builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1476899992.49 results: success (0) buildid: 20161019101422 builduid: f7dff28ec4d84db6b702e4f113d0aa13 revision: 8bd0d7e850dd1e62fa088d99821a2072a9273c09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.495082) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.495450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.495735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.512317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.512583) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 10:59:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.9M=0s 2016-10-19 10:59:52 (23.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.686155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.686438) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015970 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.738385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:52.739521) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8bd0d7e850dd1e62fa088d99821a2072a9273c09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8bd0d7e850dd1e62fa088d99821a2072a9273c09 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 10:59:53,070 truncating revision to first 12 chars 2016-10-19 10:59:53,070 Setting DEBUG logging. 2016-10-19 10:59:53,070 attempt 1/10 2016-10-19 10:59:53,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8bd0d7e850dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 10:59:53,372 unpacking tar archive at: fx-team-8bd0d7e850dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:53.368342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:53.368842) ========= script_repo_revision: 8bd0d7e850dd1e62fa088d99821a2072a9273c09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:53.369525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:53.370022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 10:59:53.382028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-19 10:59:53.382501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:59:53 INFO - MultiFileLogger online at 20161019 10:59:53 in /builds/slave/test 10:59:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:59:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:59:53 INFO - {'append_to_log': False, 10:59:53 INFO - 'base_work_dir': '/builds/slave/test', 10:59:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:59:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:59:53 INFO - 'branch': 'Fx-Team-Non-PGO', 10:59:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:59:53 INFO - 'config_files': ('talos/linux_config.py',), 10:59:53 INFO - 'default_actions': ('clobber', 10:59:53 INFO - 'read-buildbot-config', 10:59:53 INFO - 'download-and-extract', 10:59:53 INFO - 'populate-webroot', 10:59:53 INFO - 'create-virtualenv', 10:59:53 INFO - 'install', 10:59:53 INFO - 'run-tests'), 10:59:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:59:53 INFO - 'download_minidump_stackwalk': True, 10:59:53 INFO - 'download_symbols': 'ondemand', 10:59:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:59:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:59:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:59:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:59:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:59:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:59:53 INFO - 'installer_path': 'installer.exe', 10:59:53 INFO - 'log_level': 'info', 10:59:53 INFO - 'log_name': 'talos', 10:59:53 INFO - 'log_to_console': True, 10:59:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:59:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:59:53 INFO - 'opt_config_files': (), 10:59:53 INFO - 'pip_index': False, 10:59:53 INFO - 'sps_profile': False, 10:59:53 INFO - 'sps_profile_interval': 0, 10:59:53 INFO - 'suite': 'dromaeojs', 10:59:53 INFO - 'system_bits': '32', 10:59:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:59:53 INFO - 'title': 'talos-linux64-ix-022', 10:59:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:59:53 INFO - 'use_talos_json': True, 10:59:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:59:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:59:53 INFO - 'work_dir': 'build'} 10:59:53 INFO - [mozharness: 2016-10-19 17:59:53.819593Z] Running clobber step. 10:59:53 INFO - Running pre-action listener: _resource_record_pre_action 10:59:53 INFO - Running main action method: clobber 10:59:53 INFO - rmtree: /builds/slave/test/build 10:59:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:59:54 INFO - Running post-action listener: _resource_record_post_action 10:59:54 INFO - [mozharness: 2016-10-19 17:59:54.293751Z] Finished clobber step (success) 10:59:54 INFO - [mozharness: 2016-10-19 17:59:54.293850Z] Running read-buildbot-config step. 10:59:54 INFO - Running pre-action listener: _resource_record_pre_action 10:59:54 INFO - Running main action method: read_buildbot_config 10:59:54 INFO - Using buildbot properties: 10:59:54 INFO - { 10:59:54 INFO - "project": "", 10:59:54 INFO - "product": "firefox", 10:59:54 INFO - "script_repo_revision": "production", 10:59:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:59:54 INFO - "repository": "", 10:59:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:59:54 INFO - "buildid": "20161019101422", 10:59:54 INFO - "pgo_build": "False", 10:59:54 INFO - "basedir": "/builds/slave/test", 10:59:54 INFO - "buildnumber": 1983, 10:59:54 INFO - "slavename": "talos-linux64-ix-022", 10:59:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:59:54 INFO - "platform": "ubuntu64_hw", 10:59:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:59:54 INFO - "branch": "fx-team", 10:59:54 INFO - "repo_path": "integration/fx-team", 10:59:54 INFO - "revision": "8bd0d7e850dd1e62fa088d99821a2072a9273c09", 10:59:54 INFO - "stage_platform": "linux64", 10:59:54 INFO - "builduid": "f7dff28ec4d84db6b702e4f113d0aa13", 10:59:54 INFO - "slavebuilddir": "test" 10:59:54 INFO - } 10:59:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:59:54 INFO - Running post-action listener: _resource_record_post_action 10:59:54 INFO - [mozharness: 2016-10-19 17:59:54.296290Z] Finished read-buildbot-config step (success) 10:59:54 INFO - [mozharness: 2016-10-19 17:59:54.296379Z] Running download-and-extract step. 10:59:54 INFO - Running pre-action listener: _resource_record_pre_action 10:59:54 INFO - Running main action method: download_and_extract 10:59:54 INFO - mkdir: /builds/slave/test/build/tests 10:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:54 INFO - trying https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:59:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:59:54 INFO - Downloaded 1361 bytes. 10:59:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:59:55 INFO - Using the following test package requirements: 10:59:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:59:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:59:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'jsshell-linux-x86_64.zip'], 10:59:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:59:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:59:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:59:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:59:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:59:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:59:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:59:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:59:55 INFO - Fetch https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:59:55 INFO - Http code: 200 10:59:55 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 10:59:55 INFO - x-amz-cf-id: P3NWGcHIOtRitrGUL0eJUPIMba1L-IOUNt_ZuLe6AUqqqcd7VNv8iQ== 10:59:55 INFO - x-amz-version-id: nVyu2pog9zAxRhCNqayiTpgyZzPi_meV 10:59:56 INFO - Expected file size: 20542225 10:59:56 INFO - Obtained file size: 20542225 11:00:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:00:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:00:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:00 INFO - Fetch https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:00:01 INFO - Http code: 200 11:00:01 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 11:00:01 INFO - x-amz-cf-id: 3UR_Go_XBX1f-WZRWjDr403dHZYnSSNsr0TijJJGXS2YCn1P5FAxCQ== 11:00:01 INFO - x-amz-version-id: nVyu2pog9zAxRhCNqayiTpgyZzPi_meV 11:00:01 INFO - Expected file size: 20542225 11:00:01 INFO - Obtained file size: 20542225 11:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:00:06 INFO - Fetch https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:00:06 INFO - Http code: 200 11:00:06 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 11:00:06 INFO - x-amz-cf-id: z2rLvsuhoV8mNOZ1WLSVPTn3ftFpki-kuLyRb5W2zBY3XhCxszbX7A== 11:00:06 INFO - x-amz-version-id: dO6m700pPZoghdAbcD7OuAQsqP3RUUR2 11:00:07 INFO - Expected file size: 14409028 11:00:07 INFO - Obtained file size: 14409028 11:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:07 INFO - trying https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:00:07 INFO - Downloading https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:00:09 INFO - Downloaded 55596903 bytes. 11:00:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:00:09 INFO - mkdir: /builds/slave/test/properties 11:00:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:00:09 INFO - Writing to file /builds/slave/test/properties/build_url 11:00:09 INFO - Contents: 11:00:09 INFO - build_url:https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:00:10 INFO - Running post-action listener: _resource_record_post_action 11:00:10 INFO - Running post-action listener: set_extra_try_arguments 11:00:10 INFO - [mozharness: 2016-10-19 18:00:10.434330Z] Finished download-and-extract step (success) 11:00:10 INFO - [mozharness: 2016-10-19 18:00:10.434559Z] Running populate-webroot step. 11:00:10 INFO - Running pre-action listener: _resource_record_pre_action 11:00:10 INFO - Running main action method: populate_webroot 11:00:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:10 INFO - '--tppagecycles', 11:00:10 INFO - '7'], 11:00:10 INFO - 'tests': ['tsvgm']}}, 11:00:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:00:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:00:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:00:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['damp', 'tps']}, 11:00:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'tests': ['damp', 'tps']}, 11:00:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['dromaeo_dom']}, 11:00:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['basic_compositor_video']}, 11:00:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:00:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['a11yr', 11:00:10 INFO - 'ts_paint', 11:00:10 INFO - 'tpaint', 11:00:10 INFO - 'sessionrestore', 11:00:10 INFO - 'sessionrestore_no_auto_restore', 11:00:10 INFO - 'tabpaint']}, 11:00:10 INFO - 'other-e10s': {'tests': ['a11yr', 11:00:10 INFO - 'ts_paint', 11:00:10 INFO - 'tpaint', 11:00:10 INFO - 'sessionrestore', 11:00:10 INFO - 'sessionrestore_no_auto_restore', 11:00:10 INFO - 'tabpaint']}, 11:00:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:00:10 INFO - 'ts_paint', 11:00:10 INFO - 'tpaint', 11:00:10 INFO - 'sessionrestore', 11:00:10 INFO - 'sessionrestore_no_auto_restore', 11:00:10 INFO - 'tabpaint']}, 11:00:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:00:10 INFO - 'ts_paint', 11:00:10 INFO - 'tpaint', 11:00:10 INFO - 'sessionrestore', 11:00:10 INFO - 'sessionrestore_no_auto_restore', 11:00:10 INFO - 'tabpaint']}, 11:00:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['a11yr', 11:00:10 INFO - 'ts_paint', 11:00:10 INFO - 'tpaint', 11:00:10 INFO - 'sessionrestore', 11:00:10 INFO - 'sessionrestore_no_auto_restore', 11:00:10 INFO - 'tabpaint']}, 11:00:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['a11yr', 11:00:10 INFO - 'ts_paint', 11:00:10 INFO - 'tpaint', 11:00:10 INFO - 'sessionrestore', 11:00:10 INFO - 'sessionrestore_no_auto_restore', 11:00:10 INFO - 'tabpaint']}, 11:00:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['tsvgx', 11:00:10 INFO - 'tsvgr_opacity', 11:00:10 INFO - 'tart', 11:00:10 INFO - 'tscrollx', 11:00:10 INFO - 'cart']}, 11:00:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:00:10 INFO - 'tsvgr_opacity', 11:00:10 INFO - 'tart', 11:00:10 INFO - 'tscrollx', 11:00:10 INFO - 'cart']}, 11:00:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'talos_options': ['--disable-e10s'], 11:00:10 INFO - 'tests': ['tp5o']}, 11:00:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'tests': ['tp5o']}, 11:00:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'talos_options': ['--disable-e10s', 11:00:10 INFO - '--xperf_path', 11:00:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:10 INFO - 'tests': ['tp5n']}, 11:00:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:10 INFO - 'talos_options': ['--xperf_path', 11:00:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:10 INFO - 'tests': ['tp5n']}}, 11:00:10 INFO - 'talos.zip': {'path': '', 11:00:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:10 INFO - Running post-action listener: _resource_record_post_action 11:00:10 INFO - [mozharness: 2016-10-19 18:00:10.454657Z] Finished populate-webroot step (success) 11:00:10 INFO - [mozharness: 2016-10-19 18:00:10.454746Z] Running create-virtualenv step. 11:00:10 INFO - Running pre-action listener: _resource_record_pre_action 11:00:10 INFO - Running main action method: create_virtualenv 11:00:10 INFO - Creating virtualenv /builds/slave/test/build/venv 11:00:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:00:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:00:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:10 INFO - Using real prefix '/usr' 11:00:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:00:11 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:13 INFO - Installing pip.................done. 11:00:13 INFO - Return code: 0 11:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:00:13 INFO - Reading from file tmpfile_stdout 11:00:13 INFO - Output received: 11:00:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:00:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:00:13 INFO - Using env: {'DISPLAY': ':0', 11:00:13 INFO - 'HOME': '/home/cltbld', 11:00:13 INFO - 'LANG': 'en_US.UTF-8', 11:00:13 INFO - 'LANGUAGE': 'en_US:en', 11:00:13 INFO - 'LOGNAME': 'cltbld', 11:00:13 INFO - 'MAIL': '/var/mail/cltbld', 11:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:13 INFO - 'MOZ_NO_REMOTE': '1', 11:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:13 INFO - 'NO_EM_RESTART': '1', 11:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:13 INFO - 'PWD': '/builds/slave/test', 11:00:13 INFO - 'SHELL': '/bin/bash', 11:00:13 INFO - 'SHLVL': '1', 11:00:13 INFO - 'TERM': 'linux', 11:00:13 INFO - 'TMOUT': '86400', 11:00:13 INFO - 'USER': 'cltbld', 11:00:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:13 INFO - '_': '/tools/buildbot/bin/python'} 11:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:00:13 INFO - Cleaning up... 11:00:13 INFO - Return code: 0 11:00:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:00:13 INFO - Using env: {'DISPLAY': ':0', 11:00:13 INFO - 'HOME': '/home/cltbld', 11:00:13 INFO - 'LANG': 'en_US.UTF-8', 11:00:13 INFO - 'LANGUAGE': 'en_US:en', 11:00:13 INFO - 'LOGNAME': 'cltbld', 11:00:13 INFO - 'MAIL': '/var/mail/cltbld', 11:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:13 INFO - 'MOZ_NO_REMOTE': '1', 11:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:13 INFO - 'NO_EM_RESTART': '1', 11:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:13 INFO - 'PWD': '/builds/slave/test', 11:00:13 INFO - 'SHELL': '/bin/bash', 11:00:13 INFO - 'SHLVL': '1', 11:00:13 INFO - 'TERM': 'linux', 11:00:13 INFO - 'TMOUT': '86400', 11:00:13 INFO - 'USER': 'cltbld', 11:00:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:13 INFO - '_': '/tools/buildbot/bin/python'} 11:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:13 INFO - Downloading/unpacking psutil>=3.1.1 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:15 INFO - Installing collected packages: psutil 11:00:15 INFO - Running setup.py install for psutil 11:00:15 INFO - building 'psutil._psutil_linux' extension 11:00:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:00:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:00:15 INFO - building 'psutil._psutil_posix' extension 11:00:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:00:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:16 INFO - Successfully installed psutil 11:00:16 INFO - Cleaning up... 11:00:16 INFO - Return code: 0 11:00:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:00:16 INFO - Using env: {'DISPLAY': ':0', 11:00:16 INFO - 'HOME': '/home/cltbld', 11:00:16 INFO - 'LANG': 'en_US.UTF-8', 11:00:16 INFO - 'LANGUAGE': 'en_US:en', 11:00:16 INFO - 'LOGNAME': 'cltbld', 11:00:16 INFO - 'MAIL': '/var/mail/cltbld', 11:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:16 INFO - 'MOZ_NO_REMOTE': '1', 11:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:16 INFO - 'NO_EM_RESTART': '1', 11:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:16 INFO - 'PWD': '/builds/slave/test', 11:00:16 INFO - 'SHELL': '/bin/bash', 11:00:16 INFO - 'SHLVL': '1', 11:00:16 INFO - 'TERM': 'linux', 11:00:16 INFO - 'TMOUT': '86400', 11:00:16 INFO - 'USER': 'cltbld', 11:00:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:16 INFO - '_': '/tools/buildbot/bin/python'} 11:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:00:18 INFO - Installing collected packages: mozsystemmonitor 11:00:18 INFO - Running setup.py install for mozsystemmonitor 11:00:18 INFO - Successfully installed mozsystemmonitor 11:00:18 INFO - Cleaning up... 11:00:18 INFO - Return code: 0 11:00:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:00:18 INFO - Using env: {'DISPLAY': ':0', 11:00:18 INFO - 'HOME': '/home/cltbld', 11:00:18 INFO - 'LANG': 'en_US.UTF-8', 11:00:18 INFO - 'LANGUAGE': 'en_US:en', 11:00:18 INFO - 'LOGNAME': 'cltbld', 11:00:18 INFO - 'MAIL': '/var/mail/cltbld', 11:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:18 INFO - 'MOZ_NO_REMOTE': '1', 11:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:18 INFO - 'NO_EM_RESTART': '1', 11:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:18 INFO - 'PWD': '/builds/slave/test', 11:00:18 INFO - 'SHELL': '/bin/bash', 11:00:18 INFO - 'SHLVL': '1', 11:00:18 INFO - 'TERM': 'linux', 11:00:18 INFO - 'TMOUT': '86400', 11:00:18 INFO - 'USER': 'cltbld', 11:00:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:18 INFO - '_': '/tools/buildbot/bin/python'} 11:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:18 INFO - Downloading/unpacking jsonschema==2.5.1 11:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:20 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:21 INFO - warning: no files found matching '*.txt' 11:00:21 INFO - no previously-included directories found matching 'build' 11:00:21 INFO - no previously-included directories found matching 'dist' 11:00:21 INFO - no previously-included directories found matching '.git*' 11:00:21 INFO - Installing collected packages: jsonschema, functools32 11:00:21 INFO - Running setup.py install for functools32 11:00:21 INFO - warning: no files found matching '*.txt' 11:00:21 INFO - no previously-included directories found matching 'build' 11:00:21 INFO - no previously-included directories found matching 'dist' 11:00:21 INFO - no previously-included directories found matching '.git*' 11:00:21 INFO - Successfully installed jsonschema functools32 11:00:21 INFO - Cleaning up... 11:00:21 INFO - Return code: 0 11:00:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:00:21 INFO - Using env: {'DISPLAY': ':0', 11:00:21 INFO - 'HOME': '/home/cltbld', 11:00:21 INFO - 'LANG': 'en_US.UTF-8', 11:00:21 INFO - 'LANGUAGE': 'en_US:en', 11:00:21 INFO - 'LOGNAME': 'cltbld', 11:00:21 INFO - 'MAIL': '/var/mail/cltbld', 11:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:21 INFO - 'MOZ_NO_REMOTE': '1', 11:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:21 INFO - 'NO_EM_RESTART': '1', 11:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:21 INFO - 'PWD': '/builds/slave/test', 11:00:21 INFO - 'SHELL': '/bin/bash', 11:00:21 INFO - 'SHLVL': '1', 11:00:21 INFO - 'TERM': 'linux', 11:00:21 INFO - 'TMOUT': '86400', 11:00:21 INFO - 'USER': 'cltbld', 11:00:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:21 INFO - '_': '/tools/buildbot/bin/python'} 11:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:00:21 INFO - Cleaning up... 11:00:21 INFO - Return code: 0 11:00:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:00:21 INFO - Using env: {'DISPLAY': ':0', 11:00:21 INFO - 'HOME': '/home/cltbld', 11:00:21 INFO - 'LANG': 'en_US.UTF-8', 11:00:21 INFO - 'LANGUAGE': 'en_US:en', 11:00:21 INFO - 'LOGNAME': 'cltbld', 11:00:21 INFO - 'MAIL': '/var/mail/cltbld', 11:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:21 INFO - 'MOZ_NO_REMOTE': '1', 11:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:21 INFO - 'NO_EM_RESTART': '1', 11:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:21 INFO - 'PWD': '/builds/slave/test', 11:00:21 INFO - 'SHELL': '/bin/bash', 11:00:21 INFO - 'SHLVL': '1', 11:00:21 INFO - 'TERM': 'linux', 11:00:21 INFO - 'TMOUT': '86400', 11:00:21 INFO - 'USER': 'cltbld', 11:00:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:21 INFO - '_': '/tools/buildbot/bin/python'} 11:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:21 INFO - Downloading/unpacking blobuploader==1.2.4 11:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:23 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:00:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:24 INFO - Downloading docopt-0.6.1.tar.gz 11:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:24 INFO - Running setup.py install for blobuploader 11:00:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:00:24 INFO - Running setup.py install for requests 11:00:24 INFO - Running setup.py install for docopt 11:00:24 INFO - Successfully installed blobuploader requests docopt 11:00:24 INFO - Cleaning up... 11:00:24 INFO - Return code: 0 11:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:24 INFO - Using env: {'DISPLAY': ':0', 11:00:24 INFO - 'HOME': '/home/cltbld', 11:00:24 INFO - 'LANG': 'en_US.UTF-8', 11:00:24 INFO - 'LANGUAGE': 'en_US:en', 11:00:24 INFO - 'LOGNAME': 'cltbld', 11:00:24 INFO - 'MAIL': '/var/mail/cltbld', 11:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:24 INFO - 'MOZ_NO_REMOTE': '1', 11:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:24 INFO - 'NO_EM_RESTART': '1', 11:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:24 INFO - 'PWD': '/builds/slave/test', 11:00:24 INFO - 'SHELL': '/bin/bash', 11:00:24 INFO - 'SHLVL': '1', 11:00:24 INFO - 'TERM': 'linux', 11:00:24 INFO - 'TMOUT': '86400', 11:00:24 INFO - 'USER': 'cltbld', 11:00:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:24 INFO - '_': '/tools/buildbot/bin/python'} 11:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:25 INFO - Running setup.py (path:/tmp/pip-c1eUzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:25 INFO - Running setup.py (path:/tmp/pip-VSs7gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:25 INFO - Running setup.py (path:/tmp/pip-BJAuJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:25 INFO - Running setup.py (path:/tmp/pip-FXrZ0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:25 INFO - Running setup.py (path:/tmp/pip-WwBjhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:25 INFO - Running setup.py (path:/tmp/pip-sr_SFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:25 INFO - Running setup.py (path:/tmp/pip-Vqzhs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:25 INFO - Running setup.py (path:/tmp/pip-nNmhmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:25 INFO - Running setup.py (path:/tmp/pip-Cj8fXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:25 INFO - Running setup.py (path:/tmp/pip-SqpG4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:25 INFO - Running setup.py (path:/tmp/pip-iUtCEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:25 INFO - Running setup.py (path:/tmp/pip-4OlB_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:26 INFO - Running setup.py (path:/tmp/pip-YSmR5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:26 INFO - Running setup.py (path:/tmp/pip-E3_brv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:26 INFO - Running setup.py (path:/tmp/pip-vvdDl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:26 INFO - Running setup.py (path:/tmp/pip-mG51dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:26 INFO - Running setup.py (path:/tmp/pip-lBbhaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:26 INFO - Running setup.py install for manifestparser 11:00:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:00:26 INFO - Running setup.py install for mozcrash 11:00:26 INFO - Running setup.py install for mozdebug 11:00:26 INFO - Running setup.py install for mozdevice 11:00:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:00:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:00:26 INFO - Running setup.py install for mozfile 11:00:26 INFO - Running setup.py install for mozhttpd 11:00:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for mozinfo 11:00:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for mozInstall 11:00:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for mozleak 11:00:27 INFO - Running setup.py install for mozlog 11:00:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for moznetwork 11:00:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for mozprocess 11:00:27 INFO - Running setup.py install for mozprofile 11:00:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for mozrunner 11:00:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:00:27 INFO - Running setup.py install for mozscreenshot 11:00:28 INFO - Running setup.py install for moztest 11:00:28 INFO - Running setup.py install for mozversion 11:00:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:00:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:28 INFO - Cleaning up... 11:00:28 INFO - Return code: 0 11:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:28 INFO - Using env: {'DISPLAY': ':0', 11:00:28 INFO - 'HOME': '/home/cltbld', 11:00:28 INFO - 'LANG': 'en_US.UTF-8', 11:00:28 INFO - 'LANGUAGE': 'en_US:en', 11:00:28 INFO - 'LOGNAME': 'cltbld', 11:00:28 INFO - 'MAIL': '/var/mail/cltbld', 11:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:28 INFO - 'MOZ_NO_REMOTE': '1', 11:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:28 INFO - 'NO_EM_RESTART': '1', 11:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:28 INFO - 'PWD': '/builds/slave/test', 11:00:28 INFO - 'SHELL': '/bin/bash', 11:00:28 INFO - 'SHLVL': '1', 11:00:28 INFO - 'TERM': 'linux', 11:00:28 INFO - 'TMOUT': '86400', 11:00:28 INFO - 'USER': 'cltbld', 11:00:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:28 INFO - '_': '/tools/buildbot/bin/python'} 11:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:28 INFO - Running setup.py (path:/tmp/pip-0J5RTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:28 INFO - Running setup.py (path:/tmp/pip-gui7o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:28 INFO - Running setup.py (path:/tmp/pip-i1ZMdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:28 INFO - Running setup.py (path:/tmp/pip-11iq8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:28 INFO - Running setup.py (path:/tmp/pip-jr2qSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:28 INFO - Running setup.py (path:/tmp/pip-_owCty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:28 INFO - Running setup.py (path:/tmp/pip-kVwIeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:28 INFO - Running setup.py (path:/tmp/pip-OJCguW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:29 INFO - Running setup.py (path:/tmp/pip-jpYb1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:29 INFO - Running setup.py (path:/tmp/pip-tbS418-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:29 INFO - Running setup.py (path:/tmp/pip-0hvuyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:29 INFO - Running setup.py (path:/tmp/pip-Civ9HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:29 INFO - Running setup.py (path:/tmp/pip-K0qfj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:29 INFO - Running setup.py (path:/tmp/pip-pcGCzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:29 INFO - Running setup.py (path:/tmp/pip-iqoyPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:29 INFO - Running setup.py (path:/tmp/pip-oUdW_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:29 INFO - Running setup.py (path:/tmp/pip-n8sdGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:31 INFO - Downloading blessings-1.6.tar.gz 11:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:31 INFO - Installing collected packages: blessings 11:00:31 INFO - Running setup.py install for blessings 11:00:31 INFO - Successfully installed blessings 11:00:31 INFO - Cleaning up... 11:00:31 INFO - Return code: 0 11:00:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:32 INFO - Reading from file tmpfile_stdout 11:00:32 INFO - Current package versions: 11:00:32 INFO - argparse == 1.2.1 11:00:32 INFO - blessings == 1.6 11:00:32 INFO - blobuploader == 1.2.4 11:00:32 INFO - docopt == 0.6.1 11:00:32 INFO - functools32 == 3.2.3-2 11:00:32 INFO - jsonschema == 2.5.1 11:00:32 INFO - manifestparser == 1.1 11:00:32 INFO - mozInstall == 1.12 11:00:32 INFO - mozcrash == 0.17 11:00:32 INFO - mozdebug == 0.1 11:00:32 INFO - mozdevice == 0.48 11:00:32 INFO - mozfile == 1.2 11:00:32 INFO - mozhttpd == 0.7 11:00:32 INFO - mozinfo == 0.9 11:00:32 INFO - mozleak == 0.1 11:00:32 INFO - mozlog == 3.4 11:00:32 INFO - moznetwork == 0.27 11:00:32 INFO - mozprocess == 0.23 11:00:32 INFO - mozprofile == 0.28 11:00:32 INFO - mozrunner == 6.12 11:00:32 INFO - mozscreenshot == 0.1 11:00:32 INFO - mozsystemmonitor == 0.3 11:00:32 INFO - moztest == 0.7 11:00:32 INFO - mozversion == 1.4 11:00:32 INFO - psutil == 3.1.1 11:00:32 INFO - requests == 1.2.3 11:00:32 INFO - wsgiref == 0.1.2 11:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:32 INFO - Using env: {'DISPLAY': ':0', 11:00:32 INFO - 'HOME': '/home/cltbld', 11:00:32 INFO - 'LANG': 'en_US.UTF-8', 11:00:32 INFO - 'LANGUAGE': 'en_US:en', 11:00:32 INFO - 'LOGNAME': 'cltbld', 11:00:32 INFO - 'MAIL': '/var/mail/cltbld', 11:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:32 INFO - 'MOZ_NO_REMOTE': '1', 11:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:32 INFO - 'NO_EM_RESTART': '1', 11:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:32 INFO - 'PWD': '/builds/slave/test', 11:00:32 INFO - 'SHELL': '/bin/bash', 11:00:32 INFO - 'SHLVL': '1', 11:00:32 INFO - 'TERM': 'linux', 11:00:32 INFO - 'TMOUT': '86400', 11:00:32 INFO - 'USER': 'cltbld', 11:00:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:32 INFO - '_': '/tools/buildbot/bin/python'} 11:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:00:32 INFO - Cleaning up... 11:00:32 INFO - Return code: 0 11:00:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bb46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:00:32 INFO - Using env: {'DISPLAY': ':0', 11:00:32 INFO - 'HOME': '/home/cltbld', 11:00:32 INFO - 'LANG': 'en_US.UTF-8', 11:00:32 INFO - 'LANGUAGE': 'en_US:en', 11:00:32 INFO - 'LOGNAME': 'cltbld', 11:00:32 INFO - 'MAIL': '/var/mail/cltbld', 11:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:32 INFO - 'MOZ_NO_REMOTE': '1', 11:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:32 INFO - 'NO_EM_RESTART': '1', 11:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:32 INFO - 'PWD': '/builds/slave/test', 11:00:32 INFO - 'SHELL': '/bin/bash', 11:00:32 INFO - 'SHLVL': '1', 11:00:32 INFO - 'TERM': 'linux', 11:00:32 INFO - 'TMOUT': '86400', 11:00:32 INFO - 'USER': 'cltbld', 11:00:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:32 INFO - '_': '/tools/buildbot/bin/python'} 11:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:00:32 INFO - Cleaning up... 11:00:32 INFO - Return code: 0 11:00:32 INFO - Running post-action listener: _resource_record_post_action 11:00:32 INFO - Running post-action listener: _start_resource_monitoring 11:00:32 INFO - Starting resource monitoring. 11:00:32 INFO - [mozharness: 2016-10-19 18:00:32.575513Z] Finished create-virtualenv step (success) 11:00:32 INFO - [mozharness: 2016-10-19 18:00:32.576069Z] Running install step. 11:00:32 INFO - Running pre-action listener: _resource_record_pre_action 11:00:32 INFO - Running main action method: install 11:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:32 INFO - Reading from file tmpfile_stdout 11:00:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:00:32 INFO - Reading from file tmpfile_stdout 11:00:32 INFO - Output received: 11:00:32 INFO - Usage: mozinstall [options] installer 11:00:32 INFO - Options: 11:00:32 INFO - -h, --help show this help message and exit 11:00:32 INFO - -d DEST, --destination=DEST 11:00:32 INFO - Directory to install application into. [default: 11:00:32 INFO - "/builds/slave/test"] 11:00:32 INFO - --app=APP Application being installed. [default: firefox] 11:00:32 INFO - mkdir: /builds/slave/test/build/application 11:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:00:48 INFO - Reading from file tmpfile_stdout 11:00:48 INFO - Output received: 11:00:48 INFO - /builds/slave/test/build/application/firefox/firefox 11:00:48 INFO - Running post-action listener: _resource_record_post_action 11:00:48 INFO - [mozharness: 2016-10-19 18:00:48.949183Z] Finished install step (success) 11:00:48 INFO - [mozharness: 2016-10-19 18:00:48.949435Z] Running run-tests step. 11:00:48 INFO - Running pre-action listener: _resource_record_pre_action 11:00:48 INFO - Running main action method: run_tests 11:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:48 INFO - Python 2.7.3 11:00:48 INFO - Return code: 0 11:00:48 INFO - grabbing minidump binary from tooltool 11:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abdf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:00:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:00:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:00:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:49 INFO - Return code: 0 11:00:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:00:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:00:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:00:49 INFO - Using env: {'DISPLAY': ':0', 11:00:49 INFO - 'HOME': '/home/cltbld', 11:00:49 INFO - 'LANG': 'en_US.UTF-8', 11:00:49 INFO - 'LANGUAGE': 'en_US:en', 11:00:49 INFO - 'LOGNAME': 'cltbld', 11:00:49 INFO - 'MAIL': '/var/mail/cltbld', 11:00:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:49 INFO - 'MOZ_NO_REMOTE': '1', 11:00:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:49 INFO - 'NO_EM_RESTART': '1', 11:00:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:49 INFO - 'PWD': '/builds/slave/test', 11:00:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:49 INFO - 'SHELL': '/bin/bash', 11:00:49 INFO - 'SHLVL': '1', 11:00:49 INFO - 'TERM': 'linux', 11:00:49 INFO - 'TMOUT': '86400', 11:00:49 INFO - 'USER': 'cltbld', 11:00:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708', 11:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:49 INFO - '_': '/tools/buildbot/bin/python'} 11:00:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:00:49 INFO - mozversion application_buildid: 20161019101422 11:00:49 INFO - mozversion application_changeset: 8bd0d7e850dd1e62fa088d99821a2072a9273c09 11:00:49 INFO - mozversion application_display_name: Nightly 11:00:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:49 INFO - mozversion application_name: Firefox 11:00:49 INFO - mozversion application_remotingname: firefox 11:00:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:00:49 INFO - mozversion application_vendor: Mozilla 11:00:49 INFO - mozversion application_version: 52.0a1 11:00:49 INFO - mozversion platform_buildid: 20161019101422 11:00:49 INFO - mozversion platform_changeset: 8bd0d7e850dd1e62fa088d99821a2072a9273c09 11:00:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:00:49 INFO - mozversion platform_version: 52.0a1 11:00:49 INFO - using testdate: 1476900049 11:00:49 INFO - actual date: 1476900049 11:00:49 INFO - starting webserver on 'localhost:48660' 11:00:49 INFO - SUITE-START | Running 2 tests 11:00:49 INFO - TEST-START | dromaeo_css 11:00:49 INFO - operating with platform_type : linux_ 11:00:49 INFO - Initialising browser for dromaeo_css test... 11:00:49 INFO - TEST-INFO | started process 19883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhniUT/profile http://localhost:48660/getInfo.html) 11:00:53 INFO - PROCESS | 19883 | __metrics Screen width/height:1600/1200 11:00:53 INFO - PROCESS | 19883 | colorDepth:24 11:00:53 INFO - PROCESS | 19883 | Browser inner width/height: 1024/697 11:00:53 INFO - PROCESS | 19883 | __metrics 11:00:54 INFO - PROCESS | 19883 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:00:54 INFO - PROCESS | 19883 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:00:54 INFO - PROCESS | 19883 | console.error: PushService: 11:00:54 INFO - PROCESS | 19883 | stateChangeProcessEnqueue: Error transitioning state 11:00:54 INFO - PROCESS | 19883 | UnknownError 11:00:55 INFO - TEST-INFO | 19883: exit 0 11:00:55 INFO - Browser initialized. 11:00:55 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:55 INFO - TEST-INFO | started process 19966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhniUT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:07 INFO - PROCESS | 19966 | RSS: Main: 173281280 11:01:07 INFO - PROCESS | 19966 | 11:01:59 INFO - PROCESS | 19966 | 1476900119621 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:04:13 INFO - PROCESS | 19966 | Cycle 1(1): loaded http://localhost:48660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48660/tests/dromaeo/cssquery-ext.html) 11:04:14 INFO - PROCESS | 19966 | RSS: Main: 307929088 11:04:14 INFO - PROCESS | 19966 | 11:07:17 INFO - PROCESS | 19966 | Cycle 1(1): loaded http://localhost:48660/tests/dromaeo/cssquery-ext.html (next: http://localhost:48660/tests/dromaeo/cssquery-jquery.html) 11:07:17 INFO - PROCESS | 19966 | RSS: Main: 281419776 11:07:17 INFO - PROCESS | 19966 | 11:10:19 INFO - PROCESS | 19966 | Cycle 1(1): loaded http://localhost:48660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48660/tests/dromaeo/cssquery-mootools.html) 11:10:20 INFO - PROCESS | 19966 | RSS: Main: 222674944 11:10:20 INFO - PROCESS | 19966 | 11:13:22 INFO - PROCESS | 19966 | Cycle 1(1): loaded http://localhost:48660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48660/tests/dromaeo/cssquery-prototype.html) 11:13:23 INFO - PROCESS | 19966 | RSS: Main: 219631616 11:13:23 INFO - PROCESS | 19966 | 11:16:26 INFO - PROCESS | 19966 | Cycle 1(1): loaded http://localhost:48660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48660/tests/dromaeo/cssquery-yui.html) 11:16:26 INFO - PROCESS | 19966 | RSS: Main: 219344896 11:16:26 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | Cycle 1(1): loaded http://localhost:48660/tests/dromaeo/cssquery-yui.html (next: http://localhost:48660/tests/dromaeo/cssquery-dojo.html) 11:19:30 INFO - PROCESS | 19966 | RSS: Main: 309358592 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | __start_tp_report 11:19:30 INFO - PROCESS | 19966 | _x_x_mozilla_page_load 11:19:30 INFO - PROCESS | 19966 | _x_x_mozilla_page_load_details 11:19:30 INFO - PROCESS | 19966 | |i|pagename|runs| 11:19:30 INFO - PROCESS | 19966 | |0;dojo.html;2562.4362640219147;2567.576349902266;2615.8561279129653;2625.1205846041576;2640.3663120851;4614.054118905625;4635.096156249533;4712.528747125286;4726.763661816908;4735.218688916329;4714.057188562293;4723.267893476508;4726.574608285262;4777.52224777522;4799.808007679689;4292.828286868537;4327.0480494291205;4344.4786625604975;4402.273624851896;4448;4488.326750987346;4492.61812745917;4494.303382975628;4500.932486012696;4518.1415531049;4260.7656578888145;4434.334849772527;4437.711548749353;4452.087322098978;4543.954560454386;4363.149185908717;4363.258246098171;4423.225935461313;4427.291633338683;4449.443819522559;4373.934390984138;4383.583559561836;4394.516603173648;4424.070945101533;4443.533428989942;4741;4778.235482322812;4803.471618122004;4806.038792241531;4865.781039853215;4984.501549845023;5050.368703912011;5051.494850514956;5096.184610462308;5105.463926287724;5155.71643559604;5174.948250517522;5190.662606930575;5209.192575150858;5230.633855630107;4814.109389762905;4820.517948205222;4838.346823178897;4838.443578988426;4881.414230292387;5101.540861322499;5181.559567436735;5303.655262407931;5305.124654432053;5305.4164041955355;4971.801127954914;4975.278584605212;5017.698938063655;5028.220625803006;5101.132807422747;5088.847334579968;5103.897922041539;5107.565856902131;5108.361454818148;5175.792968281302;5047.394312682502;5051.722155281494;5085.898282034413;5099.413567439792;5167.509086636764;4942.184539550934;5008.023435430129;5008.874778130576;5066.341375621146;5069.39167299919;4364.978175109168;4365.214261432972;4365.257906155897;4366.868993930188;4369.235383807821;3747.0445036515516;3784.299904517618;3831.3486707259276;3833.8083095845095;3836.501254836853;4364.432623758955;4374.540673229329;4383.057642606855;4428.9813342930665;4429.911401772011;5084.669496482717;5120.641555091108;5128;5131.820386286462;5193.143131383279;4278.187144442546;4339.197248508973;4346.261135606955;4369.956300436955;4412.492563355255;4516.3902873112365;4545.704529205591;4547.8635640930825;4559.3844830948065;4626.097910907408;4808.519148085234;4823.975880120577;4824.107540105092;4829.830955916666;4886.511348865085;5121.74391280442;5154.664946778447;5166.095933211598;5168.3797944246935;5231.869203269949;4617.676762626584;4681.133990211822;4681.461631912373;4786.8085276588545;4834.806607735652;5100.18397056484;5108.335916330853;5108.821191258288;5157.07172708916;5164.948350516447;5167.302414174038;5175;5177.197534382177;5178.249153872743;5241.423443421144;4851.102546028996;4915.287283343823;4917.01659668075;5026.421961474477;5038.395392552917;4959.0329885671945;4963.181075122564;5001.349824522788;5010.69935803853;5086.237064440364;4913.1893237615395;4939.629527785359;4939.777710002986;4939.827106051271;5008.474110218374;4841.782119804688;5037.244413338029;5051.772670229775;5056.342675452168;5118.104331742004;4751.40607424072;4864.148773964472;4880.95119048805;4915.5330243626795;4917.434495033117 11:19:30 INFO - PROCESS | 19966 | |1;ext.html;547.6221407229011;548.2051026012283;564.9914901900108;571.4456976732567;577.9046457334539;29818.85090574547;30659.84670076649;38425.42361864567;39948.600513994854;40010.39984400229;39979.40030899532;40399;40474.19051618973;40540.39189412154;40573.59426405735;7545.283198096199;7699.576523291216;7700.576468294242;7703.268189521987;7705.15243323234;7507.512011719221;7597.202293759131;7602.277783610548;7602.809929751746;7609.048868891388;7592.506487078323;7632.274933881273;7632.771016869475;7643.121041080291;7651.081870175559;7550.5847178405165;7572.242775722439;7576.0908690956885;7584.810379740496;7584.848303033964;7592.278733520362;7641.847163056707;7646.961765191194;7656.885146722803;7661.846763064707;36210.63789362099;36635.26729465422;36695.449568256496;36702.265954680755;36749;3004.8948286810073;3183.729383002448;3500.9649903500895;3549.4853246279145;3659.0669379308106;28040.298992525146;28719.28201794951;28890.422191556263;29188.270293242625;30400.695993040008;3346.3140056288403;3367.3770352484867;3406.6423025582453;3450.447928331455;3523.9471407928645;235033;236297;236314;236344;237076;52440;53085.734571326895;53167.734161328946;53169.202461963105;53321;32468.350632987207;33471.16322091918;33619.15952101168;54718.452815472134;54862.45137548653;14353.85646143546;14357.425702971974;14363.425462981573;14461.349239284258;14463.49377771773;10684.839727404094;10706.946465267623;10707.678769636923;10725.195610329256;10727.78544429107;17523.56191095233;17651.82348176502;17681.7347739784;17732.822671773116;17747.378841740476;6721.66391680414;6968.512204145661;6991.126109236346;6992.265812089658;7109.715611375487;779.6140910249463;891.8305521950808;908.7410088124852;911.8085202107632;962.7110577924068;26380.47239055208;26769.19692409231;27313;27413.86293068522;27526.587101193498;726.6040008195546;922.9030951749969;1019.9647357931706;1025.9281850270409;1061.7876424714934;13471.595852124452;14383.856161438462;14435;14505;14721.263936803118;360779;361642;362817;363566;364679;47075.76462117668;47471.287930681065;47605.523944760804;47628.28557571639;47671;1054.699410667956;1099.2250463423268;1123.5955056179769;1136.86926003509;1175.6149562133292;24392.87803560971;26827.597586036616;26941;28398.574021389282;28488.572671409533;40920;46310;46415.30377044279;46446.07107857891;46555;333013;334750;335494;337893.07390039135;338043;23810.523789524457;25083.623745643465;25228.74771252264;26480.470390591694;26904.59643105316;37395;38027.80986095052;38044.23911521809;38053;39006.60993390143;32295;32716.345673086882;32771.672283276865;32793.50809737904;33617.66382336145;31324;32828.015159545255;32968.34063318672;33542.32915341631;33744.66255337415;31858.36283274275;32371.19072023218;32599.837000814845;32773.67226327706;33108.66891331056;28435.431291373643;29461.410771784875;29914.850425747733;30087;30186;23379.103164566153;23510.412239694146;23511.41221469477;23730.881345593163;23986 11:19:30 INFO - PROCESS | 19966 | |2;jquery.html;341.23222748815164;358.3317113583168;366.8000939487979;372.2592041836745;391.93924941634054;12281.14032017758;12508.374581270946;16127.838721612781;16322.183890805472;17093.23080461379;14409;14424.278786060708;14543.272836358166;14730.26348682567;16827.83172168281;4821.662483626147;4860.829870954517;5076.517730815566;5078.949210507903;5080.364954380702;4536.500984891659;5131.589472842183;5132.538071573557;5133.076046311662;5135.871603209931;5098.439171691111;5104.055749686301;5107.565856902168;5108.20822772469;5109.182530795074;4895.485973972735;5060.898782024357;5077.238414237857;5081.974590127063;5087.211482220243;4561.589456948891;4563.429571303587;4565.041341318327;4565.977170114162;4567.314902764612;19105.61788764217;19648.901755491275;19712.70430943537;19756.901215493974;19862.80137198624;1809.1406581873637;2320.501092265171;2391.1272385579314;2412.3486658602255;2436.549238390903;12511.812322815165;12711.809322860165;12841.743165136644;13188.538401156009;13276.53532126371;1684.4020372767613;1687.974680379783;1706.1895599590218;1726.8445839874346;1767.5757818123686;63839;64600.676996615184;64784.99999999953;64827.3517264826;64898.67550662264;9097.636094556143;9211.723648290563;9513.191378732747;9546.474943878153;9598.9040109598;13035.15271507349;13043.347832608331;13072.28102454355;13078.607641770763;13088.934555327163;6950.409215216662;7100.715971361191;7182.712691492282;7225.530340527849;7281.1262648482525;6624.966875165594;6635.86728265432;6724.865502689919;6856.074429951992;6878.58728476293;5781.277340332458;5803.912941305884;5866.494754732469;5904.76380944766;5917.52659787216;1712.8715346349074;1728.1186594836724;1734.965300693979;1763.8236176382259;1793.1751394358741;811.5495899775564;864.4553931023415;868.2142660891903;898.510311880027;928.4104593583123;16098.11460369691;16287.104209268604;16375.918120409322;16708.331666733437;16944.57638559046;844.8859403980384;849.2611428057506;856.1823458597025;864.3517361978517;890.1143362354499;9300.162985331217;9595.856062159073;9723.367981081206;9815.312928094965;9835.360701554377;368863;371746;381782;385391;388599;61655.691721542;61724.69137654283;62397.37602624006;63141.36858631447;63314.36685633177;873.8689196620558;890.6526454682679;894.852349362361;897.0132853860831;898.6495266845935;14062.296885155905;14540.927295363455;14764.114153150846;14873.85126148768;14998.775018374952;33230.66769332276;33627;33759.4936075964;34461.65538344685;35264.29471410506;43548.78225608852;44159.55840441555;44414;44877;45578;6780.525363224527;7061.858762824612;7319.890201647086;7432.888506672512;7787.338076263581;10750.46247687628;11068.114550836075;11273.492692829006;11601.419929003347;11759.353235572125;9364.391314564531;9986.700398988041;10100.84848727255;10260.650834835322;10308.433036183082;4165.229432554987;4293.720908140961;10043.397396156253;10105;10237.310843710704;10052.94973525157;10080.143187829117;10162.491875406053;10226.437545934747;10429.68710938673;7107.076080109553;7209.170945341143;7250.818729531804;7252.093488313961;7254.746083887038;10005.649802256887;10010.349327293703;10016.248781341574;10163.136133428741;10198 11:19:30 INFO - PROCESS | 19966 | |3;mootools.html;1259.9748005039905;1367.4256812138901;1424.3946322812806;1474.6018574984755;1702.5658457093439;6472.935270647292;7394.408447324215;7683.270089341518;7683.385329173673;7984.401169912266;7852.764417067483;7917.010373703287;7918.683252669886;7921.128675845653;7928.7621371358955;2152.9784702152974;2181.9127234910584;2183.3886511776727;2186.158329043314;2187.0267730859773;2119.5231073008526;2151.698762173297;2182.138055468089;2182.2798476502717;2186.0818456248335;2144.592527419793;2161.9783802162015;2173.4131784418196;2175.184305885293;2176.1948079210633;2097.727295451597;2106.452322396173;2113.4821968617634;2113.4821968617634;2118.1527389044427;2052.6613108837023;2088.363049269972;2089.477630592352;2096.779838116991;2105.2631578947244;7755.2632499912415;7848.725294614661;7856.960715196445;7908.406869484812;7959.482633628795;4513;4664.183767840648;4678.836240731558;4690.906181876343;4691.859244222679;2824.2515733330683;2907.680155182928;2948.8083274587298;2971.554266859967;2974.7471464925507;926.8702381666573;930.4975313330793;931.2038207332769;938.6714649872558;946.4368700623119;10659.680209593724;10768.300060496043;10803.459827008697;10804.13566914645;10825.404602746847;4126.607972242632;4138.627523522837;4142.4051740079685;4152.252594532953;4249.80875860587;8530.317574594017;8530.70142545008;8535.274501667427;8538.06081331053;8539.444936079259;4554.726716397026;4559.224931761609;4562.429696287964;4563.315502674625;4572.908541829212;3603.837827297778;3645.65366290202;3707.4068149096015;4188.81150348235;4219.873403797891;3114.0657802659566;3439.9312013759586;3449.931001379958;3460.8961731148106;3476.0534100903574;971.5142428785607;1001.0890090018048;1003.6537394598852;1011.585250047477;1012.1548506996741;597.6951754605183;718.7807718645759;725.2276325713099;747.8616455955557;766.4826242286434;4768.284757286366;4946.3817022872145;4960.801567937314;5058.367704036996;5112.900726343854;357.72633935039715;384.75568014311114;385.08542212245914;396.74806497874056;407.83686525390084;3250.6424293327714;3277.623073346548;3283.097148284241;3299.4061069007807;3400.217949871494;9225;9664.951675241578;9673.419594824332;9682.75793105178;9689;9601.615935362646;9611.711648650551;9614.278929080347;9624.133827955518;9635.903640963641;7266.273372662798;7273.418126549864;7321.816954576072;7353.595552244571;7363.190049094595;4581.522389249954;4855.465898751064;4858.5384388483035;4875.171220892527;4921.360223170965;8608.354373421893;8759.474431534129;8854.335924805537;8886.333524985523;8904.73285801427;8898.154675306094;8967;8999.820003600022;9013.774655633662;9041.457512549268;6340.112384266298;6406.23125224976;6416.390442908103;6418.903716444351;6428.4214420702365;7081.114860642419;7081.46888983318;7121.608311542707;7157.928420715726;7185.2814718527725;6546.5417420782;6568.9014664781025;6593.406593406617;6605.405513503808;6731;6481.837954051187;6532.8366790830605;6605.768798092044;6654.3012983637955;6769.086173366532;5638.4925356718095;5796.94203057964;5839.649621022752;5961.7615295387695;5966.582339236385;4136.710430269853;4180.895477613084;4247.426597409434;4287.65698744106;4384.05742765307;4102.097538541516;4180.8118634660905;4200.613797446897;4215.13589714114;4386.978065109654 11:19:30 INFO - PROCESS | 19966 | |4;prototype.html;282.3548192380411;283.29600941659976;292.561158262606;293.05489795409795;295.10435827264257;4717.702631776259;4793.5446132617435;4798.312944750937;4822.64965809573;4839.975800120998;4732.408448943882;4745.857624271269;4752.364441202474;4754.9286760698615;4766.61867050636;3544.982275088621;3653.725970552206;3789.3558095123894;3790.564085130204;3809.8285577149027;3657.3233951718885;3741.681957033655;3746.8126593670345;3758.135628805376;3768.2275133597545;3714;3717.516722826029;3721.144136848513;3724.9813750931344;3735.1035751419736;3523.6828685418177;3644.2529281497227;3734.271816995687;3755.586885442599;3756.11731243159;3220.6457289698114;3263.6083669959758;3293.324868401996;3293.5389045533643;3297.7526685498683;4595.471520775087;4621.815127394933;4632.374629425052;4650.790714417859;4670.439547254351;4248.383984322256;4251.319788833803;4253.149370125956;4264.360345948102;4299.355096735483;4820.373351464323;4917.213245880677;4954.628402869763;4955.60355171589;4985.626078044161;3569.3575156471825;3573;3590.1922067534856;3600.207954250061;3601.2617413430185;5165.535101840853;5171.301874246966;5183.377994640629;5189.766460509286;5245.737713114368;3511.701505372072;3689.4281386385155;3700.5744339401313;3752.7240738148616;3757.680597149218;3760.4547340635454;3761.097336639187;3761.586225515191;3761.6238376162714;3776.3580191367532;4271.611726189001;4292.656587472995;4311.8009814994575;4317.395564620955;4330.285502891988;4865.9756701216975;5085.466026067284;5096.337476128154;5100.27135482515;5100.770465329069;1279.8272233248579;1306.8301120854228;1308.6074177746639;1311.0756916374123;1312.737452509502;806.7821688144168;838.5890913452364;841.8653015517488;856.1737922904427;857.8798968144465;3869.8645547405704;3925.9607403926166;4168.874933751992;4266.1655488140395;4359.716618419792;5143.199880042031;5151.995360904588;5162.716050617252;5176.792928282902;5196.376434827845;4424.7123936944;4432.357308190294;4448.35498852671;4453.710508816916;4477.776111194427;2594.15689900783;2690.704022557517;2723.4553089382202;2727.5363188258043;2750.422411293611;4794.113089078532;4798.184308667535;4798.592119669797;4803.4061606731975;4841.15279826029;5262.289590905255;5268.394134674485;5274.340707411574;5279.392869819943;5291.95712465334;4675.438947326343;4762.333273341735;4811.446683631427;4822.807087716522;4850.878728031827;5106.514881086291;5114.514121158484;5118.948810511847;5126.615813730346;5129.563987061141;5052.797888084436;5061.215511595708;5065.290859279778;5069.188929771366;5087.745612719275;4590.196715574828;4750.738709371018;4769.236922092448;4785.521447855187;4848.151573474698;3728.96271037297;3733.5519737631657;3734.775913445202;3734.7945862976712;3746.662800347982;5142.485751424977;5152.922706159336;5199.584033277253;5211.478852114758;5214.270002199619;4749.168895443353;4976.527229913152;5016.4231113420965;5019.557691443172;5030.8239211627415;4955.4301255356095;4972.577330926912;4987.351644286219;4998.700077995187;5002.224655178453;4926;4933.77797999098;4939.9259011114145;4948.406191257072;4963.181075122564;4781.617470602413;4901.950980490149;4998.4251811042195;5008.04525330057;5063.5695965843315;4741.762911854325;4796.904061918812;4898.657094003528;4907.730074845917;4914.483979182278 11:19:30 INFO - PROCESS | 19966 | |5;yui.html;602.9788957386492;606.8846919085377;626.82448914304;646.7413034786088;700.1493185779277;11689.766204675912;12649.367531623428;13015.088943773928;13037;13050.608481745563;12641.620751377473;12691.428885700143;12754.298513581749;12761.617151485447;12793.040521960844;639.8624295776407;770.0566805663046;792.7344339646226;796.080526991326;796.8844517544982;648.3969907985571;780.9804754881117;796.2594786848229;796.7649543384687;797.2426195114635;834.4284165346756;839.9412041157121;841.2891107014563;842.873568964654;845.9238668519832;664.9202095748493;837.7151768398774;841.8063845315581;842.6039761312235;842.8272204198124;500.7271037284689;587.597495715432;602.4878852974937;603.7766026570154;604.1391017799662;12784.61646150617;12798.936005320007;12833.165844220095;12849.35753212345;12862;10931.45342732868;11345.413125908677;11664.241824281395;11674.241174323726;11928.761424771455;11697.09465045175;11712.121590880633;11837.763244735143;11889.524419023228;11980.281183128953;3988.0827409695644;4012.8394864205397;4013.337799263118;4045.1190196558446;4054.2904991626347;60294.39705602932;60896.69551652257;61470;62003.99999999955;62640.37359626436;9945.403275803475;10034.949825250973;10067.395956242648;10165.44090075053;10248.897511024794;18789.34237301688;18889.338873139375;18936.147873345733;18948.62102757937;19056.047197640062;5846.41535846412;6022.18700475439;6368.235811702625;6532.379423954717;6873.381395674413;3480.617132115465;3504.7546671733244;3544.80503572306;3586.085548185248;3591.030421786103;2745.5195340815676;2825.717428257199;2832.971670283312;2840.3751174741524;2850.2446851584345;440.66289288694173;443.06513257027643;445.012073197501;446.23025281389346;452.74646198129153;479.45581764696624;494.6191432596952;520.7942862569264;548.454287983459;570.6604570280676;6908.9309106909295;7154.248803875518;7169;7409.481336306515;7556.2443755624;448.9326601009809;457.9381783459257;517.7126694684487;520.2482412913304;538.2921458282347;3431.4681224410256;3449.7757645752945;3496.4056110461283;3554.5556805399324;3652.415613501827;69675;70845.64577177081;71256.64371678108;90403.54798226098;99731;72376;72713.63643181857;74111.62944185245;74972.62513687396;75835.62082189554;48170.5182948173;59799;65312.34687653158;66788.99266043956;68019.65990170017;7947.615715285276;8247.463914845515;8262.876056859031;8454.661813527637;8640.827183456422;31662.36675266528;34993.65006349904;40234.79882600685;42391.57608423876;43273.99431105256;34270.63181416008;35117;37319.62680373162;60051;61600;9694.418334899929;10104.79790404173;10337.896621033995;10537.841932371173;11239.494222759831;12536.811947820972;12578.559750409058;12786.68033299175;12897.419616117484;13440.663983400493;10763.569457221623;11052.336859788438;11066.889331106586;11146.609868654557;11480.770384592428;11573;11941.462634181657;12314.507419703112;12343.259404435763;12459.439325230567;9869.407835529892;9974.50127493608;10159.644412445528;10703.518341674488;10708.357498550113;8708.34687398435;8809.383343165917;9170.174684278447;9270.675526356816;9274.768130796783;8706.216440520131;9100.681476148304;9183.770405739642;9186;9241.630334786532 11:19:30 INFO - PROCESS | 19966 | __end_tp_report 11:19:30 INFO - PROCESS | 19966 | __start_cc_report 11:19:30 INFO - PROCESS | 19966 | _x_x_mozilla_cycle_collect,1344 11:19:30 INFO - PROCESS | 19966 | __end_cc_report 11:19:30 INFO - PROCESS | 19966 | __startTimestamp1476901170288__endTimestamp 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | ------- Summary: start ------- 11:19:30 INFO - PROCESS | 19966 | Number of tests: 6 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | [#0] dojo.html Cycles:165 Average:4725.48 Median:4838.44 stddev:506.55 (10.5%) stddev-sans-first:478.84 11:19:30 INFO - PROCESS | 19966 | Values: 2562.4 2567.6 2615.9 2625.1 2640.4 4614.1 4635.1 4712.5 4726.8 4735.2 4714.1 4723.3 4726.6 4777.5 4799.8 4292.8 4327.0 4344.5 4402.3 4448.0 4488.3 4492.6 4494.3 4500.9 4518.1 4260.8 4434.3 4437.7 4452.1 4544.0 4363.1 4363.3 4423.2 4427.3 4449.4 4373.9 4383.6 4394.5 4424.1 4443.5 4741.0 4778.2 4803.5 4806.0 4865.8 4984.5 5050.4 5051.5 5096.2 5105.5 5155.7 5174.9 5190.7 5209.2 5230.6 4814.1 4820.5 4838.3 4838.4 4881.4 5101.5 5181.6 5303.7 5305.1 5305.4 4971.8 4975.3 5017.7 5028.2 5101.1 5088.8 5103.9 5107.6 5108.4 5175.8 5047.4 5051.7 5085.9 5099.4 5167.5 4942.2 5008.0 5008.9 5066.3 5069.4 4365.0 4365.2 4365.3 4366.9 4369.2 3747.0 3784.3 3831.3 3833.8 3836.5 4364.4 4374.5 4383.1 4429.0 4429.9 5084.7 5120.6 5128.0 5131.8 5193.1 4278.2 4339.2 4346.3 4370.0 4412.5 4516.4 4545.7 4547.9 4559.4 4626.1 4808.5 4824.0 4824.1 4829.8 4886.5 5121.7 5154.7 5166.1 5168.4 5231.9 4617.7 4681.1 4681.5 4786.8 4834.8 5100.2 5108.3 5108.8 5157.1 5164.9 5167.3 5175.0 5177.2 5178.2 5241.4 4851.1 4915.3 4917.0 5026.4 5038.4 4959.0 4963.2 5001.3 5010.7 5086.2 4913.2 4939.6 4939.8 4939.8 5008.5 4841.8 5037.2 5051.8 5056.3 5118.1 4751.4 4864.1 4881.0 4915.5 4917.4 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | [#1] ext.html Cycles:180 Average:45719.51 Median:337968.04 stddev:83301.87 (24.6%) stddev-sans-first:83466.51 11:19:30 INFO - PROCESS | 19966 | Values: 547.6 548.2 565.0 571.4 577.9 29818.9 30659.8 38425.4 39948.6 40010.4 39979.4 40399.0 40474.2 40540.4 40573.6 7545.3 7699.6 7700.6 7703.3 7705.2 7507.5 7597.2 7602.3 7602.8 7609.0 7592.5 7632.3 7632.8 7643.1 7651.1 7550.6 7572.2 7576.1 7584.8 7584.8 7592.3 7641.8 7647.0 7656.9 7661.8 36210.6 36635.3 36695.4 36702.3 36749.0 3004.9 3183.7 3501.0 3549.5 3659.1 28040.3 28719.3 28890.4 29188.3 30400.7 3346.3 3367.4 3406.6 3450.4 3523.9 235033.0 236297.0 236314.0 236344.0 237076.0 52440.0 53085.7 53167.7 53169.2 53321.0 32468.4 33471.2 33619.2 54718.5 54862.5 14353.9 14357.4 14363.4 14461.3 14463.5 10684.8 10706.9 10707.7 10725.2 10727.8 17523.6 17651.8 17681.7 17732.8 17747.4 6721.7 6968.5 6991.1 6992.3 7109.7 779.6 891.8 908.7 911.8 962.7 26380.5 26769.2 27313.0 27413.9 27526.6 726.6 922.9 1020.0 1025.9 1061.8 13471.6 14383.9 14435.0 14505.0 14721.3 360779.0 361642.0 362817.0 363566.0 364679.0 47075.8 47471.3 47605.5 47628.3 47671.0 1054.7 1099.2 1123.6 1136.9 1175.6 24392.9 26827.6 26941.0 28398.6 28488.6 40920.0 46310.0 46415.3 46446.1 46555.0 333013.0 334750.0 335494.0 337893.1 338043.0 23810.5 25083.6 25228.7 26480.5 26904.6 37395.0 38027.8 38044.2 38053.0 39006.6 32295.0 32716.3 32771.7 32793.5 33617.7 31324.0 32828.0 32968.3 33542.3 33744.7 31858.4 32371.2 32599.8 32773.7 33108.7 28435.4 29461.4 29914.9 30087.0 30186.0 23379.1 23510.4 23511.4 23730.9 23986.0 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | [#2] jquery.html Cycles:180 Average:22986.75 Median:44645.50 stddev:62270.30 (139.5%) stddev-sans-first:62421.77 11:19:30 INFO - PROCESS | 19966 | Values: 341.2 358.3 366.8 372.3 391.9 12281.1 12508.4 16127.8 16322.2 17093.2 14409.0 14424.3 14543.3 14730.3 16827.8 4821.7 4860.8 5076.5 5078.9 5080.4 4536.5 5131.6 5132.5 5133.1 5135.9 5098.4 5104.1 5107.6 5108.2 5109.2 4895.5 5060.9 5077.2 5082.0 5087.2 4561.6 4563.4 4565.0 4566.0 4567.3 19105.6 19648.9 19712.7 19756.9 19862.8 1809.1 2320.5 2391.1 2412.3 2436.5 12511.8 12711.8 12841.7 13188.5 13276.5 1684.4 1688.0 1706.2 1726.8 1767.6 63839.0 64600.7 64785.0 64827.4 64898.7 9097.6 9211.7 9513.2 9546.5 9598.9 13035.2 13043.3 13072.3 13078.6 13088.9 6950.4 7100.7 7182.7 7225.5 7281.1 6625.0 6635.9 6724.9 6856.1 6878.6 5781.3 5803.9 5866.5 5904.8 5917.5 1712.9 1728.1 1735.0 1763.8 1793.2 811.5 864.5 868.2 898.5 928.4 16098.1 16287.1 16375.9 16708.3 16944.6 844.9 849.3 856.2 864.4 890.1 9300.2 9595.9 9723.4 9815.3 9835.4 368863.0 371746.0 381782.0 385391.0 388599.0 61655.7 61724.7 62397.4 63141.4 63314.4 873.9 890.7 894.9 897.0 898.6 14062.3 14540.9 14764.1 14873.9 14998.8 33230.7 33627.0 33759.5 34461.7 35264.3 43548.8 44159.6 44414.0 44877.0 45578.0 6780.5 7061.9 7319.9 7432.9 7787.3 10750.5 11068.1 11273.5 11601.4 11759.4 9364.4 9986.7 10100.8 10260.7 10308.4 4165.2 4293.7 10043.4 10105.0 10237.3 10052.9 10080.1 10162.5 10226.4 10429.7 7107.1 7209.2 7250.8 7252.1 7254.7 10005.6 10010.3 10016.2 10163.1 10198.0 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | [#3] mootools.html Cycles:180 Average:4992.05 Median:4811.88 stddev:2887.11 (60.0%) stddev-sans-first:2881.59 11:19:30 INFO - PROCESS | 19966 | Values: 1260.0 1367.4 1424.4 1474.6 1702.6 6472.9 7394.4 7683.3 7683.4 7984.4 7852.8 7917.0 7918.7 7921.1 7928.8 2153.0 2181.9 2183.4 2186.2 2187.0 2119.5 2151.7 2182.1 2182.3 2186.1 2144.6 2162.0 2173.4 2175.2 2176.2 2097.7 2106.5 2113.5 2113.5 2118.2 2052.7 2088.4 2089.5 2096.8 2105.3 7755.3 7848.7 7857.0 7908.4 7959.5 4513.0 4664.2 4678.8 4690.9 4691.9 2824.3 2907.7 2948.8 2971.6 2974.7 926.9 930.5 931.2 938.7 946.4 10659.7 10768.3 10803.5 10804.1 10825.4 4126.6 4138.6 4142.4 4152.3 4249.8 8530.3 8530.7 8535.3 8538.1 8539.4 4554.7 4559.2 4562.4 4563.3 4572.9 3603.8 3645.7 3707.4 4188.8 4219.9 3114.1 3439.9 3449.9 3460.9 3476.1 971.5 1001.1 1003.7 1011.6 1012.2 597.7 718.8 725.2 747.9 766.5 4768.3 4946.4 4960.8 5058.4 5112.9 357.7 384.8 385.1 396.7 407.8 3250.6 3277.6 3283.1 3299.4 3400.2 9225.0 9665.0 9673.4 9682.8 9689.0 9601.6 9611.7 9614.3 9624.1 9635.9 7266.3 7273.4 7321.8 7353.6 7363.2 4581.5 4855.5 4858.5 4875.2 4921.4 8608.4 8759.5 8854.3 8886.3 8904.7 8898.2 8967.0 8999.8 9013.8 9041.5 6340.1 6406.2 6416.4 6418.9 6428.4 7081.1 7081.5 7121.6 7157.9 7185.3 6546.5 6568.9 6593.4 6605.4 6731.0 6481.8 6532.8 6605.8 6654.3 6769.1 5638.5 5796.9 5839.6 5961.8 5966.6 4136.7 4180.9 4247.4 4287.7 4384.1 4102.1 4180.8 4200.6 4215.1 4387.0 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | [#4] prototype.html Cycles:180 Average:4148.62 Median:4747.51 stddev:1201.32 (25.3%) stddev-sans-first:1169.11 11:19:30 INFO - PROCESS | 19966 | Values: 282.4 283.3 292.6 293.1 295.1 4717.7 4793.5 4798.3 4822.6 4840.0 4732.4 4745.9 4752.4 4754.9 4766.6 3545.0 3653.7 3789.4 3790.6 3809.8 3657.3 3741.7 3746.8 3758.1 3768.2 3714.0 3717.5 3721.1 3725.0 3735.1 3523.7 3644.3 3734.3 3755.6 3756.1 3220.6 3263.6 3293.3 3293.5 3297.8 4595.5 4621.8 4632.4 4650.8 4670.4 4248.4 4251.3 4253.1 4264.4 4299.4 4820.4 4917.2 4954.6 4955.6 4985.6 3569.4 3573.0 3590.2 3600.2 3601.3 5165.5 5171.3 5183.4 5189.8 5245.7 3511.7 3689.4 3700.6 3752.7 3757.7 3760.5 3761.1 3761.6 3761.6 3776.4 4271.6 4292.7 4311.8 4317.4 4330.3 4866.0 5085.5 5096.3 5100.3 5100.8 1279.8 1306.8 1308.6 1311.1 1312.7 806.8 838.6 841.9 856.2 857.9 3869.9 3926.0 4168.9 4266.2 4359.7 5143.2 5152.0 5162.7 5176.8 5196.4 4424.7 4432.4 4448.4 4453.7 4477.8 2594.2 2690.7 2723.5 2727.5 2750.4 4794.1 4798.2 4798.6 4803.4 4841.2 5262.3 5268.4 5274.3 5279.4 5292.0 4675.4 4762.3 4811.4 4822.8 4850.9 5106.5 5114.5 5118.9 5126.6 5129.6 5052.8 5061.2 5065.3 5069.2 5087.7 4590.2 4750.7 4769.2 4785.5 4848.2 3729.0 3733.6 3734.8 3734.8 3746.7 5142.5 5152.9 5199.6 5211.5 5214.3 4749.2 4976.5 5016.4 5019.6 5030.8 4955.4 4972.6 4987.4 4998.7 5002.2 4926.0 4933.8 4939.9 4948.4 4963.2 4781.6 4902.0 4998.4 5008.0 5063.6 4741.8 4796.9 4898.7 4907.7 4914.5 11:19:30 INFO - PROCESS | 19966 | 11:19:30 INFO - PROCESS | 19966 | [#5] yui.html Cycles:180 Average:15798.34 Median:468.70 stddev:21615.78 (4611.9%) stddev-sans-first:21646.31 11:19:30 INFO - PROCESS | 19966 | Values: 603.0 606.9 626.8 646.7 700.1 11689.8 12649.4 13015.1 13037.0 13050.6 12641.6 12691.4 12754.3 12761.6 12793.0 639.9 770.1 792.7 796.1 796.9 648.4 781.0 796.3 796.8 797.2 834.4 839.9 841.3 842.9 845.9 664.9 837.7 841.8 842.6 842.8 500.7 587.6 602.5 603.8 604.1 12784.6 12798.9 12833.2 12849.4 12862.0 10931.5 11345.4 11664.2 11674.2 11928.8 11697.1 11712.1 11837.8 11889.5 11980.3 3988.1 4012.8 4013.3 4045.1 4054.3 60294.4 60896.7 61470.0 62004.0 62640.4 9945.4 10034.9 10067.4 10165.4 10248.9 18789.3 18889.3 18936.1 18948.6 19056.0 5846.4 6022.2 6368.2 6532.4 6873.4 3480.6 3504.8 3544.8 3586.1 3591.0 2745.5 2825.7 2833.0 2840.4 2850.2 440.7 443.1 445.0 446.2 452.7 479.5 494.6 520.8 548.5 570.7 6908.9 7154.2 7169.0 7409.5 7556.2 448.9 457.9 517.7 520.2 538.3 3431.5 3449.8 3496.4 3554.6 3652.4 69675.0 70845.6 71256.6 90403.5 99731.0 72376.0 72713.6 74111.6 74972.6 75835.6 48170.5 59799.0 65312.3 66789.0 68019.7 7947.6 8247.5 8262.9 8454.7 8640.8 31662.4 34993.7 40234.8 42391.6 43274.0 34270.6 35117.0 37319.6 60051.0 61600.0 9694.4 10104.8 10337.9 10537.8 11239.5 12536.8 12578.6 12786.7 12897.4 13440.7 10763.6 11052.3 11066.9 11146.6 11480.8 11573.0 11941.5 12314.5 12343.3 12459.4 9869.4 9974.5 10159.6 10703.5 10708.4 8708.3 8809.4 9170.2 9270.7 9274.8 8706.2 9100.7 9183.8 9186.0 9241.6 11:19:30 INFO - PROCESS | 19966 | -------- Summary: end -------- 11:19:30 INFO - PROCESS | 19966 | 11:19:31 INFO - TEST-INFO | 19966: exit 0 11:19:31 INFO - TEST-OK | dromaeo_css | took 1122029ms 11:19:31 INFO - TEST-START | kraken 11:19:31 INFO - operating with platform_type : linux_ 11:19:31 INFO - Initialising browser for kraken test... 11:19:31 INFO - TEST-INFO | started process 20281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_6_a54/profile http://localhost:48660/getInfo.html) 11:19:35 INFO - PROCESS | 20281 | __metrics Screen width/height:1600/1200 11:19:35 INFO - PROCESS | 20281 | colorDepth:24 11:19:35 INFO - PROCESS | 20281 | Browser inner width/height: 1024/697 11:19:35 INFO - PROCESS | 20281 | __metrics 11:19:36 INFO - PROCESS | 20281 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:19:36 INFO - PROCESS | 20281 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:36 INFO - PROCESS | 20281 | console.error: PushService: 11:19:36 INFO - PROCESS | 20281 | stateChangeProcessEnqueue: Error transitioning state 11:19:36 INFO - PROCESS | 20281 | UnknownError 11:19:37 INFO - TEST-INFO | 20281: exit 0 11:19:37 INFO - Browser initialized. 11:19:37 INFO - Running cycle 1/1 for kraken test... 11:19:37 INFO - TEST-INFO | started process 20364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_6_a54/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:49 INFO - PROCESS | 20364 | RSS: Main: 173498368 11:19:49 INFO - PROCESS | 20364 | 11:19:52 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48660/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:53 INFO - PROCESS | 20364 | RSS: Main: 230289408 11:19:53 INFO - PROCESS | 20364 | 11:19:56 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48660/tests/kraken/driver.html?testName=audio-dft) 11:19:56 INFO - PROCESS | 20364 | RSS: Main: 217206784 11:19:56 INFO - PROCESS | 20364 | 11:20:00 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48660/tests/kraken/driver.html?testName=audio-fft) 11:20:00 INFO - PROCESS | 20364 | RSS: Main: 298303488 11:20:00 INFO - PROCESS | 20364 | 11:20:02 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48660/tests/kraken/driver.html?testName=audio-oscillator) 11:20:03 INFO - PROCESS | 20364 | RSS: Main: 209801216 11:20:03 INFO - PROCESS | 20364 | 11:20:05 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:06 INFO - PROCESS | 20364 | RSS: Main: 212635648 11:20:06 INFO - PROCESS | 20364 | 11:20:09 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48660/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:10 INFO - PROCESS | 20364 | RSS: Main: 248619008 11:20:10 INFO - PROCESS | 20364 | 11:20:13 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48660/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:14 INFO - PROCESS | 20364 | RSS: Main: 243089408 11:20:14 INFO - PROCESS | 20364 | 11:20:16 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48660/tests/kraken/driver.html?testName=json-parse-financial) 11:20:17 INFO - PROCESS | 20364 | RSS: Main: 245669888 11:20:17 INFO - PROCESS | 20364 | 11:20:19 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:19 INFO - PROCESS | 20364 | RSS: Main: 209276928 11:20:19 INFO - PROCESS | 20364 | 11:20:21 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:22 INFO - PROCESS | 20364 | RSS: Main: 216854528 11:20:22 INFO - PROCESS | 20364 | 11:20:24 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:25 INFO - PROCESS | 20364 | RSS: Main: 225402880 11:20:25 INFO - PROCESS | 20364 | 11:20:28 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:28 INFO - PROCESS | 20364 | RSS: Main: 234369024 11:20:28 INFO - PROCESS | 20364 | 11:20:31 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:32 INFO - PROCESS | 20364 | RSS: Main: 231051264 11:20:32 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | Cycle 1(1): loaded http://localhost:48660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48660/tests/kraken/driver.html?testName=ai-astar) 11:20:34 INFO - PROCESS | 20364 | RSS: Main: 279404544 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | __start_tp_report 11:20:34 INFO - PROCESS | 20364 | _x_x_mozilla_page_load 11:20:34 INFO - PROCESS | 20364 | _x_x_mozilla_page_load_details 11:20:34 INFO - PROCESS | 20364 | |i|pagename|runs| 11:20:34 INFO - PROCESS | 20364 | |0;ai-astar;106;113;114;113;113;113;113;113;113;113 11:20:34 INFO - PROCESS | 20364 | |1;audio-beat-detection;155;130;129;167;130;127;127;127;163;128 11:20:34 INFO - PROCESS | 20364 | |2;audio-dft;160;161;162;163;162;161;162;160;161;162 11:20:34 INFO - PROCESS | 20364 | |3;audio-fft;78;77;77;108;78;77;77;77;101;76 11:20:34 INFO - PROCESS | 20364 | |4;audio-oscillator;84;85;119;84;85;84;108;82;83;120 11:20:34 INFO - PROCESS | 20364 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;117;119 11:20:34 INFO - PROCESS | 20364 | |6;imaging-darkroom;146;147;148;146;147;146;146;147;146;147 11:20:34 INFO - PROCESS | 20364 | |7;imaging-desaturate;85;85;85;84;85;84;84;84;84;84 11:20:34 INFO - PROCESS | 20364 | |8;json-parse-financial;64;64;63;63;63;65;64;64;65;64 11:20:34 INFO - PROCESS | 20364 | |9;json-stringify-tinderbox;66;66;66;65;68;70;70;66;67;67 11:20:34 INFO - PROCESS | 20364 | |10;stanford-crypto-aes;85;93;87;92;83;94;91;84;84;84 11:20:34 INFO - PROCESS | 20364 | |11;stanford-crypto-ccm;151;144;141;146;137;139;155;141;177;152 11:20:34 INFO - PROCESS | 20364 | |12;stanford-crypto-pbkdf2;182;177;185;182;179;179;182;180;178;183 11:20:34 INFO - PROCESS | 20364 | |13;stanford-crypto-sha256-iterative;78;74;71;72;74;75;70;69;67;69 11:20:34 INFO - PROCESS | 20364 | __end_tp_report 11:20:34 INFO - PROCESS | 20364 | __start_cc_report 11:20:34 INFO - PROCESS | 20364 | _x_x_mozilla_cycle_collect,1923 11:20:34 INFO - PROCESS | 20364 | __end_cc_report 11:20:34 INFO - PROCESS | 20364 | __startTimestamp1476901234585__endTimestamp 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | ------- Summary: start ------- 11:20:34 INFO - PROCESS | 20364 | Number of tests: 14 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.27 (2.0%) stddev-sans-first:0.33 11:20:34 INFO - PROCESS | 20364 | Values: 106.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:130.00 stddev:16.42 (12.6%) stddev-sans-first:16.26 11:20:34 INFO - PROCESS | 20364 | Values: 155.0 130.0 129.0 167.0 130.0 127.0 127.0 127.0 163.0 128.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 11:20:34 INFO - PROCESS | 20364 | Values: 160.0 161.0 162.0 163.0 162.0 161.0 162.0 160.0 161.0 162.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:11.67 (15.2%) stddev-sans-first:12.26 11:20:34 INFO - PROCESS | 20364 | Values: 78.0 77.0 77.0 108.0 78.0 77.0 77.0 77.0 101.0 76.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.00 stddev:15.71 (18.7%) stddev-sans-first:16.29 11:20:34 INFO - PROCESS | 20364 | Values: 84.0 85.0 119.0 84.0 85.0 84.0 108.0 82.0 83.0 120.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 11:20:34 INFO - PROCESS | 20364 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 119.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:20:34 INFO - PROCESS | 20364 | Values: 146.0 147.0 148.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 11:20:34 INFO - PROCESS | 20364 | Values: 85.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 11:20:34 INFO - PROCESS | 20364 | Values: 64.0 64.0 63.0 63.0 63.0 65.0 64.0 64.0 65.0 64.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.73 (2.6%) stddev-sans-first:1.79 11:20:34 INFO - PROCESS | 20364 | Values: 66.0 66.0 66.0 65.0 68.0 70.0 70.0 66.0 67.0 67.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:89.00 stddev:4.32 (4.9%) stddev-sans-first:4.47 11:20:34 INFO - PROCESS | 20364 | Values: 85.0 93.0 87.0 92.0 83.0 94.0 91.0 84.0 84.0 84.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:148.50 stddev:11.71 (7.9%) stddev-sans-first:12.38 11:20:34 INFO - PROCESS | 20364 | Values: 151.0 144.0 141.0 146.0 137.0 139.0 155.0 141.0 177.0 152.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:182.00 stddev:2.50 (1.4%) stddev-sans-first:2.60 11:20:34 INFO - PROCESS | 20364 | Values: 182.0 177.0 185.0 182.0 179.0 179.0 182.0 180.0 178.0 183.0 11:20:34 INFO - PROCESS | 20364 | 11:20:34 INFO - PROCESS | 20364 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:73.00 stddev:3.35 (4.6%) stddev-sans-first:2.73 11:20:34 INFO - PROCESS | 20364 | Values: 78.0 74.0 71.0 72.0 74.0 75.0 70.0 69.0 67.0 69.0 11:20:34 INFO - PROCESS | 20364 | -------- Summary: end -------- 11:20:34 INFO - PROCESS | 20364 | 11:20:36 INFO - TEST-INFO | 20364: exit 0 11:20:36 INFO - TEST-OK | kraken | took 64871ms 11:20:36 INFO - SUITE-END | took 1186s 11:20:36 INFO - Completed test suite (00:19:47) 11:20:36 INFO - javascript benchmark 11:20:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.4362640219147, 2567.576349902266, 2615.8561279129653, 2625.1205846041576, 2640.3663120851, 4614.054118905625, 4635.096156249533, 4712.528747125286, 4726.763661816908, 4735.218688916329, 4714.057188562293, 4723.267893476508, 4726.574608285262, 4777.52224777522, 4799.808007679689, 4292.828286868537, 4327.0480494291205, 4344.4786625604975, 4402.273624851896, 4448.0, 4488.326750987346, 4492.61812745917, 4494.303382975628, 4500.932486012696, 4518.1415531049, 4260.7656578888145, 4434.334849772527, 4437.711548749353, 4452.087322098978, 4543.954560454386, 4363.149185908717, 4363.258246098171, 4423.225935461313, 4427.291633338683, 4449.443819522559, 4373.934390984138, 4383.583559561836, 4394.516603173648, 4424.070945101533, 4443.533428989942, 4741.0, 4778.235482322812, 4803.471618122004, 4806.038792241531, 4865.781039853215, 4984.501549845023, 5050.368703912011, 5051.494850514956, 5096.184610462308, 5105.463926287724, 5155.71643559604, 5174.948250517522, 5190.662606930575, 5209.192575150858, 5230.633855630107, 4814.109389762905, 4820.517948205222, 4838.346823178897, 4838.443578988426, 4881.414230292387, 5101.540861322499, 5181.559567436735, 5303.655262407931, 5305.124654432053, 5305.4164041955355, 4971.801127954914, 4975.278584605212, 5017.698938063655, 5028.220625803006, 5101.132807422747, 5088.847334579968, 5103.897922041539, 5107.565856902131, 5108.361454818148, 5175.792968281302, 5047.394312682502, 5051.722155281494, 5085.898282034413, 5099.413567439792, 5167.509086636764, 4942.184539550934, 5008.023435430129, 5008.874778130576, 5066.341375621146, 5069.39167299919, 4364.978175109168, 4365.214261432972, 4365.257906155897, 4366.868993930188, 4369.235383807821, 3747.0445036515516, 3784.299904517618, 3831.3486707259276, 3833.8083095845095, 3836.501254836853, 4364.432623758955, 4374.540673229329, 4383.057642606855, 4428.9813342930665, 4429.911401772011, 5084.669496482717, 5120.641555091108, 5128.0, 5131.820386286462, 5193.143131383279, 4278.187144442546, 4339.197248508973, 4346.261135606955, 4369.956300436955, 4412.492563355255, 4516.3902873112365, 4545.704529205591, 4547.8635640930825, 4559.3844830948065, 4626.097910907408, 4808.519148085234, 4823.975880120577, 4824.107540105092, 4829.830955916666, 4886.511348865085, 5121.74391280442, 5154.664946778447, 5166.095933211598, 5168.3797944246935, 5231.869203269949, 4617.676762626584, 4681.133990211822, 4681.461631912373, 4786.8085276588545, 4834.806607735652, 5100.18397056484, 5108.335916330853, 5108.821191258288, 5157.07172708916, 5164.948350516447, 5167.302414174038, 5175.0, 5177.197534382177, 5178.249153872743, 5241.423443421144, 4851.102546028996, 4915.287283343823, 4917.01659668075, 5026.421961474477, 5038.395392552917, 4959.0329885671945, 4963.181075122564, 5001.349824522788, 5010.69935803853, 5086.237064440364, 4913.1893237615395, 4939.629527785359, 4939.777710002986, 4939.827106051271, 5008.474110218374, 4841.782119804688, 5037.244413338029, 5051.772670229775, 5056.342675452168, 5118.104331742004, 4751.40607424072, 4864.148773964472, 4880.95119048805, 4915.5330243626795, 4917.434495033117], "value": 4692.029631060804, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.6221407229011, 548.2051026012283, 564.9914901900108, 571.4456976732567, 577.9046457334539, 29818.85090574547, 30659.84670076649, 38425.42361864567, 39948.600513994854, 40010.39984400229, 39979.40030899532, 40399.0, 40474.19051618973, 40540.39189412154, 40573.59426405735, 7545.283198096199, 7699.576523291216, 7700.576468294242, 7703.268189521987, 7705.15243323234, 7507.512011719221, 7597.202293759131, 7602.277783610548, 7602.809929751746, 7609.048868891388, 7592.506487078323, 7632.274933881273, 7632.771016869475, 7643.121041080291, 7651.081870175559, 7550.5847178405165, 7572.242775722439, 7576.0908690956885, 7584.810379740496, 7584.848303033964, 7592.278733520362, 7641.847163056707, 7646.961765191194, 7656.885146722803, 7661.846763064707, 36210.63789362099, 36635.26729465422, 36695.449568256496, 36702.265954680755, 36749.0, 3004.8948286810073, 3183.729383002448, 3500.9649903500895, 3549.4853246279145, 3659.0669379308106, 28040.298992525146, 28719.28201794951, 28890.422191556263, 29188.270293242625, 30400.695993040008, 3346.3140056288403, 3367.3770352484867, 3406.6423025582453, 3450.447928331455, 3523.9471407928645, 235033.0, 236297.0, 236314.0, 236344.0, 237076.0, 52440.0, 53085.734571326895, 53167.734161328946, 53169.202461963105, 53321.0, 32468.350632987207, 33471.16322091918, 33619.15952101168, 54718.452815472134, 54862.45137548653, 14353.85646143546, 14357.425702971974, 14363.425462981573, 14461.349239284258, 14463.49377771773, 10684.839727404094, 10706.946465267623, 10707.678769636923, 10725.195610329256, 10727.78544429107, 17523.56191095233, 17651.82348176502, 17681.7347739784, 17732.822671773116, 17747.378841740476, 6721.66391680414, 6968.512204145661, 6991.126109236346, 6992.265812089658, 7109.715611375487, 779.6140910249463, 891.8305521950808, 908.7410088124852, 911.8085202107632, 962.7110577924068, 26380.47239055208, 26769.19692409231, 27313.0, 27413.86293068522, 27526.587101193498, 726.6040008195546, 922.9030951749969, 1019.9647357931706, 1025.9281850270409, 1061.7876424714934, 13471.595852124452, 14383.856161438462, 14435.0, 14505.0, 14721.263936803118, 360779.0, 361642.0, 362817.0, 363566.0, 364679.0, 47075.76462117668, 47471.287930681065, 47605.523944760804, 47628.28557571639, 47671.0, 1054.699410667956, 1099.2250463423268, 1123.5955056179769, 1136.86926003509, 1175.6149562133292, 24392.87803560971, 26827.597586036616, 26941.0, 28398.574021389282, 28488.572671409533, 40920.0, 46310.0, 46415.30377044279, 46446.07107857891, 46555.0, 333013.0, 334750.0, 335494.0, 337893.07390039135, 338043.0, 23810.523789524457, 25083.623745643465, 25228.74771252264, 26480.470390591694, 26904.59643105316, 37395.0, 38027.80986095052, 38044.23911521809, 38053.0, 39006.60993390143, 32295.0, 32716.345673086882, 32771.672283276865, 32793.50809737904, 33617.66382336145, 31324.0, 32828.015159545255, 32968.34063318672, 33542.32915341631, 33744.66255337415, 31858.36283274275, 32371.19072023218, 32599.837000814845, 32773.67226327706, 33108.66891331056, 28435.431291373643, 29461.410771784875, 29914.850425747733, 30087.0, 30186.0, 23379.103164566153, 23510.412239694146, 23511.41221469477, 23730.881345593163, 23986.0], "value": 16896.8687353019, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.23222748815164, 358.3317113583168, 366.8000939487979, 372.2592041836745, 391.93924941634054, 12281.14032017758, 12508.374581270946, 16127.838721612781, 16322.183890805472, 17093.23080461379, 14409.0, 14424.278786060708, 14543.272836358166, 14730.26348682567, 16827.83172168281, 4821.662483626147, 4860.829870954517, 5076.517730815566, 5078.949210507903, 5080.364954380702, 4536.500984891659, 5131.589472842183, 5132.538071573557, 5133.076046311662, 5135.871603209931, 5098.439171691111, 5104.055749686301, 5107.565856902168, 5108.20822772469, 5109.182530795074, 4895.485973972735, 5060.898782024357, 5077.238414237857, 5081.974590127063, 5087.211482220243, 4561.589456948891, 4563.429571303587, 4565.041341318327, 4565.977170114162, 4567.314902764612, 19105.61788764217, 19648.901755491275, 19712.70430943537, 19756.901215493974, 19862.80137198624, 1809.1406581873637, 2320.501092265171, 2391.1272385579314, 2412.3486658602255, 2436.549238390903, 12511.812322815165, 12711.809322860165, 12841.743165136644, 13188.538401156009, 13276.53532126371, 1684.4020372767613, 1687.974680379783, 1706.1895599590218, 1726.8445839874346, 1767.5757818123686, 63839.0, 64600.676996615184, 64784.99999999953, 64827.3517264826, 64898.67550662264, 9097.636094556143, 9211.723648290563, 9513.191378732747, 9546.474943878153, 9598.9040109598, 13035.15271507349, 13043.347832608331, 13072.28102454355, 13078.607641770763, 13088.934555327163, 6950.409215216662, 7100.715971361191, 7182.712691492282, 7225.530340527849, 7281.1262648482525, 6624.966875165594, 6635.86728265432, 6724.865502689919, 6856.074429951992, 6878.58728476293, 5781.277340332458, 5803.912941305884, 5866.494754732469, 5904.76380944766, 5917.52659787216, 1712.8715346349074, 1728.1186594836724, 1734.965300693979, 1763.8236176382259, 1793.1751394358741, 811.5495899775564, 864.4553931023415, 868.2142660891903, 898.510311880027, 928.4104593583123, 16098.11460369691, 16287.104209268604, 16375.918120409322, 16708.331666733437, 16944.57638559046, 844.8859403980384, 849.2611428057506, 856.1823458597025, 864.3517361978517, 890.1143362354499, 9300.162985331217, 9595.856062159073, 9723.367981081206, 9815.312928094965, 9835.360701554377, 368863.0, 371746.0, 381782.0, 385391.0, 388599.0, 61655.691721542, 61724.69137654283, 62397.37602624006, 63141.36858631447, 63314.36685633177, 873.8689196620558, 890.6526454682679, 894.852349362361, 897.0132853860831, 898.6495266845935, 14062.296885155905, 14540.927295363455, 14764.114153150846, 14873.85126148768, 14998.775018374952, 33230.66769332276, 33627.0, 33759.4936075964, 34461.65538344685, 35264.29471410506, 43548.78225608852, 44159.55840441555, 44414.0, 44877.0, 45578.0, 6780.525363224527, 7061.858762824612, 7319.890201647086, 7432.888506672512, 7787.338076263581, 10750.46247687628, 11068.114550836075, 11273.492692829006, 11601.419929003347, 11759.353235572125, 9364.391314564531, 9986.700398988041, 10100.84848727255, 10260.650834835322, 10308.433036183082, 4165.229432554987, 4293.720908140961, 10043.397396156253, 10105.0, 10237.310843710704, 10052.94973525157, 10080.143187829117, 10162.491875406053, 10226.437545934747, 10429.68710938673, 7107.076080109553, 7209.170945341143, 7250.818729531804, 7252.093488313961, 7254.746083887038, 10005.649802256887, 10010.349327293703, 10016.248781341574, 10163.136133428741, 10198.0], "value": 7939.466535015344, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.9748005039905, 1367.4256812138901, 1424.3946322812806, 1474.6018574984755, 1702.5658457093439, 6472.935270647292, 7394.408447324215, 7683.270089341518, 7683.385329173673, 7984.401169912266, 7852.764417067483, 7917.010373703287, 7918.683252669886, 7921.128675845653, 7928.7621371358955, 2152.9784702152974, 2181.9127234910584, 2183.3886511776727, 2186.158329043314, 2187.0267730859773, 2119.5231073008526, 2151.698762173297, 2182.138055468089, 2182.2798476502717, 2186.0818456248335, 2144.592527419793, 2161.9783802162015, 2173.4131784418196, 2175.184305885293, 2176.1948079210633, 2097.727295451597, 2106.452322396173, 2113.4821968617634, 2113.4821968617634, 2118.1527389044427, 2052.6613108837023, 2088.363049269972, 2089.477630592352, 2096.779838116991, 2105.2631578947244, 7755.2632499912415, 7848.725294614661, 7856.960715196445, 7908.406869484812, 7959.482633628795, 4513.0, 4664.183767840648, 4678.836240731558, 4690.906181876343, 4691.859244222679, 2824.2515733330683, 2907.680155182928, 2948.8083274587298, 2971.554266859967, 2974.7471464925507, 926.8702381666573, 930.4975313330793, 931.2038207332769, 938.6714649872558, 946.4368700623119, 10659.680209593724, 10768.300060496043, 10803.459827008697, 10804.13566914645, 10825.404602746847, 4126.607972242632, 4138.627523522837, 4142.4051740079685, 4152.252594532953, 4249.80875860587, 8530.317574594017, 8530.70142545008, 8535.274501667427, 8538.06081331053, 8539.444936079259, 4554.726716397026, 4559.224931761609, 4562.429696287964, 4563.315502674625, 4572.908541829212, 3603.837827297778, 3645.65366290202, 3707.4068149096015, 4188.81150348235, 4219.873403797891, 3114.0657802659566, 3439.9312013759586, 3449.931001379958, 3460.8961731148106, 3476.0534100903574, 971.5142428785607, 1001.0890090018048, 1003.6537394598852, 1011.585250047477, 1012.1548506996741, 597.6951754605183, 718.7807718645759, 725.2276325713099, 747.8616455955557, 766.4826242286434, 4768.284757286366, 4946.3817022872145, 4960.801567937314, 5058.367704036996, 5112.900726343854, 357.72633935039715, 384.75568014311114, 385.08542212245914, 396.74806497874056, 407.83686525390084, 3250.6424293327714, 3277.623073346548, 3283.097148284241, 3299.4061069007807, 3400.217949871494, 9225.0, 9664.951675241578, 9673.419594824332, 9682.75793105178, 9689.0, 9601.615935362646, 9611.711648650551, 9614.278929080347, 9624.133827955518, 9635.903640963641, 7266.273372662798, 7273.418126549864, 7321.816954576072, 7353.595552244571, 7363.190049094595, 4581.522389249954, 4855.465898751064, 4858.5384388483035, 4875.171220892527, 4921.360223170965, 8608.354373421893, 8759.474431534129, 8854.335924805537, 8886.333524985523, 8904.73285801427, 8898.154675306094, 8967.0, 8999.820003600022, 9013.774655633662, 9041.457512549268, 6340.112384266298, 6406.23125224976, 6416.390442908103, 6418.903716444351, 6428.4214420702365, 7081.114860642419, 7081.46888983318, 7121.608311542707, 7157.928420715726, 7185.2814718527725, 6546.5417420782, 6568.9014664781025, 6593.406593406617, 6605.405513503808, 6731.0, 6481.837954051187, 6532.8366790830605, 6605.768798092044, 6654.3012983637955, 6769.086173366532, 5638.4925356718095, 5796.94203057964, 5839.649621022752, 5961.7615295387695, 5966.582339236385, 4136.710430269853, 4180.895477613084, 4247.426597409434, 4287.65698744106, 4384.05742765307, 4102.097538541516, 4180.8118634660905, 4200.613797446897, 4215.13589714114, 4386.978065109654], "value": 3912.3585685704084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.3548192380411, 283.29600941659976, 292.561158262606, 293.05489795409795, 295.10435827264257, 4717.702631776259, 4793.5446132617435, 4798.312944750937, 4822.64965809573, 4839.975800120998, 4732.408448943882, 4745.857624271269, 4752.364441202474, 4754.9286760698615, 4766.61867050636, 3544.982275088621, 3653.725970552206, 3789.3558095123894, 3790.564085130204, 3809.8285577149027, 3657.3233951718885, 3741.681957033655, 3746.8126593670345, 3758.135628805376, 3768.2275133597545, 3714.0, 3717.516722826029, 3721.144136848513, 3724.9813750931344, 3735.1035751419736, 3523.6828685418177, 3644.2529281497227, 3734.271816995687, 3755.586885442599, 3756.11731243159, 3220.6457289698114, 3263.6083669959758, 3293.324868401996, 3293.5389045533643, 3297.7526685498683, 4595.471520775087, 4621.815127394933, 4632.374629425052, 4650.790714417859, 4670.439547254351, 4248.383984322256, 4251.319788833803, 4253.149370125956, 4264.360345948102, 4299.355096735483, 4820.373351464323, 4917.213245880677, 4954.628402869763, 4955.60355171589, 4985.626078044161, 3569.3575156471825, 3573.0, 3590.1922067534856, 3600.207954250061, 3601.2617413430185, 5165.535101840853, 5171.301874246966, 5183.377994640629, 5189.766460509286, 5245.737713114368, 3511.701505372072, 3689.4281386385155, 3700.5744339401313, 3752.7240738148616, 3757.680597149218, 3760.4547340635454, 3761.097336639187, 3761.586225515191, 3761.6238376162714, 3776.3580191367532, 4271.611726189001, 4292.656587472995, 4311.8009814994575, 4317.395564620955, 4330.285502891988, 4865.9756701216975, 5085.466026067284, 5096.337476128154, 5100.27135482515, 5100.770465329069, 1279.8272233248579, 1306.8301120854228, 1308.6074177746639, 1311.0756916374123, 1312.737452509502, 806.7821688144168, 838.5890913452364, 841.8653015517488, 856.1737922904427, 857.8798968144465, 3869.8645547405704, 3925.9607403926166, 4168.874933751992, 4266.1655488140395, 4359.716618419792, 5143.199880042031, 5151.995360904588, 5162.716050617252, 5176.792928282902, 5196.376434827845, 4424.7123936944, 4432.357308190294, 4448.35498852671, 4453.710508816916, 4477.776111194427, 2594.15689900783, 2690.704022557517, 2723.4553089382202, 2727.5363188258043, 2750.422411293611, 4794.113089078532, 4798.184308667535, 4798.592119669797, 4803.4061606731975, 4841.15279826029, 5262.289590905255, 5268.394134674485, 5274.340707411574, 5279.392869819943, 5291.95712465334, 4675.438947326343, 4762.333273341735, 4811.446683631427, 4822.807087716522, 4850.878728031827, 5106.514881086291, 5114.514121158484, 5118.948810511847, 5126.615813730346, 5129.563987061141, 5052.797888084436, 5061.215511595708, 5065.290859279778, 5069.188929771366, 5087.745612719275, 4590.196715574828, 4750.738709371018, 4769.236922092448, 4785.521447855187, 4848.151573474698, 3728.96271037297, 3733.5519737631657, 3734.775913445202, 3734.7945862976712, 3746.662800347982, 5142.485751424977, 5152.922706159336, 5199.584033277253, 5211.478852114758, 5214.270002199619, 4749.168895443353, 4976.527229913152, 5016.4231113420965, 5019.557691443172, 5030.8239211627415, 4955.4301255356095, 4972.577330926912, 4987.351644286219, 4998.700077995187, 5002.224655178453, 4926.0, 4933.77797999098, 4939.9259011114145, 4948.406191257072, 4963.181075122564, 4781.617470602413, 4901.950980490149, 4998.4251811042195, 5008.04525330057, 5063.5695965843315, 4741.762911854325, 4796.904061918812, 4898.657094003528, 4907.730074845917, 4914.483979182278], "value": 3765.0145234970737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9788957386492, 606.8846919085377, 626.82448914304, 646.7413034786088, 700.1493185779277, 11689.766204675912, 12649.367531623428, 13015.088943773928, 13037.0, 13050.608481745563, 12641.620751377473, 12691.428885700143, 12754.298513581749, 12761.617151485447, 12793.040521960844, 639.8624295776407, 770.0566805663046, 792.7344339646226, 796.080526991326, 796.8844517544982, 648.3969907985571, 780.9804754881117, 796.2594786848229, 796.7649543384687, 797.2426195114635, 834.4284165346756, 839.9412041157121, 841.2891107014563, 842.873568964654, 845.9238668519832, 664.9202095748493, 837.7151768398774, 841.8063845315581, 842.6039761312235, 842.8272204198124, 500.7271037284689, 587.597495715432, 602.4878852974937, 603.7766026570154, 604.1391017799662, 12784.61646150617, 12798.936005320007, 12833.165844220095, 12849.35753212345, 12862.0, 10931.45342732868, 11345.413125908677, 11664.241824281395, 11674.241174323726, 11928.761424771455, 11697.09465045175, 11712.121590880633, 11837.763244735143, 11889.524419023228, 11980.281183128953, 3988.0827409695644, 4012.8394864205397, 4013.337799263118, 4045.1190196558446, 4054.2904991626347, 60294.39705602932, 60896.69551652257, 61470.0, 62003.99999999955, 62640.37359626436, 9945.403275803475, 10034.949825250973, 10067.395956242648, 10165.44090075053, 10248.897511024794, 18789.34237301688, 18889.338873139375, 18936.147873345733, 18948.62102757937, 19056.047197640062, 5846.41535846412, 6022.18700475439, 6368.235811702625, 6532.379423954717, 6873.381395674413, 3480.617132115465, 3504.7546671733244, 3544.80503572306, 3586.085548185248, 3591.030421786103, 2745.5195340815676, 2825.717428257199, 2832.971670283312, 2840.3751174741524, 2850.2446851584345, 440.66289288694173, 443.06513257027643, 445.012073197501, 446.23025281389346, 452.74646198129153, 479.45581764696624, 494.6191432596952, 520.7942862569264, 548.454287983459, 570.6604570280676, 6908.9309106909295, 7154.248803875518, 7169.0, 7409.481336306515, 7556.2443755624, 448.9326601009809, 457.9381783459257, 517.7126694684487, 520.2482412913304, 538.2921458282347, 3431.4681224410256, 3449.7757645752945, 3496.4056110461283, 3554.5556805399324, 3652.415613501827, 69675.0, 70845.64577177081, 71256.64371678108, 90403.54798226098, 99731.0, 72376.0, 72713.63643181857, 74111.62944185245, 74972.62513687396, 75835.62082189554, 48170.5182948173, 59799.0, 65312.34687653158, 66788.99266043956, 68019.65990170017, 7947.615715285276, 8247.463914845515, 8262.876056859031, 8454.661813527637, 8640.827183456422, 31662.36675266528, 34993.65006349904, 40234.79882600685, 42391.57608423876, 43273.99431105256, 34270.63181416008, 35117.0, 37319.62680373162, 60051.0, 61600.0, 9694.418334899929, 10104.79790404173, 10337.896621033995, 10537.841932371173, 11239.494222759831, 12536.811947820972, 12578.559750409058, 12786.68033299175, 12897.419616117484, 13440.663983400493, 10763.569457221623, 11052.336859788438, 11066.889331106586, 11146.609868654557, 11480.770384592428, 11573.0, 11941.462634181657, 12314.507419703112, 12343.259404435763, 12459.439325230567, 9869.407835529892, 9974.50127493608, 10159.644412445528, 10703.518341674488, 10708.357498550113, 8708.34687398435, 8809.383343165917, 9170.174684278447, 9270.675526356816, 9274.768130796783, 8706.216440520131, 9100.681476148304, 9183.770405739642, 9186.0, 9241.630334786532], "value": 6178.049412470452, "unit": "score"}], "name": "dromaeo_css", "value": 6208.844972975796, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 129.0, 167.0, 130.0, 127.0, 127.0, 127.0, 163.0, 128.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 160.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 108.0, 78.0, 77.0, 77.0, 77.0, 101.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 119.0, 84.0, 85.0, 84.0, 108.0, 82.0, 83.0, 120.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 119.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 68.0, 70.0, 70.0, 66.0, 67.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 87.0, 92.0, 83.0, 94.0, 91.0, 84.0, 84.0, 84.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 144.0, 141.0, 146.0, 137.0, 139.0, 155.0, 141.0, 177.0, 152.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 185.0, 182.0, 179.0, 179.0, 182.0, 180.0, 178.0, 183.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 71.0, 72.0, 74.0, 75.0, 70.0, 69.0, 67.0, 69.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1555.6000000000001, "alertThreshold": 2.0}]} 11:20:36 INFO - Return code: 0 11:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:20:36 INFO - # TBPL SUCCESS # 11:20:36 INFO - Running post-action listener: _resource_record_post_action 11:20:36 INFO - [mozharness: 2016-10-19 18:20:36.392637Z] Finished run-tests step (success) 11:20:36 INFO - Running post-run listener: _resource_record_post_run 11:20:36 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401530880; Read time: 12; Write time: 258896 11:20:36 INFO - TinderboxPrint: CPU usage
13.0% 11:20:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:20:36 INFO - TinderboxPrint: I/O write bytes / time
401,530,880 / 258,896 11:20:36 INFO - TinderboxPrint: CPU idle
8,348.3 (87.0%) 11:20:36 INFO - TinderboxPrint: CPU user
1,202.6 (12.5%) 11:20:36 INFO - TinderboxPrint: Swap in / out
0 / 0 11:20:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99790848; Read time: 0; Write time: 77832 11:20:36 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290377728; Read time: 0; Write time: 177368 11:20:37 INFO - Running post-run listener: _upload_blobber_files 11:20:37 INFO - Blob upload gear active. 11:20:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:20:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:20:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:38 INFO - (blobuploader) - INFO - Done attempting. 11:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:42 INFO - (blobuploader) - INFO - Done attempting. 11:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:43 INFO - (blobuploader) - INFO - Done attempting. 11:20:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:43 INFO - Return code: 0 11:20:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/913cd10ce4b08a749e3f1580bc62d0fa6a4ef29249c32c8b058f9b29d9e1992b1d1d1f9ea4fde3c7ac616a4d70d3a84b10e60a18857f74308deb0804a0d12fc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8d0cfe5d466ae778a3efcbf0eddde8d8fff626c8670dbfffb5184793eac38ed6b1d19006cce08c2f9503909020bbd1547b8478546ef0690a437cb2d7895b2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40044084022ddb336f122a7746c3cd69a9dd94178785879ea503fb6268bae4984ad007c614bb49ffdab4f5a7801ea31c458236436be03b1ee59c920e1c4c0637"} 11:20:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:43 INFO - Contents: 11:20:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/913cd10ce4b08a749e3f1580bc62d0fa6a4ef29249c32c8b058f9b29d9e1992b1d1d1f9ea4fde3c7ac616a4d70d3a84b10e60a18857f74308deb0804a0d12fc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8d0cfe5d466ae778a3efcbf0eddde8d8fff626c8670dbfffb5184793eac38ed6b1d19006cce08c2f9503909020bbd1547b8478546ef0690a437cb2d7895b2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40044084022ddb336f122a7746c3cd69a9dd94178785879ea503fb6268bae4984ad007c614bb49ffdab4f5a7801ea31c458236436be03b1ee59c920e1c4c0637"} 11:20:43 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:43 INFO - Copying logs to upload dir... 11:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.937989 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-19 11:20:43.338641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 11:20:43.342169) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/913cd10ce4b08a749e3f1580bc62d0fa6a4ef29249c32c8b058f9b29d9e1992b1d1d1f9ea4fde3c7ac616a4d70d3a84b10e60a18857f74308deb0804a0d12fc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8d0cfe5d466ae778a3efcbf0eddde8d8fff626c8670dbfffb5184793eac38ed6b1d19006cce08c2f9503909020bbd1547b8478546ef0690a437cb2d7895b2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40044084022ddb336f122a7746c3cd69a9dd94178785879ea503fb6268bae4984ad007c614bb49ffdab4f5a7801ea31c458236436be03b1ee59c920e1c4c0637"} build_url:https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/GQtORQQ9S26kr-AjK0esAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/913cd10ce4b08a749e3f1580bc62d0fa6a4ef29249c32c8b058f9b29d9e1992b1d1d1f9ea4fde3c7ac616a4d70d3a84b10e60a18857f74308deb0804a0d12fc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8d0cfe5d466ae778a3efcbf0eddde8d8fff626c8670dbfffb5184793eac38ed6b1d19006cce08c2f9503909020bbd1547b8478546ef0690a437cb2d7895b2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40044084022ddb336f122a7746c3cd69a9dd94178785879ea503fb6268bae4984ad007c614bb49ffdab4f5a7801ea31c458236436be03b1ee59c920e1c4c0637"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 11:20:43.367846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:20:43.368190) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476899632.384621-1070599708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:20:43.453960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 11:20:43.454321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 11:20:43.454648) ========= ========= Total master_lag: 0.18 =========