builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1479219966.84 results: success (0) buildid: 20161115050514 builduid: 7547e53e3d4e473b80943fef03480bc2 revision: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.842210) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.842696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.842982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.857824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.858196) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 06:26:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-11-15 06:26:07 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.989168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:06.989493) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:07.039540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 06:26:07.039920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 --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=516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 06:26:07,268 truncating revision to first 12 chars 2016-11-15 06:26:07,268 Setting DEBUG logging. 2016-11-15 06:26:07,268 attempt 1/10 2016-11-15 06:26:07,268 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb3473c1770d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 06:26:08,060 unpacking tar archive at: mozilla-central-fb3473c1770d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.123764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 06:26:08.177214) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:08.177546) ========= script_repo_revision: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:08.178007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:08.178298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 06:26:08.187442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 52 secs) (at 2016-11-15 06:26:08.187903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:08 INFO - MultiFileLogger online at 20161115 06:26:08 in /builds/slave/test 06:26:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:26:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:08 INFO - {'append_to_log': False, 06:26:08 INFO - 'base_work_dir': '/builds/slave/test', 06:26:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:26:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:08 INFO - 'branch': 'Firefox-Non-PGO', 06:26:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:08 INFO - 'config_files': ('talos/linux_config.py',), 06:26:08 INFO - 'default_actions': ('clobber', 06:26:08 INFO - 'read-buildbot-config', 06:26:08 INFO - 'download-and-extract', 06:26:08 INFO - 'populate-webroot', 06:26:08 INFO - 'create-virtualenv', 06:26:08 INFO - 'install', 06:26:08 INFO - 'run-tests'), 06:26:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:08 INFO - 'download_minidump_stackwalk': True, 06:26:08 INFO - 'download_symbols': 'ondemand', 06:26:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:08 INFO - 'installer_path': 'installer.exe', 06:26:08 INFO - 'log_level': 'info', 06:26:08 INFO - 'log_name': 'talos', 06:26:08 INFO - 'log_to_console': True, 06:26:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:08 INFO - 'opt_config_files': (), 06:26:08 INFO - 'pip_index': False, 06:26:08 INFO - 'sps_profile': False, 06:26:08 INFO - 'sps_profile_interval': 0, 06:26:08 INFO - 'suite': 'dromaeojs-e10s', 06:26:08 INFO - 'system_bits': '32', 06:26:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:08 INFO - 'title': 'talos-linux64-ix-061', 06:26:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:08 INFO - 'use_talos_json': True, 06:26:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:08 INFO - 'work_dir': 'build'} 06:26:08 INFO - [mozharness: 2016-11-15 14:26:08.519902Z] Running clobber step. 06:26:08 INFO - Running pre-action listener: _resource_record_pre_action 06:26:08 INFO - Running main action method: clobber 06:26:08 INFO - rmtree: /builds/slave/test/build 06:26:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:09 INFO - Running post-action listener: _resource_record_post_action 06:26:09 INFO - [mozharness: 2016-11-15 14:26:09.572983Z] Finished clobber step (success) 06:26:09 INFO - [mozharness: 2016-11-15 14:26:09.573082Z] Running read-buildbot-config step. 06:26:09 INFO - Running pre-action listener: _resource_record_pre_action 06:26:09 INFO - Running main action method: read_buildbot_config 06:26:09 INFO - Using buildbot properties: 06:26:09 INFO - { 06:26:09 INFO - "project": "", 06:26:09 INFO - "product": "firefox", 06:26:09 INFO - "script_repo_revision": "production", 06:26:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:26:09 INFO - "repository": "", 06:26:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:26:09 INFO - "buildid": "20161115050514", 06:26:09 INFO - "pgo_build": "False", 06:26:09 INFO - "basedir": "/builds/slave/test", 06:26:09 INFO - "buildnumber": 549, 06:26:09 INFO - "slavename": "talos-linux64-ix-061", 06:26:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:26:09 INFO - "platform": "ubuntu64_hw", 06:26:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:26:09 INFO - "branch": "mozilla-central", 06:26:09 INFO - "repo_path": "mozilla-central", 06:26:09 INFO - "revision": "fb3473c1770d3dace1ec09dfbb574fabe7cb26b1", 06:26:09 INFO - "stage_platform": "linux64", 06:26:09 INFO - "builduid": "7547e53e3d4e473b80943fef03480bc2", 06:26:09 INFO - "slavebuilddir": "test" 06:26:09 INFO - } 06:26:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 06:26:09 INFO - Running post-action listener: _resource_record_post_action 06:26:09 INFO - [mozharness: 2016-11-15 14:26:09.575490Z] Finished read-buildbot-config step (success) 06:26:09 INFO - [mozharness: 2016-11-15 14:26:09.575579Z] Running download-and-extract step. 06:26:09 INFO - Running pre-action listener: _resource_record_pre_action 06:26:09 INFO - Running main action method: download_and_extract 06:26:09 INFO - mkdir: /builds/slave/test/build/tests 06:26:09 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')]} 06:26:09 INFO - trying https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:26:10 INFO - Downloaded 1361 bytes. 06:26:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:26:10 INFO - Using the following test package requirements: 06:26:10 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:26:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:26:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'jsshell-linux-x86_64.zip'], 06:26:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:26:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:26:10 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:26:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:26:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:26:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:26:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:26:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:26:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:26:10 INFO - retry: attempt #1 caught exception: HTTP Error 503: Service Unavailable 06:26:10 INFO - retry: Failed, sleeping 60 seconds before retrying 06:27:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:27:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:27:11 INFO - retry: attempt #2 caught exception: HTTP Error 503: Service Unavailable 06:27:11 INFO - retry: Failed, sleeping 120 seconds before retrying 06:29:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:29:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:29:12 INFO - Http code: 200 06:29:12 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 06:29:12 INFO - x-amz-cf-id: I0J_CgCZglxeey0UO0EbPGkAgChkoBsvffn-1WqRoFC78nXOlvHVcg== 06:29:12 INFO - x-amz-version-id: OklOh45hfGaAYLP4i_arrcPb5z2_Dj0n 06:29:13 INFO - Expected file size: 20416553 06:29:13 INFO - Obtained file size: 20416553 06:29:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:29:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:29:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:29:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:29:17 INFO - Http code: 200 06:29:17 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 06:29:17 INFO - x-amz-cf-id: BlHT4E1Ke7W7BYTrPZGfAGNLhns1lS6JtbrX5-KqryBZIzTgvpY_wQ== 06:29:17 INFO - x-amz-version-id: OklOh45hfGaAYLP4i_arrcPb5z2_Dj0n 06:29:18 INFO - Expected file size: 20416553 06:29:18 INFO - Obtained file size: 20416553 06:29:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 06:29:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:29:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:29:23 INFO - Http code: 200 06:29:23 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 06:29:23 INFO - x-amz-cf-id: aelpTie5ncH9dHwLWY5_6OOxufUAE9vOHHTEftTjmDrSiVY_dOTmzg== 06:29:23 INFO - x-amz-version-id: W_YIJdTYN_JCf_fkxjc7Yp2_ENZTXvMZ 06:29:24 INFO - Expected file size: 14409038 06:29:24 INFO - Obtained file size: 14409038 06:29: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')]} 06:29:24 INFO - trying https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:29:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:29:25 INFO - Downloaded 55710949 bytes. 06:29:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:29:25 INFO - mkdir: /builds/slave/test/properties 06:29:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:29:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:29:25 INFO - Contents: 06:29:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:29:26 INFO - Running post-action listener: _resource_record_post_action 06:29:26 INFO - Running post-action listener: set_extra_try_arguments 06:29:26 INFO - [mozharness: 2016-11-15 14:29:26.048940Z] Finished download-and-extract step (success) 06:29:26 INFO - [mozharness: 2016-11-15 14:29:26.049179Z] Running populate-webroot step. 06:29:26 INFO - Running pre-action listener: _resource_record_pre_action 06:29:26 INFO - Running main action method: populate_webroot 06:29:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:29:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:29:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:29:26 INFO - '--tppagecycles', 06:29:26 INFO - '7'], 06:29:26 INFO - 'tests': ['tsvgm']}}, 06:29:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:29:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:29:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:29:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:29:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['damp', 'tps']}, 06:29:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'tests': ['damp', 'tps']}, 06:29:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['dromaeo_dom']}, 06:29:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:29:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['basic_compositor_video']}, 06:29:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:29:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['a11yr', 06:29:26 INFO - 'ts_paint', 06:29:26 INFO - 'tpaint', 06:29:26 INFO - 'sessionrestore', 06:29:26 INFO - 'sessionrestore_no_auto_restore', 06:29:26 INFO - 'tabpaint']}, 06:29:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:29:26 INFO - 'ts_paint', 06:29:26 INFO - 'tpaint', 06:29:26 INFO - 'sessionrestore', 06:29:26 INFO - 'sessionrestore_no_auto_restore', 06:29:26 INFO - 'tabpaint']}, 06:29:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:29:26 INFO - 'ts_paint', 06:29:26 INFO - 'tpaint', 06:29:26 INFO - 'sessionrestore', 06:29:26 INFO - 'sessionrestore_no_auto_restore', 06:29:26 INFO - 'tabpaint']}, 06:29:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:29:26 INFO - 'ts_paint', 06:29:26 INFO - 'tpaint', 06:29:26 INFO - 'sessionrestore', 06:29:26 INFO - 'sessionrestore_no_auto_restore', 06:29:26 INFO - 'tabpaint']}, 06:29:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['a11yr', 06:29:26 INFO - 'ts_paint', 06:29:26 INFO - 'tpaint', 06:29:26 INFO - 'sessionrestore', 06:29:26 INFO - 'sessionrestore_no_auto_restore', 06:29:26 INFO - 'tabpaint']}, 06:29:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['a11yr', 06:29:26 INFO - 'ts_paint', 06:29:26 INFO - 'tpaint', 06:29:26 INFO - 'sessionrestore', 06:29:26 INFO - 'sessionrestore_no_auto_restore', 06:29:26 INFO - 'tabpaint']}, 06:29:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['tsvgx', 06:29:26 INFO - 'tsvgr_opacity', 06:29:26 INFO - 'tart', 06:29:26 INFO - 'tscrollx', 06:29:26 INFO - 'cart']}, 06:29:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:29:26 INFO - 'tsvgr_opacity', 06:29:26 INFO - 'tart', 06:29:26 INFO - 'tscrollx', 06:29:26 INFO - 'cart']}, 06:29:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'talos_options': ['--disable-e10s'], 06:29:26 INFO - 'tests': ['tp5o']}, 06:29:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'tests': ['tp5o']}, 06:29:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'talos_options': ['--disable-e10s', 06:29:26 INFO - '--xperf_path', 06:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:26 INFO - 'tests': ['tp5n']}, 06:29:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:26 INFO - 'talos_options': ['--xperf_path', 06:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:26 INFO - 'tests': ['tp5n']}}, 06:29:26 INFO - 'talos.zip': {'path': '', 06:29:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:29:26 INFO - Running post-action listener: _resource_record_post_action 06:29:26 INFO - [mozharness: 2016-11-15 14:29:26.069473Z] Finished populate-webroot step (success) 06:29:26 INFO - [mozharness: 2016-11-15 14:29:26.069561Z] Running create-virtualenv step. 06:29:26 INFO - Running pre-action listener: _resource_record_pre_action 06:29:26 INFO - Running main action method: create_virtualenv 06:29:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:29:26 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 06:29:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:29:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:29:26 INFO - Using real prefix '/usr' 06:29:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:29:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:29:28 INFO - Installing pip.................done. 06:29:28 INFO - Return code: 0 06:29:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:29:28 INFO - Reading from file tmpfile_stdout 06:29:28 INFO - Output received: 06:29:28 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) 06:29:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:29: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')]} 06:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:28 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:28 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 06:29:28 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 06:29:28 INFO - Using env: {'DISPLAY': ':0', 06:29:28 INFO - 'HOME': '/home/cltbld', 06:29:28 INFO - 'LANG': 'en_US.UTF-8', 06:29:28 INFO - 'LANGUAGE': 'en_US:en', 06:29:28 INFO - 'LOGNAME': 'cltbld', 06:29:28 INFO - 'MAIL': '/var/mail/cltbld', 06:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:28 INFO - 'MOZ_NO_REMOTE': '1', 06:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:28 INFO - 'NO_EM_RESTART': '1', 06:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:28 INFO - 'PWD': '/builds/slave/test', 06:29:28 INFO - 'SHELL': '/bin/bash', 06:29:28 INFO - 'SHLVL': '1', 06:29:28 INFO - 'TERM': 'linux', 06:29:28 INFO - 'TMOUT': '86400', 06:29:28 INFO - 'USER': 'cltbld', 06:29:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:28 INFO - '_': '/tools/buildbot/bin/python'} 06:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:29 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 06:29:29 INFO - Cleaning up... 06:29:29 INFO - Return code: 0 06:29:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:29:29 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')]} 06:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:29 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')]} 06:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:29 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:29 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 06:29:29 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 06:29:29 INFO - Using env: {'DISPLAY': ':0', 06:29:29 INFO - 'HOME': '/home/cltbld', 06:29:29 INFO - 'LANG': 'en_US.UTF-8', 06:29:29 INFO - 'LANGUAGE': 'en_US:en', 06:29:29 INFO - 'LOGNAME': 'cltbld', 06:29:29 INFO - 'MAIL': '/var/mail/cltbld', 06:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:29 INFO - 'MOZ_NO_REMOTE': '1', 06:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:29 INFO - 'NO_EM_RESTART': '1', 06:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:29 INFO - 'PWD': '/builds/slave/test', 06:29:29 INFO - 'SHELL': '/bin/bash', 06:29:29 INFO - 'SHLVL': '1', 06:29:29 INFO - 'TERM': 'linux', 06:29:29 INFO - 'TMOUT': '86400', 06:29:29 INFO - 'USER': 'cltbld', 06:29:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:29 INFO - '_': '/tools/buildbot/bin/python'} 06:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:29 INFO - Downloading/unpacking psutil>=3.1.1 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:29:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:31 INFO - Installing collected packages: psutil 06:29:31 INFO - Running setup.py install for psutil 06:29:31 INFO - building 'psutil._psutil_linux' extension 06:29:31 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 06:29:31 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 06:29:31 INFO - building 'psutil._psutil_posix' extension 06:29:31 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 06:29:31 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 06:29:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:31 INFO - Successfully installed psutil 06:29:31 INFO - Cleaning up... 06:29:31 INFO - Return code: 0 06:29:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:29:31 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')]} 06:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:31 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')]} 06:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:31 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:31 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 06:29:31 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 06:29:31 INFO - Using env: {'DISPLAY': ':0', 06:29:31 INFO - 'HOME': '/home/cltbld', 06:29:31 INFO - 'LANG': 'en_US.UTF-8', 06:29:31 INFO - 'LANGUAGE': 'en_US:en', 06:29:31 INFO - 'LOGNAME': 'cltbld', 06:29:31 INFO - 'MAIL': '/var/mail/cltbld', 06:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:31 INFO - 'MOZ_NO_REMOTE': '1', 06:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:31 INFO - 'NO_EM_RESTART': '1', 06:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:31 INFO - 'PWD': '/builds/slave/test', 06:29:31 INFO - 'SHELL': '/bin/bash', 06:29:31 INFO - 'SHLVL': '1', 06:29:31 INFO - 'TERM': 'linux', 06:29:31 INFO - 'TMOUT': '86400', 06:29:31 INFO - 'USER': 'cltbld', 06:29:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:31 INFO - '_': '/tools/buildbot/bin/python'} 06:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:29:32 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 06:29:32 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 06:29:32 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 06:29:32 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 06:29:32 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 06:29:32 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 06:29:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:29:34 INFO - Installing collected packages: mozsystemmonitor 06:29:34 INFO - Running setup.py install for mozsystemmonitor 06:29:34 INFO - Successfully installed mozsystemmonitor 06:29:34 INFO - Cleaning up... 06:29:34 INFO - Return code: 0 06:29:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:29:34 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')]} 06:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:34 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')]} 06:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:34 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:34 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 06:29:34 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 06:29:34 INFO - Using env: {'DISPLAY': ':0', 06:29:34 INFO - 'HOME': '/home/cltbld', 06:29:34 INFO - 'LANG': 'en_US.UTF-8', 06:29:34 INFO - 'LANGUAGE': 'en_US:en', 06:29:34 INFO - 'LOGNAME': 'cltbld', 06:29:34 INFO - 'MAIL': '/var/mail/cltbld', 06:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:34 INFO - 'MOZ_NO_REMOTE': '1', 06:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:34 INFO - 'NO_EM_RESTART': '1', 06:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:34 INFO - 'PWD': '/builds/slave/test', 06:29:34 INFO - 'SHELL': '/bin/bash', 06:29:34 INFO - 'SHLVL': '1', 06:29:34 INFO - 'TERM': 'linux', 06:29:34 INFO - 'TMOUT': '86400', 06:29:34 INFO - 'USER': 'cltbld', 06:29:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:34 INFO - '_': '/tools/buildbot/bin/python'} 06:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:29:34 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 06:29:34 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 06:29:34 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 06:29:34 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 06:29:34 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 06:29:34 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 06:29:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:29:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:29:36 INFO - warning: no files found matching '*.txt' 06:29:36 INFO - no previously-included directories found matching 'build' 06:29:36 INFO - no previously-included directories found matching 'dist' 06:29:36 INFO - no previously-included directories found matching '.git*' 06:29:36 INFO - Installing collected packages: jsonschema, functools32 06:29:36 INFO - Running setup.py install for functools32 06:29:36 INFO - warning: no files found matching '*.txt' 06:29:36 INFO - no previously-included directories found matching 'build' 06:29:36 INFO - no previously-included directories found matching 'dist' 06:29:36 INFO - no previously-included directories found matching '.git*' 06:29:36 INFO - Successfully installed jsonschema functools32 06:29:36 INFO - Cleaning up... 06:29:36 INFO - Return code: 0 06:29:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:29:36 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')]} 06:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:36 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')]} 06:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:36 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:36 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 06:29:36 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 06:29:36 INFO - Using env: {'DISPLAY': ':0', 06:29:36 INFO - 'HOME': '/home/cltbld', 06:29:36 INFO - 'LANG': 'en_US.UTF-8', 06:29:36 INFO - 'LANGUAGE': 'en_US:en', 06:29:36 INFO - 'LOGNAME': 'cltbld', 06:29:36 INFO - 'MAIL': '/var/mail/cltbld', 06:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:36 INFO - 'MOZ_NO_REMOTE': '1', 06:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:36 INFO - 'NO_EM_RESTART': '1', 06:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:36 INFO - 'PWD': '/builds/slave/test', 06:29:36 INFO - 'SHELL': '/bin/bash', 06:29:36 INFO - 'SHLVL': '1', 06:29:36 INFO - 'TERM': 'linux', 06:29:36 INFO - 'TMOUT': '86400', 06:29:36 INFO - 'USER': 'cltbld', 06:29:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:36 INFO - '_': '/tools/buildbot/bin/python'} 06:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:29:37 INFO - Cleaning up... 06:29:37 INFO - Return code: 0 06:29:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:29:37 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')]} 06:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:37 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')]} 06:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:37 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:37 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 06:29:37 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 06:29:37 INFO - Using env: {'DISPLAY': ':0', 06:29:37 INFO - 'HOME': '/home/cltbld', 06:29:37 INFO - 'LANG': 'en_US.UTF-8', 06:29:37 INFO - 'LANGUAGE': 'en_US:en', 06:29:37 INFO - 'LOGNAME': 'cltbld', 06:29:37 INFO - 'MAIL': '/var/mail/cltbld', 06:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:37 INFO - 'MOZ_NO_REMOTE': '1', 06:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:37 INFO - 'NO_EM_RESTART': '1', 06:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:37 INFO - 'PWD': '/builds/slave/test', 06:29:37 INFO - 'SHELL': '/bin/bash', 06:29:37 INFO - 'SHLVL': '1', 06:29:37 INFO - 'TERM': 'linux', 06:29:37 INFO - 'TMOUT': '86400', 06:29:37 INFO - 'USER': 'cltbld', 06:29:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:37 INFO - '_': '/tools/buildbot/bin/python'} 06:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:29:37 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 06:29:37 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 06:29:37 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 06:29:37 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 06:29:37 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 06:29:37 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 06:29:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:29:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:29:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 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 06:29:39 INFO - Downloading docopt-0.6.1.tar.gz 06:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:29:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:29:40 INFO - Running setup.py install for blobuploader 06:29:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:29:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:29:40 INFO - Running setup.py install for requests 06:29:40 INFO - Running setup.py install for docopt 06:29:40 INFO - Successfully installed blobuploader requests docopt 06:29:40 INFO - Cleaning up... 06:29:40 INFO - Return code: 0 06:29:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:40 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')]} 06:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:40 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')]} 06:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:40 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:40 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 06:29:40 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 06:29:40 INFO - Using env: {'DISPLAY': ':0', 06:29:40 INFO - 'HOME': '/home/cltbld', 06:29:40 INFO - 'LANG': 'en_US.UTF-8', 06:29:40 INFO - 'LANGUAGE': 'en_US:en', 06:29:40 INFO - 'LOGNAME': 'cltbld', 06:29:40 INFO - 'MAIL': '/var/mail/cltbld', 06:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:40 INFO - 'MOZ_NO_REMOTE': '1', 06:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:40 INFO - 'NO_EM_RESTART': '1', 06:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:40 INFO - 'PWD': '/builds/slave/test', 06:29:40 INFO - 'SHELL': '/bin/bash', 06:29:40 INFO - 'SHLVL': '1', 06:29:40 INFO - 'TERM': 'linux', 06:29:40 INFO - 'TMOUT': '86400', 06:29:40 INFO - 'USER': 'cltbld', 06:29:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:40 INFO - '_': '/tools/buildbot/bin/python'} 06:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:40 INFO - Running setup.py (path:/tmp/pip-JnFA_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:40 INFO - Running setup.py (path:/tmp/pip-1ekKDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:41 INFO - Running setup.py (path:/tmp/pip-gWKmbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:41 INFO - Running setup.py (path:/tmp/pip-aeUFtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:41 INFO - Running setup.py (path:/tmp/pip-kS4tIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:41 INFO - Running setup.py (path:/tmp/pip-VhdnAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:41 INFO - Running setup.py (path:/tmp/pip-e2VmKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:41 INFO - Running setup.py (path:/tmp/pip-Fx0ExT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:41 INFO - Running setup.py (path:/tmp/pip-sjtczk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:41 INFO - Running setup.py (path:/tmp/pip-hS2w4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:41 INFO - Running setup.py (path:/tmp/pip-PutoPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:41 INFO - Running setup.py (path:/tmp/pip-a_mh6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:41 INFO - Running setup.py (path:/tmp/pip-2M2hbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:41 INFO - Running setup.py (path:/tmp/pip-MnPU3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:41 INFO - Running setup.py (path:/tmp/pip-PGX0ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:41 INFO - Running setup.py (path:/tmp/pip-hlVpXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:42 INFO - Running setup.py (path:/tmp/pip-_ixUDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:29:42 INFO - Running setup.py install for manifestparser 06:29:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozcrash 06:29:42 INFO - Running setup.py install for mozdebug 06:29:42 INFO - Running setup.py install for mozdevice 06:29:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozfile 06:29:42 INFO - Running setup.py install for mozhttpd 06:29:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozinfo 06:29:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozInstall 06:29:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozleak 06:29:42 INFO - Running setup.py install for mozlog 06:29:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Running setup.py install for moznetwork 06:29:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Running setup.py install for mozprocess 06:29:43 INFO - Running setup.py install for mozprofile 06:29:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Running setup.py install for mozrunner 06:29:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Running setup.py install for mozscreenshot 06:29:43 INFO - Running setup.py install for moztest 06:29:43 INFO - Running setup.py install for mozversion 06:29:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:43 INFO - Cleaning up... 06:29:43 INFO - Return code: 0 06:29:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:43 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')]} 06:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:43 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')]} 06:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:43 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:43 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 06:29:43 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 06:29:43 INFO - Using env: {'DISPLAY': ':0', 06:29:43 INFO - 'HOME': '/home/cltbld', 06:29:43 INFO - 'LANG': 'en_US.UTF-8', 06:29:43 INFO - 'LANGUAGE': 'en_US:en', 06:29:43 INFO - 'LOGNAME': 'cltbld', 06:29:43 INFO - 'MAIL': '/var/mail/cltbld', 06:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:43 INFO - 'MOZ_NO_REMOTE': '1', 06:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:43 INFO - 'NO_EM_RESTART': '1', 06:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:43 INFO - 'PWD': '/builds/slave/test', 06:29:43 INFO - 'SHELL': '/bin/bash', 06:29:43 INFO - 'SHLVL': '1', 06:29:43 INFO - 'TERM': 'linux', 06:29:43 INFO - 'TMOUT': '86400', 06:29:43 INFO - 'USER': 'cltbld', 06:29:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:43 INFO - '_': '/tools/buildbot/bin/python'} 06:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:44 INFO - Running setup.py (path:/tmp/pip-XeVsTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:44 INFO - Running setup.py (path:/tmp/pip-MxUbGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:44 INFO - Running setup.py (path:/tmp/pip-LyyG1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:44 INFO - Running setup.py (path:/tmp/pip-0YRrKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:44 INFO - Running setup.py (path:/tmp/pip-w8E00G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:44 INFO - Running setup.py (path:/tmp/pip-Y3lCLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:44 INFO - Running setup.py (path:/tmp/pip-QE08vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:44 INFO - Running setup.py (path:/tmp/pip-OuGHKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:44 INFO - Running setup.py (path:/tmp/pip-PqyYYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:44 INFO - Running setup.py (path:/tmp/pip-QTwehS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:44 INFO - Running setup.py (path:/tmp/pip-90TH6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:44 INFO - Running setup.py (path:/tmp/pip-S8wFM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:44 INFO - Running setup.py (path:/tmp/pip-XN8952-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:45 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)) 06:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:45 INFO - Running setup.py (path:/tmp/pip-lHcky6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 06:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:45 INFO - Running setup.py (path:/tmp/pip-LstbzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:45 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)) 06:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:45 INFO - Running setup.py (path:/tmp/pip-wLPzGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:45 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)) 06:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:45 INFO - Running setup.py (path:/tmp/pip-mykbyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:45 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)) 06:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:45 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)) 06:29:45 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)) 06:29:45 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)) 06:29:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:45 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 06:29:45 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 06:29:45 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 06:29:45 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 06:29:45 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 06:29:45 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 06:29:47 INFO - Downloading blessings-1.6.tar.gz 06:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:29:47 INFO - Installing collected packages: blessings 06:29:47 INFO - Running setup.py install for blessings 06:29:47 INFO - Successfully installed blessings 06:29:47 INFO - Cleaning up... 06:29:47 INFO - Return code: 0 06:29:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:29:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:47 INFO - Reading from file tmpfile_stdout 06:29:47 INFO - Current package versions: 06:29:47 INFO - argparse == 1.2.1 06:29:47 INFO - blessings == 1.6 06:29:47 INFO - blobuploader == 1.2.4 06:29:47 INFO - docopt == 0.6.1 06:29:47 INFO - functools32 == 3.2.3-2 06:29:47 INFO - jsonschema == 2.5.1 06:29:47 INFO - manifestparser == 1.1 06:29:47 INFO - mozInstall == 1.12 06:29:47 INFO - mozcrash == 1.0 06:29:47 INFO - mozdebug == 0.1 06:29:47 INFO - mozdevice == 0.48 06:29:47 INFO - mozfile == 1.2 06:29:47 INFO - mozhttpd == 0.7 06:29:47 INFO - mozinfo == 0.9 06:29:47 INFO - mozleak == 0.1 06:29:47 INFO - mozlog == 3.4 06:29:47 INFO - moznetwork == 0.27 06:29:47 INFO - mozprocess == 0.23 06:29:47 INFO - mozprofile == 0.28 06:29:47 INFO - mozrunner == 6.13 06:29:47 INFO - mozscreenshot == 0.1 06:29:47 INFO - mozsystemmonitor == 0.3 06:29:47 INFO - moztest == 0.7 06:29:47 INFO - mozversion == 1.4 06:29:47 INFO - psutil == 3.1.1 06:29:47 INFO - requests == 1.2.3 06:29:47 INFO - wsgiref == 0.1.2 06:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:47 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')]} 06:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:47 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')]} 06:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:47 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:47 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 06:29:47 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 06:29:47 INFO - Using env: {'DISPLAY': ':0', 06:29:47 INFO - 'HOME': '/home/cltbld', 06:29:47 INFO - 'LANG': 'en_US.UTF-8', 06:29:47 INFO - 'LANGUAGE': 'en_US:en', 06:29:47 INFO - 'LOGNAME': 'cltbld', 06:29:47 INFO - 'MAIL': '/var/mail/cltbld', 06:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:47 INFO - 'MOZ_NO_REMOTE': '1', 06:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:47 INFO - 'NO_EM_RESTART': '1', 06:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:47 INFO - 'PWD': '/builds/slave/test', 06:29:47 INFO - 'SHELL': '/bin/bash', 06:29:47 INFO - 'SHLVL': '1', 06:29:47 INFO - 'TERM': 'linux', 06:29:47 INFO - 'TMOUT': '86400', 06:29:47 INFO - 'USER': 'cltbld', 06:29:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:47 INFO - '_': '/tools/buildbot/bin/python'} 06:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 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)) 06:29:47 INFO - Cleaning up... 06:29:47 INFO - Return code: 0 06:29:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:29:47 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')]} 06:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:47 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')]} 06:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:48 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 0x7f5d82337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', '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 06:29:48 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 06:29:48 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 06:29:48 INFO - Using env: {'DISPLAY': ':0', 06:29:48 INFO - 'HOME': '/home/cltbld', 06:29:48 INFO - 'LANG': 'en_US.UTF-8', 06:29:48 INFO - 'LANGUAGE': 'en_US:en', 06:29:48 INFO - 'LOGNAME': 'cltbld', 06:29:48 INFO - 'MAIL': '/var/mail/cltbld', 06:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:48 INFO - 'MOZ_NO_REMOTE': '1', 06:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:48 INFO - 'NO_EM_RESTART': '1', 06:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:48 INFO - 'PWD': '/builds/slave/test', 06:29:48 INFO - 'SHELL': '/bin/bash', 06:29:48 INFO - 'SHLVL': '1', 06:29:48 INFO - 'TERM': 'linux', 06:29:48 INFO - 'TMOUT': '86400', 06:29:48 INFO - 'USER': 'cltbld', 06:29:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:48 INFO - '_': '/tools/buildbot/bin/python'} 06:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:29:48 INFO - Cleaning up... 06:29:48 INFO - Return code: 0 06:29:48 INFO - Running post-action listener: _resource_record_post_action 06:29:48 INFO - Running post-action listener: _start_resource_monitoring 06:29:48 INFO - Starting resource monitoring. 06:29:48 INFO - [mozharness: 2016-11-15 14:29:48.253464Z] Finished create-virtualenv step (success) 06:29:48 INFO - [mozharness: 2016-11-15 14:29:48.253923Z] Running install step. 06:29:48 INFO - Running pre-action listener: _resource_record_pre_action 06:29:48 INFO - Running main action method: install 06:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:48 INFO - Reading from file tmpfile_stdout 06:29:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:29:48 INFO - Reading from file tmpfile_stdout 06:29:48 INFO - Output received: 06:29:48 INFO - Usage: mozinstall [options] installer 06:29:48 INFO - Options: 06:29:48 INFO - -h, --help show this help message and exit 06:29:48 INFO - -d DEST, --destination=DEST 06:29:48 INFO - Directory to install application into. [default: 06:29:48 INFO - "/builds/slave/test"] 06:29:48 INFO - --app=APP Application being installed. [default: firefox] 06:29:48 INFO - mkdir: /builds/slave/test/build/application 06:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:30:04 INFO - Reading from file tmpfile_stdout 06:30:04 INFO - Output received: 06:30:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:30:04 INFO - Running post-action listener: _resource_record_post_action 06:30:04 INFO - [mozharness: 2016-11-15 14:30:04.615083Z] Finished install step (success) 06:30:04 INFO - [mozharness: 2016-11-15 14:30:04.615329Z] Running run-tests step. 06:30:04 INFO - Running pre-action listener: _resource_record_pre_action 06:30:04 INFO - Running main action method: run_tests 06:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:30:04 INFO - Python 2.7.3 06:30:04 INFO - Return code: 0 06:30:04 INFO - grabbing minidump binary from tooltool 06:30:04 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')]} 06:30:04 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 0x2ab8f60>, '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 0x2ab9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aba1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:30:04 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 06:30:04 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 06:30:04 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 06:30:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:30:04 INFO - Return code: 0 06:30:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:30:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:30:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:30:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:30:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:30:04 INFO - Using env: {'DISPLAY': ':0', 06:30:04 INFO - 'HOME': '/home/cltbld', 06:30:04 INFO - 'LANG': 'en_US.UTF-8', 06:30:04 INFO - 'LANGUAGE': 'en_US:en', 06:30:04 INFO - 'LOGNAME': 'cltbld', 06:30:04 INFO - 'MAIL': '/var/mail/cltbld', 06:30:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:30:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:04 INFO - 'MOZ_NO_REMOTE': '1', 06:30:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:04 INFO - 'NO_EM_RESTART': '1', 06:30:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:04 INFO - 'PWD': '/builds/slave/test', 06:30:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:30:04 INFO - 'SHELL': '/bin/bash', 06:30:04 INFO - 'SHLVL': '1', 06:30:04 INFO - 'TERM': 'linux', 06:30:04 INFO - 'TMOUT': '86400', 06:30:04 INFO - 'USER': 'cltbld', 06:30:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657', 06:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:04 INFO - '_': '/tools/buildbot/bin/python'} 06:30:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:30:04 INFO - mozversion application_buildid: 20161115050514 06:30:04 INFO - mozversion application_changeset: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 06:30:04 INFO - mozversion application_display_name: Nightly 06:30:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:30:04 INFO - mozversion application_name: Firefox 06:30:04 INFO - mozversion application_remotingname: firefox 06:30:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:30:04 INFO - mozversion application_vendor: Mozilla 06:30:04 INFO - mozversion application_version: 53.0a1 06:30:04 INFO - mozversion platform_buildid: 20161115050514 06:30:04 INFO - mozversion platform_changeset: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 06:30:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:30:04 INFO - mozversion platform_version: 53.0a1 06:30:04 INFO - using testdate: 1479220204 06:30:04 INFO - actual date: 1479220204 06:30:04 INFO - starting webserver on 'localhost:52626' 06:30:04 INFO - SUITE-START | Running 2 tests 06:30:04 INFO - TEST-START | dromaeo_css 06:30:04 INFO - operating with platform_type : linux_ 06:30:04 INFO - Initialising browser for dromaeo_css test... 06:30:04 INFO - TEST-INFO | started process 19470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLdwITK/profile http://localhost:52626/getInfo.html) 06:30:10 INFO - PROCESS | 19470 | __metrics Screen width/height:1600/1200 06:30:10 INFO - PROCESS | 19470 | colorDepth:24 06:30:10 INFO - PROCESS | 19470 | Browser inner width/height: 1024/697 06:30:10 INFO - PROCESS | 19470 | __metrics 06:30:10 ERROR - PROCESS | 19470 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 06:30:11 INFO - TEST-INFO | 19470: exit 0 06:30:11 INFO - Browser initialized. 06:30:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:11 INFO - TEST-INFO | started process 19593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLdwITK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:24 INFO - PROCESS | 19593 | RSS: Main: 186720256 06:30:24 INFO - PROCESS | 19593 | 06:31:13 INFO - PROCESS | 19593 | 1479220273662 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] 06:33:29 INFO - PROCESS | 19593 | Cycle 1(1): loaded http://localhost:52626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52626/tests/dromaeo/cssquery-ext.html) 06:33:31 INFO - PROCESS | 19593 | RSS: Main: 196567040 06:33:31 INFO - PROCESS | 19593 | 06:36:33 INFO - PROCESS | 19593 | Cycle 1(1): loaded http://localhost:52626/tests/dromaeo/cssquery-ext.html (next: http://localhost:52626/tests/dromaeo/cssquery-jquery.html) 06:36:34 INFO - PROCESS | 19593 | RSS: Main: 196628480 06:36:34 INFO - PROCESS | 19593 | 06:39:36 INFO - PROCESS | 19593 | Cycle 1(1): loaded http://localhost:52626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52626/tests/dromaeo/cssquery-mootools.html) 06:39:36 INFO - PROCESS | 19593 | RSS: Main: 198148096 06:39:36 INFO - PROCESS | 19593 | 06:42:39 INFO - PROCESS | 19593 | Cycle 1(1): loaded http://localhost:52626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52626/tests/dromaeo/cssquery-prototype.html) 06:42:39 INFO - PROCESS | 19593 | RSS: Main: 195133440 06:42:39 INFO - PROCESS | 19593 | 06:45:42 INFO - PROCESS | 19593 | Cycle 1(1): loaded http://localhost:52626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52626/tests/dromaeo/cssquery-yui.html) 06:45:43 INFO - PROCESS | 19593 | RSS: Main: 198201344 06:45:43 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | Cycle 1(1): loaded http://localhost:52626/tests/dromaeo/cssquery-yui.html (next: http://localhost:52626/tests/dromaeo/cssquery-dojo.html) 06:48:46 INFO - PROCESS | 19593 | RSS: Main: 198111232 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | __start_tp_report 06:48:46 INFO - PROCESS | 19593 | _x_x_mozilla_page_load 06:48:46 INFO - PROCESS | 19593 | _x_x_mozilla_page_load_details 06:48:46 INFO - PROCESS | 19593 | |i|pagename|runs| 06:48:46 INFO - PROCESS | 19593 | |0;dojo.html;2627.934301642459;2636.433166869123;2638.4591158812445;2654.7876169906403;2671.10517976478;4674.182018146819;4750.168720473916;4765.785539650716;4794.448638406584;4800.3279540864305;4728.739919304446;4736.431628204612;4792.400949881265;4794.472608013116;4794.736289504076;4310.56894310568;4415.845445409412;4436.511983681792;4478.193925093482;4556.84051058213;4466.553344665524;4473.709208901411;4517.2772356422975;4575.656825738066;4580.038191979688;4431.933520997188;4467.173572889026;4524.389207457;4530.592246697796;4557.931631025537;4287.078278170177;4350.216960947028;4351.0645211279725;4399.428074350346;4409.338599210112;4302.311630139194;4339.741474972254;4351.673624478145;4398.098389830077;4428.778561071934;4711.905761884743;4750.311204875274;4757.762111894392;4766.022965292107;4766.285057241442;5121.487851214886;5154.381474223117;5155.974220128913;5179.14544100223;5181.585473162176;5126.666766660155;5135.101357262464;5138.845834624967;5176.55999240065;5228.8692782680355;4784.091022705675;4808.471068182497;4837.2260438329695;4841.3222148899185;4848.00615873745;5024.371953505812;5292.735363231823;5296.973515132477;5300.787968481218;5303.0454518186325;4874.7562621868765;4888.462269150391;4906.362172917497;4908.165611845995;4989.077020751172;5001.7499125043605;5013.548780609763;5031.698098114051;5035.723035233024;5083;4997.550220480174;5035.79856805731;5059.747012649353;5075.5178258065425;5085.516875896784;5089.05852417304;5106.055379754757;5107.668001579886;5108.259302401206;5148.9485105149215;4232.153569286155;4274.487061552633;4281.550437204049;4286.935695964563;4330;3778.319902417591;3818.3317919364;3838.654521093115;3890.8054597270025;3942.1918506706056;4510.932336014962;4517.186906356887;4518.661100417482;4533.727976321431;4552.408186935677;5226.3205783248695;5245.947540524622;5249.973750131225;5250.921236181461;5288.735563221823;4333.220020396296;4381.715188512737;4385.3641222022625;4436.134953684065;4489.506154323022;4665.790039448233;4715.811367545329;4726.031163611451;4744.810207591658;4778.737169455644;4865.610751139971;4870.12337779189;4874.147024270809;4877.292792545132;4898.9957058803575;4864.878378040436;5223.738813059256;5224.660397074178;5231.633785634969;5287.550558202596;4623.237165867594;4629.213033784332;4705.0589882024415;4705.788239529298;4708.952910470852;4914.803407863788;4952.57903078228;4990.525900039491;5064.240363945438;5076.11168045598;5179.326687530597;5179.559737422211;5184.377874655065;5195;5224.6342756008235;5016.924746128738;5045.545900868792;5062;5062.82280120194;5082.2122571001555;4808.182608956416;4886.144924638245;4919.237518184687;4971.502849715;5033.622478314068;4805.495422980537;4839.782209800497;4866.829660961849;4877.512248775236;4888.413390393175;4955.1576232039915;5028.874278143076;5038.370203724535;5070.188769796815;5101.7704203310195;4741.881452963704;4925.45819959797;4939.604831613534;4941.827036053721;4980.626453016111 06:48:46 INFO - PROCESS | 19593 | |1;ext.html;529.4387948774302;537.3632245788741;540.8512659018769;548.3803302268437;565.7567246084183;37610;38735.61264387355;38868.222635547274;38905.22189556207;42812.571874281246;39154.8042259789;39683.40474892879;39701.60298397015;39729.205415891665;39746.621537169376;7515.887261691066;7691.9230807691765;7692.153863075086;7695.422843286776;7713.267239612228;7532.887006694904;7541.849163016736;7587.658555365022;7620.580868052255;7647.655855486489;7600.2779735925;7651.426143039266;7654.8469030619635;7665.540067595962;7668.07983042033;7562.546247225157;7619.6571154297635;7627.046619172604;7627.2372762723835;7642.808929776745;7577.696892124309;7636.465447418683;7638.159802421729;7645.235476452311;7646.502977306457;36288;36680.266394672224;36763.816180919195;36818;36880.63119368799;2979.0913771299747;3022.1084779989737;3022.637283525969;3270.1497610621172;3569.964300357015;26827.86586067077;27342;27927.022554210504;27942.301442463897;28105.3029248603;2919.737223649882;2927.8536073196256;3016;3043.117495926179;3200.199950012497;228332;228778;230483;231964;232470.9999999983;49959;50103.74948125309;50200;50266.246006309935;50472.74763626232;52192.47807521952;52379.47620523822;52563.73718131462;52626.73686631543;52694.209586856225;13360.866391335961;13385.933070334586;13390.531331403354;13408.798868016987;13623.591292261248;10534.051935325857;10689.518971646294;10693.732656683489;10703.411312377893;10720.303180293256;14182.290885455686;15432.768508472382;15511.844881551266;15566.922165389327;15770.369185232692;6058.757649694051;6190.783322583688;6296.937030629727;6302.968485157545;6358.904616430757;735.9926400736031;905.8686490458847;914.2092090341939;916.9403988740711;957.5834511987308;26492;26697.466050679268;26782.732172678414;26999.595006074924;27224.863875680494;880.3221519430003;888.595688961521;896.2426749396749;927.3230541704594;929.9907000929904;14030.579082627537;14411.351489183013;14493.768029717592;14670.33983470725;14737;325126;328630;328908;329945;331246;47425.28862067072;47444.76277618659;47556.28665570019;47728.52271477241;47730.76134619374;1052.3633201912733;1093.7429704019548;1158.3339579741682;1174.8061569841052;1186.5550418593027;24444.022239110236;25239.242822715347;26449.735502644726;26875.193744187705;27024.32439189036;41203.58796411997;41380.37929431121;41399.169137092045;41426.79286603668;41455.79272103741;291271;293098.3627046619;294825.09511406464;295466;295673;33737.493937590465;34267.97196084121;34666;34754.652453475144;34986.82506587451;38810;39121.7465403567;39690.60309396869;40009.399859001554;40363.798181008904;33772.831135844164;34046.148846279044;34225.65774342225;34270.828645856614;34339.82830085834;33820;34561.82719086489;34832.65167348395;34837.65162348445;34912.47631285482;33682.66317336795;33967.32065358728;34477.31045379129;34690.47964280487;34876.825615871756;30815;31986.840065799523;32059.839700801345;32115.197120072185;32191.839040804647;24138.39654008664;24282.75717242805;24415.633765493887;24805.255842324757;25171.87414062918 06:48:46 INFO - PROCESS | 19593 | |2;jquery.html;357.14463859057577;363.5038172894;375.0754390427596;376.3338890164407;389.5539607149814;15354.84645153548;16020.679586408265;16402.91798541007;16425.917870410645;16664;15452.22738863058;15563.144027078506;15888.602784930383;16091;16105.355785768585;4705.670603057796;5011.173156429185;5013.3482647255805;5017.59859211264;5033.295338652573;4835.298881662157;4900.117978763821;5198.350206224222;5224.399194092671;5255.947440525603;5226.503482169188;5233.1103712368795;5244.580433565325;5249.028929648028;5262.684238945656;5216.8174113906025;5228.843134705965;5403.13549832025;5444.455554444564;5456.890862182774;5257.737113144328;5260.263563101169;5266.97366513165;5269.077911365495;5270.578353731692;11038.944805276002;15558.299876505584;19735.21059157632;19821.10805013778;19838.504037399038;1912.1108684461792;2140.9250676226256;2187.84685072045;2294.2314324701247;2311.884405779704;8552.845365875652;8907.821843563092;9219.539023048821;9359.719208423758;9549.09283618055;1589.3165938646378;1697.7792886924744;1739.2173521915188;1749.571355018016;1788.937387191442;66071.33928660749;67845;68630;69165.65417172933;70922.29077709209;9700.660476883275;9842.60629574809;9856.45789481571;9957;10034.799304013879;13486.460541578226;13588.660283492794;13634.318284085755;13641.386137623831;13644.795328070088;7019.122609673791;7041.135314841402;7130.750423735144;7157.570545767167;7232.92767072333;6681.7327306908155;6883.65581720922;6954.3045695430055;7001.404880585207;7035.401990830836;4027.3153563894207;4115.609017143366;4133.524644665842;4355.629771469397;4390.429244198233;1463.8975271730876;1505.2398538737866;1750.824917508239;1817.690992531273;1846.642717602561;809.6761295481737;858.3648100405779;862.8058686795546;888.1695614600369;933.3606479561387;16077.517674469784;16555.420560280574;16608.83391166097;16720.41478548269;17020.914895425445;857.0743596915316;861.1947828780111;874.07784787049;876.2595606712318;896.1486587741541;9405.43567385959;9468.242540596735;9472.431654100776;9554.426734395958;9757.902420975699;333776;338875;339117;339644;340887;75027.62486187644;75327.62336188284;75349.24650753532;76013.61993189999;79317.60341198373;411.44044100023945;430.83197552954374;436.95848894355623;893.3924931046951;911.6945823149186;9486.797008685444;9914.256430767577;9996.450195239331;10199.337043092175;13922.930385348009;36206.637933620324;36604;37559.812200939916;40298;42548.36177457279;46221;49156;50991.49008510016;52523.73738131285;52558.73720631372;7092.25531319204;7129.322714342129;7364.447666424932;7501.88747168782;7677.654505547152;10128.44293563861;10538.315009524356;10608.575656973635;10614.203934705083;10982.505787239754;9206.355555111079;9479.668211612561;9512.476813775309;9683.51582420862;9821.5089245536;9192.586333615138;9241.260699143917;9374.343795934219;9508.381955172892;9515.571799268911;9191.632334706537;9335.953320233355;9429.952850235704;9574.808503830023;9670.887847897582;7416.480846340704;7430.294122058396;7478.401727861649;7505.399568034653;7509.6245187739305;8225.83548329042;9622.951885240529;9773.31586788918;10135;10452.738681533023 06:48:46 INFO - PROCESS | 19593 | |3;mootools.html;1313.2580092247877;1365.0581099041663;1421.786731990202;1607.0759313394801;1669.8330166983303;6226.097215903691;6434.002729576923;6726.461883049356;7222.205557388683;7230.963845180773;6704.832379190522;6917.827054323644;6919;7058.611776352299;7122.8575428491395;2047.2322878920404;2091.0903756865737;2092.8221101206414;2093.1313504895525;2095.3713885834263;2011.2256781139295;2035.2469586253108;2053.8151566359024;2064;2073.60601485718;2006.418138739771;2008.437637461513;2030.6344857925567;2031.8679285846372;2037.4193354893857;1959.1183967214738;1967.1147983407525;1973.842092632586;1975.664137096697;1977.5056235941086;1989.9900500497404;2002.8497862660213;2064.9277275295294;2073.6785798201154;2075.9273425430038;7100.5384649998105;7128.893066604005;7159.284071592851;7237.276272372773;7243.239459856692;4154.979225103855;4216.241076606209;4260.318349064135;4269.829206831723;4273.529911709709;2592.5592649249675;2766.833989960609;2767.8200916940536;2783.3459137102764;2814.408974115438;779.380392587894;804.7505273365217;834.7954751086023;840.4075127035426;843.304273973974;8878.067802880669;9146.451212927246;9188.26493880488;9372.437653740797;9487.620495180185;3550.232217061843;3561.732870034758;3591.964080359215;3648.416253399443;3649.1424515238896;7617.809554761065;7631.3513351365755;7632.809179770439;7640.694372225049;7647.923520764721;4177.5195852476745;4178.895527611834;4181.289180839264;4187;4187.392828039917;3349.0790032741193;3457.6023757267735;3662;3838.9808050960123;3893.6301051400073;2943.8528073596663;3043.284828065403;3113.128324069264;3116.0340294508774;3131.4363414585137;923.8060007398522;933.1135421349745;939.2110627073155;940.022376728195;940.1679513630486;623.3890787028737;626.6083697688945;720.1466262478979;744.2520267131498;758.8671982403057;4633.119707255611;4739.810407583727;4973.303737476756;5021.648484606116;5077.873053173626;338.25921232501236;339.96430374810785;340.6440269917942;343.048041684328;345.3179969560149;3202.3595280943437;3558.590762062396;3565.7519868045974;3617.27654469102;3707.3141468828353;8176.591170441454;8535.786605334792;8580.914190858137;8595.914040859636;8605;8358.916410835935;8365.665373384996;8451.873221901677;8506.362022848187;8508.446950948168;6435.935640643534;6684.565503242274;6717.529772915849;6718.932810671929;6756.662166891636;4761.952370478489;4896.510348965217;4942.777575009061;4988.6757360771435;5055.87360315995;7641.2740789624895;7857.607119644109;7906.367490600853;7925.167857374892;7929.643166057426;7773.961130194313;7798.727044553413;7802.687892484237;7897.565633890191;7916.525008499509;5548.861278468071;6175.5677102602385;6295.307516173309;6300.873982520416;6315.810525684236;6101.054336577838;6458.354164583504;6602.910519764185;6656.7004484797335;6774.42417394527;6039.214902062704;6170.629762214281;6208.068789681584;6214.658193799203;6240.53196010292;5964.433378829004;5975.880482390415;5984.850378740392;5993.220881285405;6042.969785151222;5627.296587926509;5661.575381846295;5700.030994730822;5707;5708.942910571007;4122.134351786159;4122.515894277997;4215.367694845675;4277.2087163874785;4417.77911104437;4194.5386007539755;4258.446401967724;4277.294246449301;4339.674524410745;4424.026714122888 06:48:46 INFO - PROCESS | 19593 | |4;prototype.html;285.665771047874;295.7072498226755;297.98957036503725;301.00667796272296;303.70843989769816;4797.952020479803;4883.997560999991;4928.778204980776;4968.975155124223;4987.700737955721;4765.309030190629;4887.242477415997;4910.680805747624;4928.31003659487;4930.137225985447;3858.266929283427;3864.516935383077;3876.379779235309;3877.3990031545154;3903.843846246161;3630.2920930418577;3846.6922646188236;3868.825902834379;3880.844766209348;3892.6885849132145;3752.662260396564;3809.466674665549;3815.9427608585893;3821.3694740367946;3823.751456155341;3798.810059497014;3802.16352402471;3807.200487897517;3807.4098514730263;3815.465834783133;3339.716124129452;3340.799552026886;3356.9160770980675;3372.898813035613;3373.814440205788;4721.881952951169;4768.570828625406;4832.154372984749;4844.781984810692;4903.950960490385;4317.15815415994;4332.696711230215;4334.198173337911;4335.869923902288;4347.3696314034605;5111.488851114858;5177.404598471187;5184.118699821001;5202.297689811865;5202.68783872965;3533.2580158166816;3595.1910820065277;3619.2037751694584;3626.5829429615405;3631.9830447474487;5327.866803329948;5342.652727572696;5364.405848081834;5371.623986320959;5396.244525766396;3691.8338674759702;3697.4268988306853;3727.986887081;3732.402815549499;3741.719371047128;3777.508923839883;3786.3563194257044;3791.563970143469;3792.8482860685817;3813.103920578662;4059.3910913363234;4285.185814695198;4326.870193894189;4333.609975102256;4335.132973405269;5143.254228136974;5144.897102057937;5151.896962060738;5152.355955505562;5156.828550441452;1176.0591526778544;1194.4505527457293;1215.7446936143333;1243.608263397027;1271.9809202861964;834.3742193354984;858.6694122762657;859.4198915731856;866.445474896067;867.5705525764787;4354.869353919387;4355.428548590189;4362.037083312522;4386.692931494828;4399.802008909607;5090.516400941905;5097.235414687752;5100.311457953128;5140.948590514122;5150.381954165524;4325.8269669213505;4335.574895832257;4343.457067866517;4360.825566977285;4363.759993200404;2615.764581187664;2677.4965407344193;2708.6456771614194;2718.9048383306886;2720.564709646447;4719.457262414798;4737.928931066037;4749.928751068736;4752.453467851241;4778;5037.29477873098;5215.400228973716;5218.399884013311;5220.425753167148;5227.3465816772905;4736.715797052188;4754.7147171169845;4759.785809638574;4795.976020119877;4800.927986080212;5104.668196567211;5111.524163568809;5129.8717532062;5138.557166698396;5154.742262886915;4732.384789977418;4996.550310472075;5006.449290577961;5015.548600625962;5046.1926091825135;4708.482066972699;4723.149833030087;4723.480417154042;4730.645201609962;4755.215389460838;3576.7496275260482;3580.283943211316;3589.335972845032;3628.63713628635;3637.3270944875285;5098.439171691185;5178.792848286177;5193.584513239008;5205.921911171411;5206.921896171485;4984.825531106394;5178.171492561172;5212.765425555935;5213.218017297436;5222.336608329703;5215.921761173661;5219.791208351623;5224.451432599674;5227.137522308929;5283.630145889751;4868.95131048685;5142.354446577209;5166.173412254021;5168.689878607295;5198.506141916512;5180.611454140879;5239.266502689703;5256.342957130359;5261.89476210466;5267;5149.639525233198;5150.97424512875;5159.406668233201;5191.351081114861;5193.584513239008 06:48:46 INFO - PROCESS | 19593 | |5;yui.html;625.7934881489109;632.4434497642075;663.2869665110007;692.6363659078983;726.912770467544;11899.52401903924;12363.567275145371;12690;12704.17422867513;12845.036622253345;12096.274223546594;12210.633680989562;12218.877811221884;12220.266783992967;12232.20490668106;614.5820841827556;761.862864684358;776.7087342246657;777.1296148313896;777.7355699062317;626.0827887145331;739.4675833399943;754.7697952124599;762.8092976755811;772.5905270206771;800.3317230112863;803.3854101612271;805.3879051920553;805.4885147931047;805.963731632078;794.5629903553051;800.2837460472903;800.3437181511134;800.6437135474716;800.8558459477292;582.8863371642532;586.1325238646826;586.3725813379685;586.5542187937156;586.560079940045;12161.20952138117;12509.874901251053;12637.368131593383;12667.36663166838;12691.04817138709;12281.754364912742;12528.937355313255;12620.81068783969;12715.173513721578;13153.40809663558;9742.659006934724;9764.609415623367;9799.069088436587;9859.26055545837;10104.494775261208;3214.7106760391443;3258.0551640024364;3272.8527216275324;3285.671432856719;3301.504774283853;48708.51291487075;49178.508214917754;49684;49685.50314496845;50142.49857501415;9485.146336829719;9785.706428807147;9810.901890981142;9863;9947.20422366209;16512.504624861274;16730.330786768638;16742;16810.411635592696;17019.914900425418;6463;6465.256495502983;6492.707828147744;6511.088447617242;6737.157855268091;3567.1973805893467;3576.0523461282783;3591.8204089795404;3603;3648.7263455240964;2780.471710375022;2848.686644469107;2851.7290857368516;2879.97120028797;2930.120963710878;485.5314621390375;489.8971216044599;496.53077841439494;500.33705340424086;509.69927742632024;476.24752890433035;518.9377274726982;580.1761498671812;581.1689284323373;630.4420587779848;7351.301626345488;7357.742479013209;7500.249975002565;7568.810779730551;7788.260115289038;557.2838902010897;563.2508763344823;574.5949105880344;577.5523968924033;588.520355909932;3442.2599141184264;3599.874004409833;3605.639436056426;3761.022134245116;3830.8276127574327;67931.3206867935;68803.65598171977;69427.3057269431;71941.6402917982;71974.64012679903;38761.80619096886;43475.56524434715;58604;59123.40876591265;60327;54731.72634136804;55522.44477555253;55807.44192558023;55962.44037559654;59050.40949590449;7077.327653872874;7173.210946795744;7331.74338898136;7346.155192152971;7443.55338679681;37428.43857342088;37802.810985944896;37836.24327513379;38863.61136388713;39674.60325396709;45633.771831140635;50674;52863;53459.19811202913;53739.73130134324;9060.90939090627;9294.767630809283;9403.576839042396;9519;9523.428594284365;10033.14718248957;10103.49482525856;10114.848277275994;10177.84733229017;10211.642592509226;9299.953500232727;9914;9924;9978.950105249427;10017.449040302561;9882.802343953224;10061.14480269156;10187.235957303084;10286.537105830106;10869.402182880018;9201.723948281562;9342.439453632804;9590.760230994281;9867.703968880945;10049.14582260516;7917.327027202752;7944.126146123806;8030.919690803017;8077;8224.876626850722;7891;7998.720044798404;8032.357411407191;8160.714374996846;8503.957480212806 06:48:46 INFO - PROCESS | 19593 | __end_tp_report 06:48:46 INFO - PROCESS | 19593 | __start_cc_report 06:48:46 INFO - PROCESS | 19593 | _x_x_mozilla_cycle_collect,359 06:48:46 INFO - PROCESS | 19593 | __end_cc_report 06:48:46 INFO - PROCESS | 19593 | __startTimestamp1479221326273__endTimestamp 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | ------- Summary: start ------- 06:48:46 INFO - PROCESS | 19593 | Number of tests: 6 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | [#0] dojo.html Cycles:165 Average:4737.60 Median:4841.32 stddev:496.30 (10.3%) stddev-sans-first:469.42 06:48:46 INFO - PROCESS | 19593 | Values: 2627.9 2636.4 2638.5 2654.8 2671.1 4674.2 4750.2 4765.8 4794.4 4800.3 4728.7 4736.4 4792.4 4794.5 4794.7 4310.6 4415.8 4436.5 4478.2 4556.8 4466.6 4473.7 4517.3 4575.7 4580.0 4431.9 4467.2 4524.4 4530.6 4557.9 4287.1 4350.2 4351.1 4399.4 4409.3 4302.3 4339.7 4351.7 4398.1 4428.8 4711.9 4750.3 4757.8 4766.0 4766.3 5121.5 5154.4 5156.0 5179.1 5181.6 5126.7 5135.1 5138.8 5176.6 5228.9 4784.1 4808.5 4837.2 4841.3 4848.0 5024.4 5292.7 5297.0 5300.8 5303.0 4874.8 4888.5 4906.4 4908.2 4989.1 5001.7 5013.5 5031.7 5035.7 5083.0 4997.6 5035.8 5059.7 5075.5 5085.5 5089.1 5106.1 5107.7 5108.3 5148.9 4232.2 4274.5 4281.6 4286.9 4330.0 3778.3 3818.3 3838.7 3890.8 3942.2 4510.9 4517.2 4518.7 4533.7 4552.4 5226.3 5245.9 5250.0 5250.9 5288.7 4333.2 4381.7 4385.4 4436.1 4489.5 4665.8 4715.8 4726.0 4744.8 4778.7 4865.6 4870.1 4874.1 4877.3 4899.0 4864.9 5223.7 5224.7 5231.6 5287.6 4623.2 4629.2 4705.1 4705.8 4709.0 4914.8 4952.6 4990.5 5064.2 5076.1 5179.3 5179.6 5184.4 5195.0 5224.6 5016.9 5045.5 5062.0 5062.8 5082.2 4808.2 4886.1 4919.2 4971.5 5033.6 4805.5 4839.8 4866.8 4877.5 4888.4 4955.2 5028.9 5038.4 5070.2 5101.8 4741.9 4925.5 4939.6 4941.8 4980.6 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | [#1] ext.html Cycles:180 Average:43957.91 Median:34857.24 stddev:75299.49 (216.0%) stddev-sans-first:75440.12 06:48:46 INFO - PROCESS | 19593 | Values: 529.4 537.4 540.9 548.4 565.8 37610.0 38735.6 38868.2 38905.2 42812.6 39154.8 39683.4 39701.6 39729.2 39746.6 7515.9 7691.9 7692.2 7695.4 7713.3 7532.9 7541.8 7587.7 7620.6 7647.7 7600.3 7651.4 7654.8 7665.5 7668.1 7562.5 7619.7 7627.0 7627.2 7642.8 7577.7 7636.5 7638.2 7645.2 7646.5 36288.0 36680.3 36763.8 36818.0 36880.6 2979.1 3022.1 3022.6 3270.1 3570.0 26827.9 27342.0 27927.0 27942.3 28105.3 2919.7 2927.9 3016.0 3043.1 3200.2 228332.0 228778.0 230483.0 231964.0 232471.0 49959.0 50103.7 50200.0 50266.2 50472.7 52192.5 52379.5 52563.7 52626.7 52694.2 13360.9 13385.9 13390.5 13408.8 13623.6 10534.1 10689.5 10693.7 10703.4 10720.3 14182.3 15432.8 15511.8 15566.9 15770.4 6058.8 6190.8 6296.9 6303.0 6358.9 736.0 905.9 914.2 916.9 957.6 26492.0 26697.5 26782.7 26999.6 27224.9 880.3 888.6 896.2 927.3 930.0 14030.6 14411.4 14493.8 14670.3 14737.0 325126.0 328630.0 328908.0 329945.0 331246.0 47425.3 47444.8 47556.3 47728.5 47730.8 1052.4 1093.7 1158.3 1174.8 1186.6 24444.0 25239.2 26449.7 26875.2 27024.3 41203.6 41380.4 41399.2 41426.8 41455.8 291271.0 293098.4 294825.1 295466.0 295673.0 33737.5 34268.0 34666.0 34754.7 34986.8 38810.0 39121.7 39690.6 40009.4 40363.8 33772.8 34046.1 34225.7 34270.8 34339.8 33820.0 34561.8 34832.7 34837.7 34912.5 33682.7 33967.3 34477.3 34690.5 34876.8 30815.0 31986.8 32059.8 32115.2 32191.8 24138.4 24282.8 24415.6 24805.3 25171.9 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | [#2] jquery.html Cycles:180 Average:22404.26 Median:28886.38 stddev:56318.40 (195.0%) stddev-sans-first:56452.06 06:48:46 INFO - PROCESS | 19593 | Values: 357.1 363.5 375.1 376.3 389.6 15354.8 16020.7 16402.9 16425.9 16664.0 15452.2 15563.1 15888.6 16091.0 16105.4 4705.7 5011.2 5013.3 5017.6 5033.3 4835.3 4900.1 5198.4 5224.4 5255.9 5226.5 5233.1 5244.6 5249.0 5262.7 5216.8 5228.8 5403.1 5444.5 5456.9 5257.7 5260.3 5267.0 5269.1 5270.6 11038.9 15558.3 19735.2 19821.1 19838.5 1912.1 2140.9 2187.8 2294.2 2311.9 8552.8 8907.8 9219.5 9359.7 9549.1 1589.3 1697.8 1739.2 1749.6 1788.9 66071.3 67845.0 68630.0 69165.7 70922.3 9700.7 9842.6 9856.5 9957.0 10034.8 13486.5 13588.7 13634.3 13641.4 13644.8 7019.1 7041.1 7130.8 7157.6 7232.9 6681.7 6883.7 6954.3 7001.4 7035.4 4027.3 4115.6 4133.5 4355.6 4390.4 1463.9 1505.2 1750.8 1817.7 1846.6 809.7 858.4 862.8 888.2 933.4 16077.5 16555.4 16608.8 16720.4 17020.9 857.1 861.2 874.1 876.3 896.1 9405.4 9468.2 9472.4 9554.4 9757.9 333776.0 338875.0 339117.0 339644.0 340887.0 75027.6 75327.6 75349.2 76013.6 79317.6 411.4 430.8 437.0 893.4 911.7 9486.8 9914.3 9996.5 10199.3 13922.9 36206.6 36604.0 37559.8 40298.0 42548.4 46221.0 49156.0 50991.5 52523.7 52558.7 7092.3 7129.3 7364.4 7501.9 7677.7 10128.4 10538.3 10608.6 10614.2 10982.5 9206.4 9479.7 9512.5 9683.5 9821.5 9192.6 9241.3 9374.3 9508.4 9515.6 9191.6 9336.0 9430.0 9574.8 9670.9 7416.5 7430.3 7478.4 7505.4 7509.6 8225.8 9623.0 9773.3 10135.0 10452.7 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | [#3] mootools.html Cycles:180 Average:4591.76 Median:5588.08 stddev:2524.54 (45.2%) stddev-sans-first:2519.60 06:48:46 INFO - PROCESS | 19593 | Values: 1313.3 1365.1 1421.8 1607.1 1669.8 6226.1 6434.0 6726.5 7222.2 7231.0 6704.8 6917.8 6919.0 7058.6 7122.9 2047.2 2091.1 2092.8 2093.1 2095.4 2011.2 2035.2 2053.8 2064.0 2073.6 2006.4 2008.4 2030.6 2031.9 2037.4 1959.1 1967.1 1973.8 1975.7 1977.5 1990.0 2002.8 2064.9 2073.7 2075.9 7100.5 7128.9 7159.3 7237.3 7243.2 4155.0 4216.2 4260.3 4269.8 4273.5 2592.6 2766.8 2767.8 2783.3 2814.4 779.4 804.8 834.8 840.4 843.3 8878.1 9146.5 9188.3 9372.4 9487.6 3550.2 3561.7 3592.0 3648.4 3649.1 7617.8 7631.4 7632.8 7640.7 7647.9 4177.5 4178.9 4181.3 4187.0 4187.4 3349.1 3457.6 3662.0 3839.0 3893.6 2943.9 3043.3 3113.1 3116.0 3131.4 923.8 933.1 939.2 940.0 940.2 623.4 626.6 720.1 744.3 758.9 4633.1 4739.8 4973.3 5021.6 5077.9 338.3 340.0 340.6 343.0 345.3 3202.4 3558.6 3565.8 3617.3 3707.3 8176.6 8535.8 8580.9 8595.9 8605.0 8358.9 8365.7 8451.9 8506.4 8508.4 6435.9 6684.6 6717.5 6718.9 6756.7 4762.0 4896.5 4942.8 4988.7 5055.9 7641.3 7857.6 7906.4 7925.2 7929.6 7774.0 7798.7 7802.7 7897.6 7916.5 5548.9 6175.6 6295.3 6300.9 6315.8 6101.1 6458.4 6602.9 6656.7 6774.4 6039.2 6170.6 6208.1 6214.7 6240.5 5964.4 5975.9 5984.9 5993.2 6043.0 5627.3 5661.6 5700.0 5707.0 5708.9 4122.1 4122.5 4215.4 4277.2 4417.8 4194.5 4258.4 4277.3 4339.7 4424.0 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | [#4] prototype.html Cycles:180 Average:4216.29 Median:4753.58 stddev:1235.07 (26.0%) stddev-sans-first:1202.78 06:48:46 INFO - PROCESS | 19593 | Values: 285.7 295.7 298.0 301.0 303.7 4798.0 4884.0 4928.8 4969.0 4987.7 4765.3 4887.2 4910.7 4928.3 4930.1 3858.3 3864.5 3876.4 3877.4 3903.8 3630.3 3846.7 3868.8 3880.8 3892.7 3752.7 3809.5 3815.9 3821.4 3823.8 3798.8 3802.2 3807.2 3807.4 3815.5 3339.7 3340.8 3356.9 3372.9 3373.8 4721.9 4768.6 4832.2 4844.8 4904.0 4317.2 4332.7 4334.2 4335.9 4347.4 5111.5 5177.4 5184.1 5202.3 5202.7 3533.3 3595.2 3619.2 3626.6 3632.0 5327.9 5342.7 5364.4 5371.6 5396.2 3691.8 3697.4 3728.0 3732.4 3741.7 3777.5 3786.4 3791.6 3792.8 3813.1 4059.4 4285.2 4326.9 4333.6 4335.1 5143.3 5144.9 5151.9 5152.4 5156.8 1176.1 1194.5 1215.7 1243.6 1272.0 834.4 858.7 859.4 866.4 867.6 4354.9 4355.4 4362.0 4386.7 4399.8 5090.5 5097.2 5100.3 5140.9 5150.4 4325.8 4335.6 4343.5 4360.8 4363.8 2615.8 2677.5 2708.6 2718.9 2720.6 4719.5 4737.9 4749.9 4752.5 4778.0 5037.3 5215.4 5218.4 5220.4 5227.3 4736.7 4754.7 4759.8 4796.0 4800.9 5104.7 5111.5 5129.9 5138.6 5154.7 4732.4 4996.6 5006.4 5015.5 5046.2 4708.5 4723.1 4723.5 4730.6 4755.2 3576.7 3580.3 3589.3 3628.6 3637.3 5098.4 5178.8 5193.6 5205.9 5206.9 4984.8 5178.2 5212.8 5213.2 5222.3 5215.9 5219.8 5224.5 5227.1 5283.6 4869.0 5142.4 5166.2 5168.7 5198.5 5180.6 5239.3 5256.3 5261.9 5267.0 5149.6 5151.0 5159.4 5191.4 5193.6 06:48:46 INFO - PROCESS | 19593 | 06:48:46 INFO - PROCESS | 19593 | [#5] yui.html Cycles:180 Average:14156.55 Median:582.03 stddev:18394.84 (3160.5%) stddev-sans-first:18418.38 06:48:46 INFO - PROCESS | 19593 | Values: 625.8 632.4 663.3 692.6 726.9 11899.5 12363.6 12690.0 12704.2 12845.0 12096.3 12210.6 12218.9 12220.3 12232.2 614.6 761.9 776.7 777.1 777.7 626.1 739.5 754.8 762.8 772.6 800.3 803.4 805.4 805.5 806.0 794.6 800.3 800.3 800.6 800.9 582.9 586.1 586.4 586.6 586.6 12161.2 12509.9 12637.4 12667.4 12691.0 12281.8 12528.9 12620.8 12715.2 13153.4 9742.7 9764.6 9799.1 9859.3 10104.5 3214.7 3258.1 3272.9 3285.7 3301.5 48708.5 49178.5 49684.0 49685.5 50142.5 9485.1 9785.7 9810.9 9863.0 9947.2 16512.5 16730.3 16742.0 16810.4 17019.9 6463.0 6465.3 6492.7 6511.1 6737.2 3567.2 3576.1 3591.8 3603.0 3648.7 2780.5 2848.7 2851.7 2880.0 2930.1 485.5 489.9 496.5 500.3 509.7 476.2 518.9 580.2 581.2 630.4 7351.3 7357.7 7500.2 7568.8 7788.3 557.3 563.3 574.6 577.6 588.5 3442.3 3599.9 3605.6 3761.0 3830.8 67931.3 68803.7 69427.3 71941.6 71974.6 38761.8 43475.6 58604.0 59123.4 60327.0 54731.7 55522.4 55807.4 55962.4 59050.4 7077.3 7173.2 7331.7 7346.2 7443.6 37428.4 37802.8 37836.2 38863.6 39674.6 45633.8 50674.0 52863.0 53459.2 53739.7 9060.9 9294.8 9403.6 9519.0 9523.4 10033.1 10103.5 10114.8 10177.8 10211.6 9300.0 9914.0 9924.0 9979.0 10017.4 9882.8 10061.1 10187.2 10286.5 10869.4 9201.7 9342.4 9590.8 9867.7 10049.1 7917.3 7944.1 8030.9 8077.0 8224.9 7891.0 7998.7 8032.4 8160.7 8504.0 06:48:46 INFO - PROCESS | 19593 | -------- Summary: end -------- 06:48:46 INFO - PROCESS | 19593 | 06:48:47 INFO - TEST-INFO | 19593: exit 0 06:48:47 INFO - TEST-OK | dromaeo_css | took 1122566ms 06:48:47 INFO - TEST-START | kraken 06:48:47 INFO - operating with platform_type : linux_ 06:48:47 INFO - Initialising browser for kraken test... 06:48:47 INFO - TEST-INFO | started process 19956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1b97cK/profile http://localhost:52626/getInfo.html) 06:48:52 INFO - PROCESS | 19956 | __metrics Screen width/height:1600/1200 06:48:52 INFO - PROCESS | 19956 | colorDepth:24 06:48:52 INFO - PROCESS | 19956 | Browser inner width/height: 1024/697 06:48:52 INFO - PROCESS | 19956 | __metrics 06:48:52 ERROR - PROCESS | 19956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 06:48:54 INFO - TEST-INFO | 19956: exit 0 06:48:54 INFO - Browser initialized. 06:48:54 INFO - Running cycle 1/1 for kraken test... 06:48:54 INFO - TEST-INFO | started process 20086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1b97cK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:06 INFO - PROCESS | 20086 | RSS: Main: 187060224 06:49:06 INFO - PROCESS | 20086 | 06:49:09 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52626/tests/kraken/driver.html?testName=audio-beat-detection) 06:49:10 INFO - PROCESS | 20086 | RSS: Main: 199581696 06:49:10 INFO - PROCESS | 20086 | 06:49:13 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52626/tests/kraken/driver.html?testName=audio-dft) 06:49:13 INFO - PROCESS | 20086 | RSS: Main: 197910528 06:49:13 INFO - PROCESS | 20086 | 06:49:16 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52626/tests/kraken/driver.html?testName=audio-fft) 06:49:17 INFO - PROCESS | 20086 | RSS: Main: 194830336 06:49:17 INFO - PROCESS | 20086 | 06:49:19 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52626/tests/kraken/driver.html?testName=audio-oscillator) 06:49:20 INFO - PROCESS | 20086 | RSS: Main: 194953216 06:49:20 INFO - PROCESS | 20086 | 06:49:22 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:22 INFO - PROCESS | 20086 | RSS: Main: 195182592 06:49:22 INFO - PROCESS | 20086 | 06:49:26 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52626/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:26 INFO - PROCESS | 20086 | RSS: Main: 200290304 06:49:26 INFO - PROCESS | 20086 | 06:49:30 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52626/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:30 INFO - PROCESS | 20086 | RSS: Main: 196792320 06:49:30 INFO - PROCESS | 20086 | 06:49:33 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52626/tests/kraken/driver.html?testName=json-parse-financial) 06:49:34 INFO - PROCESS | 20086 | RSS: Main: 198594560 06:49:34 INFO - PROCESS | 20086 | 06:49:36 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:49:36 INFO - PROCESS | 20086 | RSS: Main: 198402048 06:49:36 INFO - PROCESS | 20086 | 06:49:38 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:49:39 INFO - PROCESS | 20086 | RSS: Main: 198283264 06:49:39 INFO - PROCESS | 20086 | 06:49:41 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:42 INFO - PROCESS | 20086 | RSS: Main: 198389760 06:49:42 INFO - PROCESS | 20086 | 06:49:45 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:46 INFO - PROCESS | 20086 | RSS: Main: 198823936 06:49:46 INFO - PROCESS | 20086 | 06:49:49 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:49:49 INFO - PROCESS | 20086 | RSS: Main: 202534912 06:49:49 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | Cycle 1(1): loaded http://localhost:52626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52626/tests/kraken/driver.html?testName=ai-astar) 06:49:51 INFO - PROCESS | 20086 | RSS: Main: 204566528 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | __start_tp_report 06:49:51 INFO - PROCESS | 20086 | _x_x_mozilla_page_load 06:49:51 INFO - PROCESS | 20086 | _x_x_mozilla_page_load_details 06:49:51 INFO - PROCESS | 20086 | |i|pagename|runs| 06:49:51 INFO - PROCESS | 20086 | |0;ai-astar;109;118;117;119;119;118;118;117;119;120 06:49:51 INFO - PROCESS | 20086 | |1;audio-beat-detection;158;131;137;181;132;128;130;134;165;133 06:49:51 INFO - PROCESS | 20086 | |2;audio-dft;167;170;164;163;164;166;165;166;165;164 06:49:51 INFO - PROCESS | 20086 | |3;audio-fft;77;78;77;112;77;77;77;76;101;77 06:49:51 INFO - PROCESS | 20086 | |4;audio-oscillator;84;83;119;86;84;84;105;84;84;112 06:49:51 INFO - PROCESS | 20086 | |5;imaging-gaussian-blur;119;118;118;121;118;118;119;119;118;119 06:49:51 INFO - PROCESS | 20086 | |6;imaging-darkroom;147;149;148;149;149;150;150;151;149;147 06:49:51 INFO - PROCESS | 20086 | |7;imaging-desaturate;96;97;97;96;98;98;97;96;97;96 06:49:51 INFO - PROCESS | 20086 | |8;json-parse-financial;64;65;69;66;66;66;66;66;65;67 06:49:51 INFO - PROCESS | 20086 | |9;json-stringify-tinderbox;67;74;67;67;67;67;67;68;70;68 06:49:51 INFO - PROCESS | 20086 | |10;stanford-crypto-aes;86;86;85;85;86;85;86;86;84;84 06:49:51 INFO - PROCESS | 20086 | |11;stanford-crypto-ccm;149;151;174;152;152;143;154;156;198;156 06:49:51 INFO - PROCESS | 20086 | |12;stanford-crypto-pbkdf2;184;178;179;180;178;187;178;179;179;181 06:49:51 INFO - PROCESS | 20086 | |13;stanford-crypto-sha256-iterative;72;70;71;74;73;74;69;69;71;78 06:49:51 INFO - PROCESS | 20086 | __end_tp_report 06:49:51 INFO - PROCESS | 20086 | __start_cc_report 06:49:51 INFO - PROCESS | 20086 | _x_x_mozilla_cycle_collect,891 06:49:51 INFO - PROCESS | 20086 | __end_cc_report 06:49:51 INFO - PROCESS | 20086 | __startTimestamp1479221391752__endTimestamp 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | ------- Summary: start ------- 06:49:51 INFO - PROCESS | 20086 | Number of tests: 14 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#0] ai-astar Cycles:10 Average:117.40 Median:118.50 stddev:3.10 (2.6%) stddev-sans-first:1.00 06:49:51 INFO - PROCESS | 20086 | Values: 109.0 118.0 117.0 119.0 119.0 118.0 118.0 117.0 119.0 120.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:135.50 stddev:18.35 (13.5%) stddev-sans-first:18.63 06:49:51 INFO - PROCESS | 20086 | Values: 158.0 131.0 137.0 181.0 132.0 128.0 130.0 134.0 165.0 133.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:2.01 (1.2%) stddev-sans-first:2.05 06:49:51 INFO - PROCESS | 20086 | Values: 167.0 170.0 164.0 163.0 164.0 166.0 165.0 166.0 165.0 164.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:12.71 (16.5%) stddev-sans-first:13.31 06:49:51 INFO - PROCESS | 20086 | Values: 77.0 78.0 77.0 112.0 77.0 77.0 77.0 76.0 101.0 77.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:84.00 stddev:13.87 (16.5%) stddev-sans-first:14.37 06:49:51 INFO - PROCESS | 20086 | Values: 84.0 83.0 119.0 86.0 84.0 84.0 105.0 84.0 84.0 112.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 06:49:51 INFO - PROCESS | 20086 | Values: 119.0 118.0 118.0 121.0 118.0 118.0 119.0 119.0 118.0 119.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.29 (0.9%) stddev-sans-first:1.17 06:49:51 INFO - PROCESS | 20086 | Values: 147.0 149.0 148.0 149.0 149.0 150.0 150.0 151.0 149.0 147.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:49:51 INFO - PROCESS | 20086 | Values: 96.0 97.0 97.0 96.0 98.0 98.0 97.0 96.0 97.0 96.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:1.20 06:49:51 INFO - PROCESS | 20086 | Values: 64.0 65.0 69.0 66.0 66.0 66.0 66.0 66.0 65.0 67.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:67.50 stddev:2.25 (3.3%) stddev-sans-first:2.35 06:49:51 INFO - PROCESS | 20086 | Values: 67.0 74.0 67.0 67.0 67.0 67.0 67.0 68.0 70.0 68.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 06:49:51 INFO - PROCESS | 20086 | Values: 86.0 86.0 85.0 85.0 86.0 85.0 86.0 86.0 84.0 84.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:155.00 stddev:16.00 (10.3%) stddev-sans-first:16.60 06:49:51 INFO - PROCESS | 20086 | Values: 149.0 151.0 174.0 152.0 152.0 143.0 154.0 156.0 198.0 156.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:179.50 stddev:2.98 (1.7%) stddev-sans-first:2.85 06:49:51 INFO - PROCESS | 20086 | Values: 184.0 178.0 179.0 180.0 178.0 187.0 178.0 179.0 179.0 181.0 06:49:51 INFO - PROCESS | 20086 | 06:49:51 INFO - PROCESS | 20086 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.50 stddev:2.77 (3.8%) stddev-sans-first:2.93 06:49:51 INFO - PROCESS | 20086 | Values: 72.0 70.0 71.0 74.0 73.0 74.0 69.0 69.0 71.0 78.0 06:49:51 INFO - PROCESS | 20086 | -------- Summary: end -------- 06:49:51 INFO - PROCESS | 20086 | 06:49:52 INFO - TEST-INFO | 20086: exit 0 06:49:53 INFO - TEST-OK | kraken | took 65588ms 06:49:53 INFO - SUITE-END | took 1188s 06:49:53 INFO - Completed test suite (00:19:48) 06:49:53 INFO - javascript benchmark 06:49:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6076.046513809004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.934301642459, 2636.433166869123, 2638.4591158812445, 2654.7876169906403, 2671.10517976478, 4674.182018146819, 4750.168720473916, 4765.785539650716, 4794.448638406584, 4800.3279540864305, 4728.739919304446, 4736.431628204612, 4792.400949881265, 4794.472608013116, 4794.736289504076, 4310.56894310568, 4415.845445409412, 4436.511983681792, 4478.193925093482, 4556.84051058213, 4466.553344665524, 4473.709208901411, 4517.2772356422975, 4575.656825738066, 4580.038191979688, 4431.933520997188, 4467.173572889026, 4524.389207457, 4530.592246697796, 4557.931631025537, 4287.078278170177, 4350.216960947028, 4351.0645211279725, 4399.428074350346, 4409.338599210112, 4302.311630139194, 4339.741474972254, 4351.673624478145, 4398.098389830077, 4428.778561071934, 4711.905761884743, 4750.311204875274, 4757.762111894392, 4766.022965292107, 4766.285057241442, 5121.487851214886, 5154.381474223117, 5155.974220128913, 5179.14544100223, 5181.585473162176, 5126.666766660155, 5135.101357262464, 5138.845834624967, 5176.55999240065, 5228.8692782680355, 4784.091022705675, 4808.471068182497, 4837.2260438329695, 4841.3222148899185, 4848.00615873745, 5024.371953505812, 5292.735363231823, 5296.973515132477, 5300.787968481218, 5303.0454518186325, 4874.7562621868765, 4888.462269150391, 4906.362172917497, 4908.165611845995, 4989.077020751172, 5001.7499125043605, 5013.548780609763, 5031.698098114051, 5035.723035233024, 5083.0, 4997.550220480174, 5035.79856805731, 5059.747012649353, 5075.5178258065425, 5085.516875896784, 5089.05852417304, 5106.055379754757, 5107.668001579886, 5108.259302401206, 5148.9485105149215, 4232.153569286155, 4274.487061552633, 4281.550437204049, 4286.935695964563, 4330.0, 3778.319902417591, 3818.3317919364, 3838.654521093115, 3890.8054597270025, 3942.1918506706056, 4510.932336014962, 4517.186906356887, 4518.661100417482, 4533.727976321431, 4552.408186935677, 5226.3205783248695, 5245.947540524622, 5249.973750131225, 5250.921236181461, 5288.735563221823, 4333.220020396296, 4381.715188512737, 4385.3641222022625, 4436.134953684065, 4489.506154323022, 4665.790039448233, 4715.811367545329, 4726.031163611451, 4744.810207591658, 4778.737169455644, 4865.610751139971, 4870.12337779189, 4874.147024270809, 4877.292792545132, 4898.9957058803575, 4864.878378040436, 5223.738813059256, 5224.660397074178, 5231.633785634969, 5287.550558202596, 4623.237165867594, 4629.213033784332, 4705.0589882024415, 4705.788239529298, 4708.952910470852, 4914.803407863788, 4952.57903078228, 4990.525900039491, 5064.240363945438, 5076.11168045598, 5179.326687530597, 5179.559737422211, 5184.377874655065, 5195.0, 5224.6342756008235, 5016.924746128738, 5045.545900868792, 5062.0, 5062.82280120194, 5082.2122571001555, 4808.182608956416, 4886.144924638245, 4919.237518184687, 4971.502849715, 5033.622478314068, 4805.495422980537, 4839.782209800497, 4866.829660961849, 4877.512248775236, 4888.413390393175, 4955.1576232039915, 5028.874278143076, 5038.370203724535, 5070.188769796815, 5101.7704203310195, 4741.881452963704, 4925.45819959797, 4939.604831613534, 4941.827036053721, 4980.626453016111], "value": 4705.746208308871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.4387948774302, 537.3632245788741, 540.8512659018769, 548.3803302268437, 565.7567246084183, 37610.0, 38735.61264387355, 38868.222635547274, 38905.22189556207, 42812.571874281246, 39154.8042259789, 39683.40474892879, 39701.60298397015, 39729.205415891665, 39746.621537169376, 7515.887261691066, 7691.9230807691765, 7692.153863075086, 7695.422843286776, 7713.267239612228, 7532.887006694904, 7541.849163016736, 7587.658555365022, 7620.580868052255, 7647.655855486489, 7600.2779735925, 7651.426143039266, 7654.8469030619635, 7665.540067595962, 7668.07983042033, 7562.546247225157, 7619.6571154297635, 7627.046619172604, 7627.2372762723835, 7642.808929776745, 7577.696892124309, 7636.465447418683, 7638.159802421729, 7645.235476452311, 7646.502977306457, 36288.0, 36680.266394672224, 36763.816180919195, 36818.0, 36880.63119368799, 2979.0913771299747, 3022.1084779989737, 3022.637283525969, 3270.1497610621172, 3569.964300357015, 26827.86586067077, 27342.0, 27927.022554210504, 27942.301442463897, 28105.3029248603, 2919.737223649882, 2927.8536073196256, 3016.0, 3043.117495926179, 3200.199950012497, 228332.0, 228778.0, 230483.0, 231964.0, 232470.9999999983, 49959.0, 50103.74948125309, 50200.0, 50266.246006309935, 50472.74763626232, 52192.47807521952, 52379.47620523822, 52563.73718131462, 52626.73686631543, 52694.209586856225, 13360.866391335961, 13385.933070334586, 13390.531331403354, 13408.798868016987, 13623.591292261248, 10534.051935325857, 10689.518971646294, 10693.732656683489, 10703.411312377893, 10720.303180293256, 14182.290885455686, 15432.768508472382, 15511.844881551266, 15566.922165389327, 15770.369185232692, 6058.757649694051, 6190.783322583688, 6296.937030629727, 6302.968485157545, 6358.904616430757, 735.9926400736031, 905.8686490458847, 914.2092090341939, 916.9403988740711, 957.5834511987308, 26492.0, 26697.466050679268, 26782.732172678414, 26999.595006074924, 27224.863875680494, 880.3221519430003, 888.595688961521, 896.2426749396749, 927.3230541704594, 929.9907000929904, 14030.579082627537, 14411.351489183013, 14493.768029717592, 14670.33983470725, 14737.0, 325126.0, 328630.0, 328908.0, 329945.0, 331246.0, 47425.28862067072, 47444.76277618659, 47556.28665570019, 47728.52271477241, 47730.76134619374, 1052.3633201912733, 1093.7429704019548, 1158.3339579741682, 1174.8061569841052, 1186.5550418593027, 24444.022239110236, 25239.242822715347, 26449.735502644726, 26875.193744187705, 27024.32439189036, 41203.58796411997, 41380.37929431121, 41399.169137092045, 41426.79286603668, 41455.79272103741, 291271.0, 293098.3627046619, 294825.09511406464, 295466.0, 295673.0, 33737.493937590465, 34267.97196084121, 34666.0, 34754.652453475144, 34986.82506587451, 38810.0, 39121.7465403567, 39690.60309396869, 40009.399859001554, 40363.798181008904, 33772.831135844164, 34046.148846279044, 34225.65774342225, 34270.828645856614, 34339.82830085834, 33820.0, 34561.82719086489, 34832.65167348395, 34837.65162348445, 34912.47631285482, 33682.66317336795, 33967.32065358728, 34477.31045379129, 34690.47964280487, 34876.825615871756, 30815.0, 31986.840065799523, 32059.839700801345, 32115.197120072185, 32191.839040804647, 24138.39654008664, 24282.75717242805, 24415.633765493887, 24805.255842324757, 25171.87414062918], "value": 16818.583564557564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.14463859057577, 363.5038172894, 375.0754390427596, 376.3338890164407, 389.5539607149814, 15354.84645153548, 16020.679586408265, 16402.91798541007, 16425.917870410645, 16664.0, 15452.22738863058, 15563.144027078506, 15888.602784930383, 16091.0, 16105.355785768585, 4705.670603057796, 5011.173156429185, 5013.3482647255805, 5017.59859211264, 5033.295338652573, 4835.298881662157, 4900.117978763821, 5198.350206224222, 5224.399194092671, 5255.947440525603, 5226.503482169188, 5233.1103712368795, 5244.580433565325, 5249.028929648028, 5262.684238945656, 5216.8174113906025, 5228.843134705965, 5403.13549832025, 5444.455554444564, 5456.890862182774, 5257.737113144328, 5260.263563101169, 5266.97366513165, 5269.077911365495, 5270.578353731692, 11038.944805276002, 15558.299876505584, 19735.21059157632, 19821.10805013778, 19838.504037399038, 1912.1108684461792, 2140.9250676226256, 2187.84685072045, 2294.2314324701247, 2311.884405779704, 8552.845365875652, 8907.821843563092, 9219.539023048821, 9359.719208423758, 9549.09283618055, 1589.3165938646378, 1697.7792886924744, 1739.2173521915188, 1749.571355018016, 1788.937387191442, 66071.33928660749, 67845.0, 68630.0, 69165.65417172933, 70922.29077709209, 9700.660476883275, 9842.60629574809, 9856.45789481571, 9957.0, 10034.799304013879, 13486.460541578226, 13588.660283492794, 13634.318284085755, 13641.386137623831, 13644.795328070088, 7019.122609673791, 7041.135314841402, 7130.750423735144, 7157.570545767167, 7232.92767072333, 6681.7327306908155, 6883.65581720922, 6954.3045695430055, 7001.404880585207, 7035.401990830836, 4027.3153563894207, 4115.609017143366, 4133.524644665842, 4355.629771469397, 4390.429244198233, 1463.8975271730876, 1505.2398538737866, 1750.824917508239, 1817.690992531273, 1846.642717602561, 809.6761295481737, 858.3648100405779, 862.8058686795546, 888.1695614600369, 933.3606479561387, 16077.517674469784, 16555.420560280574, 16608.83391166097, 16720.41478548269, 17020.914895425445, 857.0743596915316, 861.1947828780111, 874.07784787049, 876.2595606712318, 896.1486587741541, 9405.43567385959, 9468.242540596735, 9472.431654100776, 9554.426734395958, 9757.902420975699, 333776.0, 338875.0, 339117.0, 339644.0, 340887.0, 75027.62486187644, 75327.62336188284, 75349.24650753532, 76013.61993189999, 79317.60341198373, 411.44044100023945, 430.83197552954374, 436.95848894355623, 893.3924931046951, 911.6945823149186, 9486.797008685444, 9914.256430767577, 9996.450195239331, 10199.337043092175, 13922.930385348009, 36206.637933620324, 36604.0, 37559.812200939916, 40298.0, 42548.36177457279, 46221.0, 49156.0, 50991.49008510016, 52523.73738131285, 52558.73720631372, 7092.25531319204, 7129.322714342129, 7364.447666424932, 7501.88747168782, 7677.654505547152, 10128.44293563861, 10538.315009524356, 10608.575656973635, 10614.203934705083, 10982.505787239754, 9206.355555111079, 9479.668211612561, 9512.476813775309, 9683.51582420862, 9821.5089245536, 9192.586333615138, 9241.260699143917, 9374.343795934219, 9508.381955172892, 9515.571799268911, 9191.632334706537, 9335.953320233355, 9429.952850235704, 9574.808503830023, 9670.887847897582, 7416.480846340704, 7430.294122058396, 7478.401727861649, 7505.399568034653, 7509.6245187739305, 8225.83548329042, 9622.951885240529, 9773.31586788918, 10135.0, 10452.738681533023], "value": 7790.3112104003985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.2580092247877, 1365.0581099041663, 1421.786731990202, 1607.0759313394801, 1669.8330166983303, 6226.097215903691, 6434.002729576923, 6726.461883049356, 7222.205557388683, 7230.963845180773, 6704.832379190522, 6917.827054323644, 6919.0, 7058.611776352299, 7122.8575428491395, 2047.2322878920404, 2091.0903756865737, 2092.8221101206414, 2093.1313504895525, 2095.3713885834263, 2011.2256781139295, 2035.2469586253108, 2053.8151566359024, 2064.0, 2073.60601485718, 2006.418138739771, 2008.437637461513, 2030.6344857925567, 2031.8679285846372, 2037.4193354893857, 1959.1183967214738, 1967.1147983407525, 1973.842092632586, 1975.664137096697, 1977.5056235941086, 1989.9900500497404, 2002.8497862660213, 2064.9277275295294, 2073.6785798201154, 2075.9273425430038, 7100.5384649998105, 7128.893066604005, 7159.284071592851, 7237.276272372773, 7243.239459856692, 4154.979225103855, 4216.241076606209, 4260.318349064135, 4269.829206831723, 4273.529911709709, 2592.5592649249675, 2766.833989960609, 2767.8200916940536, 2783.3459137102764, 2814.408974115438, 779.380392587894, 804.7505273365217, 834.7954751086023, 840.4075127035426, 843.304273973974, 8878.067802880669, 9146.451212927246, 9188.26493880488, 9372.437653740797, 9487.620495180185, 3550.232217061843, 3561.732870034758, 3591.964080359215, 3648.416253399443, 3649.1424515238896, 7617.809554761065, 7631.3513351365755, 7632.809179770439, 7640.694372225049, 7647.923520764721, 4177.5195852476745, 4178.895527611834, 4181.289180839264, 4187.0, 4187.392828039917, 3349.0790032741193, 3457.6023757267735, 3662.0, 3838.9808050960123, 3893.6301051400073, 2943.8528073596663, 3043.284828065403, 3113.128324069264, 3116.0340294508774, 3131.4363414585137, 923.8060007398522, 933.1135421349745, 939.2110627073155, 940.022376728195, 940.1679513630486, 623.3890787028737, 626.6083697688945, 720.1466262478979, 744.2520267131498, 758.8671982403057, 4633.119707255611, 4739.810407583727, 4973.303737476756, 5021.648484606116, 5077.873053173626, 338.25921232501236, 339.96430374810785, 340.6440269917942, 343.048041684328, 345.3179969560149, 3202.3595280943437, 3558.590762062396, 3565.7519868045974, 3617.27654469102, 3707.3141468828353, 8176.591170441454, 8535.786605334792, 8580.914190858137, 8595.914040859636, 8605.0, 8358.916410835935, 8365.665373384996, 8451.873221901677, 8506.362022848187, 8508.446950948168, 6435.935640643534, 6684.565503242274, 6717.529772915849, 6718.932810671929, 6756.662166891636, 4761.952370478489, 4896.510348965217, 4942.777575009061, 4988.6757360771435, 5055.87360315995, 7641.2740789624895, 7857.607119644109, 7906.367490600853, 7925.167857374892, 7929.643166057426, 7773.961130194313, 7798.727044553413, 7802.687892484237, 7897.565633890191, 7916.525008499509, 5548.861278468071, 6175.5677102602385, 6295.307516173309, 6300.873982520416, 6315.810525684236, 6101.054336577838, 6458.354164583504, 6602.910519764185, 6656.7004484797335, 6774.42417394527, 6039.214902062704, 6170.629762214281, 6208.068789681584, 6214.658193799203, 6240.53196010292, 5964.433378829004, 5975.880482390415, 5984.850378740392, 5993.220881285405, 6042.969785151222, 5627.296587926509, 5661.575381846295, 5700.030994730822, 5707.0, 5708.942910571007, 4122.134351786159, 4122.515894277997, 4215.367694845675, 4277.2087163874785, 4417.77911104437, 4194.5386007539755, 4258.446401967724, 4277.294246449301, 4339.674524410745, 4424.026714122888], "value": 3644.8308118674595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.665771047874, 295.7072498226755, 297.98957036503725, 301.00667796272296, 303.70843989769816, 4797.952020479803, 4883.997560999991, 4928.778204980776, 4968.975155124223, 4987.700737955721, 4765.309030190629, 4887.242477415997, 4910.680805747624, 4928.31003659487, 4930.137225985447, 3858.266929283427, 3864.516935383077, 3876.379779235309, 3877.3990031545154, 3903.843846246161, 3630.2920930418577, 3846.6922646188236, 3868.825902834379, 3880.844766209348, 3892.6885849132145, 3752.662260396564, 3809.466674665549, 3815.9427608585893, 3821.3694740367946, 3823.751456155341, 3798.810059497014, 3802.16352402471, 3807.200487897517, 3807.4098514730263, 3815.465834783133, 3339.716124129452, 3340.799552026886, 3356.9160770980675, 3372.898813035613, 3373.814440205788, 4721.881952951169, 4768.570828625406, 4832.154372984749, 4844.781984810692, 4903.950960490385, 4317.15815415994, 4332.696711230215, 4334.198173337911, 4335.869923902288, 4347.3696314034605, 5111.488851114858, 5177.404598471187, 5184.118699821001, 5202.297689811865, 5202.68783872965, 3533.2580158166816, 3595.1910820065277, 3619.2037751694584, 3626.5829429615405, 3631.9830447474487, 5327.866803329948, 5342.652727572696, 5364.405848081834, 5371.623986320959, 5396.244525766396, 3691.8338674759702, 3697.4268988306853, 3727.986887081, 3732.402815549499, 3741.719371047128, 3777.508923839883, 3786.3563194257044, 3791.563970143469, 3792.8482860685817, 3813.103920578662, 4059.3910913363234, 4285.185814695198, 4326.870193894189, 4333.609975102256, 4335.132973405269, 5143.254228136974, 5144.897102057937, 5151.896962060738, 5152.355955505562, 5156.828550441452, 1176.0591526778544, 1194.4505527457293, 1215.7446936143333, 1243.608263397027, 1271.9809202861964, 834.3742193354984, 858.6694122762657, 859.4198915731856, 866.445474896067, 867.5705525764787, 4354.869353919387, 4355.428548590189, 4362.037083312522, 4386.692931494828, 4399.802008909607, 5090.516400941905, 5097.235414687752, 5100.311457953128, 5140.948590514122, 5150.381954165524, 4325.8269669213505, 4335.574895832257, 4343.457067866517, 4360.825566977285, 4363.759993200404, 2615.764581187664, 2677.4965407344193, 2708.6456771614194, 2718.9048383306886, 2720.564709646447, 4719.457262414798, 4737.928931066037, 4749.928751068736, 4752.453467851241, 4778.0, 5037.29477873098, 5215.400228973716, 5218.399884013311, 5220.425753167148, 5227.3465816772905, 4736.715797052188, 4754.7147171169845, 4759.785809638574, 4795.976020119877, 4800.927986080212, 5104.668196567211, 5111.524163568809, 5129.8717532062, 5138.557166698396, 5154.742262886915, 4732.384789977418, 4996.550310472075, 5006.449290577961, 5015.548600625962, 5046.1926091825135, 4708.482066972699, 4723.149833030087, 4723.480417154042, 4730.645201609962, 4755.215389460838, 3576.7496275260482, 3580.283943211316, 3589.335972845032, 3628.63713628635, 3637.3270944875285, 5098.439171691185, 5178.792848286177, 5193.584513239008, 5205.921911171411, 5206.921896171485, 4984.825531106394, 5178.171492561172, 5212.765425555935, 5213.218017297436, 5222.336608329703, 5215.921761173661, 5219.791208351623, 5224.451432599674, 5227.137522308929, 5283.630145889751, 4868.95131048685, 5142.354446577209, 5166.173412254021, 5168.689878607295, 5198.506141916512, 5180.611454140879, 5239.266502689703, 5256.342957130359, 5261.89476210466, 5267.0, 5149.639525233198, 5150.97424512875, 5159.406668233201, 5191.351081114861, 5193.584513239008], "value": 3819.432989094504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.7934881489109, 632.4434497642075, 663.2869665110007, 692.6363659078983, 726.912770467544, 11899.52401903924, 12363.567275145371, 12690.0, 12704.17422867513, 12845.036622253345, 12096.274223546594, 12210.633680989562, 12218.877811221884, 12220.266783992967, 12232.20490668106, 614.5820841827556, 761.862864684358, 776.7087342246657, 777.1296148313896, 777.7355699062317, 626.0827887145331, 739.4675833399943, 754.7697952124599, 762.8092976755811, 772.5905270206771, 800.3317230112863, 803.3854101612271, 805.3879051920553, 805.4885147931047, 805.963731632078, 794.5629903553051, 800.2837460472903, 800.3437181511134, 800.6437135474716, 800.8558459477292, 582.8863371642532, 586.1325238646826, 586.3725813379685, 586.5542187937156, 586.560079940045, 12161.20952138117, 12509.874901251053, 12637.368131593383, 12667.36663166838, 12691.04817138709, 12281.754364912742, 12528.937355313255, 12620.81068783969, 12715.173513721578, 13153.40809663558, 9742.659006934724, 9764.609415623367, 9799.069088436587, 9859.26055545837, 10104.494775261208, 3214.7106760391443, 3258.0551640024364, 3272.8527216275324, 3285.671432856719, 3301.504774283853, 48708.51291487075, 49178.508214917754, 49684.0, 49685.50314496845, 50142.49857501415, 9485.146336829719, 9785.706428807147, 9810.901890981142, 9863.0, 9947.20422366209, 16512.504624861274, 16730.330786768638, 16742.0, 16810.411635592696, 17019.914900425418, 6463.0, 6465.256495502983, 6492.707828147744, 6511.088447617242, 6737.157855268091, 3567.1973805893467, 3576.0523461282783, 3591.8204089795404, 3603.0, 3648.7263455240964, 2780.471710375022, 2848.686644469107, 2851.7290857368516, 2879.97120028797, 2930.120963710878, 485.5314621390375, 489.8971216044599, 496.53077841439494, 500.33705340424086, 509.69927742632024, 476.24752890433035, 518.9377274726982, 580.1761498671812, 581.1689284323373, 630.4420587779848, 7351.301626345488, 7357.742479013209, 7500.249975002565, 7568.810779730551, 7788.260115289038, 557.2838902010897, 563.2508763344823, 574.5949105880344, 577.5523968924033, 588.520355909932, 3442.2599141184264, 3599.874004409833, 3605.639436056426, 3761.022134245116, 3830.8276127574327, 67931.3206867935, 68803.65598171977, 69427.3057269431, 71941.6402917982, 71974.64012679903, 38761.80619096886, 43475.56524434715, 58604.0, 59123.40876591265, 60327.0, 54731.72634136804, 55522.44477555253, 55807.44192558023, 55962.44037559654, 59050.40949590449, 7077.327653872874, 7173.210946795744, 7331.74338898136, 7346.155192152971, 7443.55338679681, 37428.43857342088, 37802.810985944896, 37836.24327513379, 38863.61136388713, 39674.60325396709, 45633.771831140635, 50674.0, 52863.0, 53459.19811202913, 53739.73130134324, 9060.90939090627, 9294.767630809283, 9403.576839042396, 9519.0, 9523.428594284365, 10033.14718248957, 10103.49482525856, 10114.848277275994, 10177.84733229017, 10211.642592509226, 9299.953500232727, 9914.0, 9924.0, 9978.950105249427, 10017.449040302561, 9882.802343953224, 10061.14480269156, 10187.235957303084, 10286.537105830106, 10869.402182880018, 9201.723948281562, 9342.439453632804, 9590.760230994281, 9867.703968880945, 10049.14582260516, 7917.327027202752, 7944.126146123806, 8030.919690803017, 8077.0, 8224.876626850722, 7891.0, 7998.720044798404, 8032.357411407191, 8160.714374996846, 8503.957480212806], "value": 5861.727290845807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0, 117.0, 119.0, 120.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 137.0, 181.0, 132.0, 128.0, 130.0, 134.0, 165.0, 133.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 164.0, 163.0, 164.0, 166.0, 165.0, 166.0, 165.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 112.0, 77.0, 77.0, 77.0, 76.0, 101.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 119.0, 86.0, 84.0, 84.0, 105.0, 84.0, 84.0, 112.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 121.0, 118.0, 118.0, 119.0, 119.0, 118.0, 119.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 149.0, 149.0, 150.0, 150.0, 151.0, 149.0, 147.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 98.0, 98.0, 97.0, 96.0, 97.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 69.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 70.0, 68.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 84.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 174.0, 152.0, 152.0, 143.0, 154.0, 156.0, 198.0, 156.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 178.0, 179.0, 180.0, 178.0, 187.0, 178.0, 179.0, 179.0, 181.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 74.0, 73.0, 74.0, 69.0, 69.0, 71.0, 78.0], "value": 72.1, "unit": "score"}]}]} 06:49:53 INFO - Return code: 0 06:49:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:49:53 ERROR - # TBPL SUCCESS # 06:49:53 INFO - Running post-action listener: _resource_record_post_action 06:49:53 INFO - [mozharness: 2016-11-15 14:49:53.519699Z] Finished run-tests step (success) 06:49:53 INFO - Running post-run listener: _resource_record_post_run 06:49:53 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401154048; Read time: 8; Write time: 371924 06:49:53 INFO - TinderboxPrint: CPU usage
13.5% 06:49:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:49:53 INFO - TinderboxPrint: I/O write bytes / time
401,154,048 / 371,924 06:49:53 INFO - TinderboxPrint: CPU idle
8,313.1 (86.5%) 06:49:53 INFO - TinderboxPrint: CPU user
1,233.2 (12.8%) 06:49:53 INFO - TinderboxPrint: Swap in / out
0 / 0 06:49:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110583808; Read time: 0; Write time: 115128 06:49:53 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290570240; Read time: 0; Write time: 256796 06:49:54 INFO - Running post-run listener: _upload_blobber_files 06:49:54 INFO - Blob upload gear active. 06:49:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:54 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 06:49:54 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:49:54 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:49:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:55 INFO - (blobuploader) - INFO - Done attempting. 06:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:58 INFO - (blobuploader) - INFO - Done attempting. 06:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:00 INFO - (blobuploader) - INFO - Done attempting. 06:50:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:50:00 INFO - Return code: 0 06:50:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:50:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:50:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ffde302073a057b5f95c975adaeab5577786a72ba1f3f1c8223802aa1d53e2ae51f471467112963cf72bd95f7f3650801c969a1e7157008f48ec475fc104867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a019df256c841ea063da3daa54e68fc4d32fbee4c86b48cc26b36187b31f716d00193a6ba27864ae120223f23f67c5266f3f0a3105a83a1bba2ea916447eb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6974a8df411a7c669eb395c5fa332ad37b6ebc3ca0741b4b1147224c7f4269204c6635eb6b5ec74f299b80b6981cdcad4853ddda61b88e3c78aaa6671b69b21d"} 06:50:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:50:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:50:00 INFO - Contents: 06:50:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ffde302073a057b5f95c975adaeab5577786a72ba1f3f1c8223802aa1d53e2ae51f471467112963cf72bd95f7f3650801c969a1e7157008f48ec475fc104867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a019df256c841ea063da3daa54e68fc4d32fbee4c86b48cc26b36187b31f716d00193a6ba27864ae120223f23f67c5266f3f0a3105a83a1bba2ea916447eb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6974a8df411a7c669eb395c5fa332ad37b6ebc3ca0741b4b1147224c7f4269204c6635eb6b5ec74f299b80b6981cdcad4853ddda61b88e3c78aaa6671b69b21d"} 06:50:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:50:00 INFO - Copying logs to upload dir... 06:50:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:50:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1432.005363 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 52 secs) (at 2016-11-15 06:50:00.195333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 06:50:00.199048) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ffde302073a057b5f95c975adaeab5577786a72ba1f3f1c8223802aa1d53e2ae51f471467112963cf72bd95f7f3650801c969a1e7157008f48ec475fc104867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a019df256c841ea063da3daa54e68fc4d32fbee4c86b48cc26b36187b31f716d00193a6ba27864ae120223f23f67c5266f3f0a3105a83a1bba2ea916447eb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6974a8df411a7c669eb395c5fa332ad37b6ebc3ca0741b4b1147224c7f4269204c6635eb6b5ec74f299b80b6981cdcad4853ddda61b88e3c78aaa6671b69b21d"} build_url:https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ffde302073a057b5f95c975adaeab5577786a72ba1f3f1c8223802aa1d53e2ae51f471467112963cf72bd95f7f3650801c969a1e7157008f48ec475fc104867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a019df256c841ea063da3daa54e68fc4d32fbee4c86b48cc26b36187b31f716d00193a6ba27864ae120223f23f67c5266f3f0a3105a83a1bba2ea916447eb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6974a8df411a7c669eb395c5fa332ad37b6ebc3ca0741b4b1147224c7f4269204c6635eb6b5ec74f299b80b6981cdcad4853ddda61b88e3c78aaa6671b69b21d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 06:50:00.224410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:50:00.224783) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479219966.344547-616811657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:50:00.310672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 06:50:00.311227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 06:50:00.311553) ========= ========= Total master_lag: 0.16 =========