builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1479219843.42 results: success (0) buildid: 20161115050514 builduid: 7547e53e3d4e473b80943fef03480bc2 revision: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.422478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.427116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.427492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.444170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.444558) ========= 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=0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 06:24:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-11-15 06:24:03 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.559667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.560045) ========= 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=0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019034 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:03.613422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 06:24:03.613854) ========= 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=0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 06:24:03,926 truncating revision to first 12 chars 2016-11-15 06:24:03,926 Setting DEBUG logging. 2016-11-15 06:24:03,926 attempt 1/10 2016-11-15 06:24:03,926 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:24:05,097 unpacking tar archive at: mozilla-central-fb3473c1770d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.491986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 06:24:05.120369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:05.120851) ========= script_repo_revision: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:05.121368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:05.121775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 06:24:05.132567) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-11-15 06:24:05.133143) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:05 INFO - MultiFileLogger online at 20161115 06:24:05 in /builds/slave/test 06:24:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:24:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:05 INFO - {'append_to_log': False, 06:24:05 INFO - 'base_work_dir': '/builds/slave/test', 06:24:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:24:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:05 INFO - 'branch': 'Firefox-Non-PGO', 06:24:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:05 INFO - 'config_files': ('talos/linux_config.py',), 06:24:05 INFO - 'default_actions': ('clobber', 06:24:05 INFO - 'read-buildbot-config', 06:24:05 INFO - 'download-and-extract', 06:24:05 INFO - 'populate-webroot', 06:24:05 INFO - 'create-virtualenv', 06:24:05 INFO - 'install', 06:24:05 INFO - 'run-tests'), 06:24:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:05 INFO - 'download_minidump_stackwalk': True, 06:24:05 INFO - 'download_symbols': 'ondemand', 06:24:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:05 INFO - 'installer_path': 'installer.exe', 06:24:05 INFO - 'log_level': 'info', 06:24:05 INFO - 'log_name': 'talos', 06:24:05 INFO - 'log_to_console': True, 06:24:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:05 INFO - 'opt_config_files': (), 06:24:05 INFO - 'pip_index': False, 06:24:05 INFO - 'sps_profile': False, 06:24:05 INFO - 'sps_profile_interval': 0, 06:24:05 INFO - 'suite': 'dromaeojs', 06:24:05 INFO - 'system_bits': '32', 06:24:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:05 INFO - 'title': 'talos-linux64-ix-017', 06:24:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:05 INFO - 'use_talos_json': True, 06:24:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:05 INFO - 'work_dir': 'build'} 06:24:05 INFO - [mozharness: 2016-11-15 14:24:05.548885Z] Running clobber step. 06:24:05 INFO - Running pre-action listener: _resource_record_pre_action 06:24:05 INFO - Running main action method: clobber 06:24:05 INFO - rmtree: /builds/slave/test/build 06:24:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:06 INFO - Running post-action listener: _resource_record_post_action 06:24:06 INFO - [mozharness: 2016-11-15 14:24:06.018122Z] Finished clobber step (success) 06:24:06 INFO - [mozharness: 2016-11-15 14:24:06.018223Z] Running read-buildbot-config step. 06:24:06 INFO - Running pre-action listener: _resource_record_pre_action 06:24:06 INFO - Running main action method: read_buildbot_config 06:24:06 INFO - Using buildbot properties: 06:24:06 INFO - { 06:24:06 INFO - "project": "", 06:24:06 INFO - "product": "firefox", 06:24:06 INFO - "script_repo_revision": "production", 06:24:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:24:06 INFO - "repository": "", 06:24:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:24:06 INFO - "buildid": "20161115050514", 06:24:06 INFO - "pgo_build": "False", 06:24:06 INFO - "basedir": "/builds/slave/test", 06:24:06 INFO - "buildnumber": 302, 06:24:06 INFO - "slavename": "talos-linux64-ix-017", 06:24:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:24:06 INFO - "platform": "ubuntu64_hw", 06:24:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:24:06 INFO - "branch": "mozilla-central", 06:24:06 INFO - "repo_path": "mozilla-central", 06:24:06 INFO - "revision": "fb3473c1770d3dace1ec09dfbb574fabe7cb26b1", 06:24:06 INFO - "stage_platform": "linux64", 06:24:06 INFO - "builduid": "7547e53e3d4e473b80943fef03480bc2", 06:24:06 INFO - "slavebuilddir": "test" 06:24:06 INFO - } 06:24:06 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:24:06 INFO - Running post-action listener: _resource_record_post_action 06:24:06 INFO - [mozharness: 2016-11-15 14:24:06.020749Z] Finished read-buildbot-config step (success) 06:24:06 INFO - [mozharness: 2016-11-15 14:24:06.020837Z] Running download-and-extract step. 06:24:06 INFO - Running pre-action listener: _resource_record_pre_action 06:24:06 INFO - Running main action method: download_and_extract 06:24:06 INFO - mkdir: /builds/slave/test/build/tests 06:24:06 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:24:06 INFO - trying https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:24:06 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:24:06 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:24:06 INFO - Downloaded 1361 bytes. 06:24:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:24:06 INFO - Using the following test package requirements: 06:24:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:24:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'jsshell-linux-x86_64.zip'], 06:24:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:24:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:24:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24:06 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:24:06 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:24:06 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:24:07 INFO - retry: attempt #1 caught exception: HTTP Error 503: Service Unavailable 06:24:07 INFO - retry: Failed, sleeping 60 seconds before retrying 06:25:07 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:25:07 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:25:07 INFO - retry: attempt #2 caught exception: HTTP Error 503: Service Unavailable 06:25:07 INFO - retry: Failed, sleeping 120 seconds before retrying 06:27:07 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:27:07 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:08 INFO - retry: attempt #3 caught exception: HTTP Error 503: Service Unavailable 06:27:08 INFO - retry: Failed, sleeping 240 seconds before retrying 06:31:08 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 #4 06:31:08 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:31:09 INFO - Http code: 200 06:31:09 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 06:31:09 INFO - x-amz-cf-id: X60pIBVGv2LnOZq8l-DYCZMThFrpvI8wHMdUfDFK3VihhUD6RHb9cg== 06:31:09 INFO - x-amz-version-id: OklOh45hfGaAYLP4i_arrcPb5z2_Dj0n 06:31:09 INFO - Expected file size: 20416553 06:31:09 INFO - Obtained file size: 20416553 06:31:13 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:31:13 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:31:13 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:31:13 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:31:13 INFO - Http code: 200 06:31:13 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 06:31:13 INFO - x-amz-cf-id: T2DKB5ZgD7MLUYt-g4SxvWep9l3ZOgTW6UM-fBIePWTJGL8-SXiF_A== 06:31:13 INFO - x-amz-version-id: OklOh45hfGaAYLP4i_arrcPb5z2_Dj0n 06:31:14 INFO - Expected file size: 20416553 06:31:14 INFO - Obtained file size: 20416553 06:31:18 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:31:18 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:31:18 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:31:19 INFO - Http code: 200 06:31:19 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 06:31:19 INFO - x-amz-cf-id: pB_wa4EufWMWIG9R5L-SnrXg9DfTVcQtL_wqtzJbIn8pzelOxzEBuQ== 06:31:19 INFO - x-amz-version-id: W_YIJdTYN_JCf_fkxjc7Yp2_ENZTXvMZ 06:31:19 INFO - Expected file size: 14409038 06:31:19 INFO - Obtained file size: 14409038 06:31:19 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:31:19 INFO - trying https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:31:19 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:31:19 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:31:20 INFO - Downloaded 55710949 bytes. 06:31:20 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:31:20 INFO - mkdir: /builds/slave/test/properties 06:31:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:31:20 INFO - Writing to file /builds/slave/test/properties/build_url 06:31:20 INFO - Contents: 06:31:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Xs3RM1PTRqyVm0uNQZYHpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:31:21 INFO - Running post-action listener: _resource_record_post_action 06:31:21 INFO - Running post-action listener: set_extra_try_arguments 06:31:21 INFO - [mozharness: 2016-11-15 14:31:21.511339Z] Finished download-and-extract step (success) 06:31:21 INFO - [mozharness: 2016-11-15 14:31:21.511566Z] Running populate-webroot step. 06:31:21 INFO - Running pre-action listener: _resource_record_pre_action 06:31:21 INFO - Running main action method: populate_webroot 06:31:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:31:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:31:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:31:21 INFO - '--tppagecycles', 06:31:21 INFO - '7'], 06:31:21 INFO - 'tests': ['tsvgm']}}, 06:31:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:31:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:31:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:31:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:31:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['damp', 'tps']}, 06:31:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'tests': ['damp', 'tps']}, 06:31:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['dromaeo_dom']}, 06:31:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:31:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['basic_compositor_video']}, 06:31:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:31:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['a11yr', 06:31:21 INFO - 'ts_paint', 06:31:21 INFO - 'tpaint', 06:31:21 INFO - 'sessionrestore', 06:31:21 INFO - 'sessionrestore_no_auto_restore', 06:31:21 INFO - 'tabpaint']}, 06:31:21 INFO - 'other-e10s': {'tests': ['a11yr', 06:31:21 INFO - 'ts_paint', 06:31:21 INFO - 'tpaint', 06:31:21 INFO - 'sessionrestore', 06:31:21 INFO - 'sessionrestore_no_auto_restore', 06:31:21 INFO - 'tabpaint']}, 06:31:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:31:21 INFO - 'ts_paint', 06:31:21 INFO - 'tpaint', 06:31:21 INFO - 'sessionrestore', 06:31:21 INFO - 'sessionrestore_no_auto_restore', 06:31:21 INFO - 'tabpaint']}, 06:31:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:31:21 INFO - 'ts_paint', 06:31:21 INFO - 'tpaint', 06:31:21 INFO - 'sessionrestore', 06:31:21 INFO - 'sessionrestore_no_auto_restore', 06:31:21 INFO - 'tabpaint']}, 06:31:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['a11yr', 06:31:21 INFO - 'ts_paint', 06:31:21 INFO - 'tpaint', 06:31:21 INFO - 'sessionrestore', 06:31:21 INFO - 'sessionrestore_no_auto_restore', 06:31:21 INFO - 'tabpaint']}, 06:31:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['a11yr', 06:31:21 INFO - 'ts_paint', 06:31:21 INFO - 'tpaint', 06:31:21 INFO - 'sessionrestore', 06:31:21 INFO - 'sessionrestore_no_auto_restore', 06:31:21 INFO - 'tabpaint']}, 06:31:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['tsvgx', 06:31:21 INFO - 'tsvgr_opacity', 06:31:21 INFO - 'tart', 06:31:21 INFO - 'tscrollx', 06:31:21 INFO - 'cart']}, 06:31:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:31:21 INFO - 'tsvgr_opacity', 06:31:21 INFO - 'tart', 06:31:21 INFO - 'tscrollx', 06:31:21 INFO - 'cart']}, 06:31:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'talos_options': ['--disable-e10s'], 06:31:21 INFO - 'tests': ['tp5o']}, 06:31:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'tests': ['tp5o']}, 06:31:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'talos_options': ['--disable-e10s', 06:31:21 INFO - '--xperf_path', 06:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:21 INFO - 'tests': ['tp5n']}, 06:31:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:21 INFO - 'talos_options': ['--xperf_path', 06:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:21 INFO - 'tests': ['tp5n']}}, 06:31:21 INFO - 'talos.zip': {'path': '', 06:31:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:31:21 INFO - Running post-action listener: _resource_record_post_action 06:31:21 INFO - [mozharness: 2016-11-15 14:31:21.528558Z] Finished populate-webroot step (success) 06:31:21 INFO - [mozharness: 2016-11-15 14:31:21.528646Z] Running create-virtualenv step. 06:31:21 INFO - Running pre-action listener: _resource_record_pre_action 06:31:21 INFO - Running main action method: create_virtualenv 06:31:21 INFO - Creating virtualenv /builds/slave/test/build/venv 06:31:21 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:31:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:31:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:31:21 INFO - Using real prefix '/usr' 06:31:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:31:22 INFO - Installing distribute.............................................................................................................................................................................................done. 06:31:24 INFO - Installing pip.................done. 06:31:24 INFO - Return code: 0 06:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:31:24 INFO - Reading from file tmpfile_stdout 06:31:24 INFO - Output received: 06:31:24 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:31:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:31: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:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:24 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:24 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:31:24 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:31:24 INFO - Using env: {'DISPLAY': ':0', 06:31:24 INFO - 'HOME': '/home/cltbld', 06:31:24 INFO - 'LANG': 'en_US.UTF-8', 06:31:24 INFO - 'LANGUAGE': 'en_US:en', 06:31:24 INFO - 'LOGNAME': 'cltbld', 06:31:24 INFO - 'MAIL': '/var/mail/cltbld', 06:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:24 INFO - 'MOZ_NO_REMOTE': '1', 06:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:24 INFO - 'NO_EM_RESTART': '1', 06:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:24 INFO - 'PWD': '/builds/slave/test', 06:31:24 INFO - 'SHELL': '/bin/bash', 06:31:24 INFO - 'SHLVL': '1', 06:31:24 INFO - 'TERM': 'linux', 06:31:24 INFO - 'TMOUT': '86400', 06:31:24 INFO - 'USER': 'cltbld', 06:31:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:24 INFO - '_': '/tools/buildbot/bin/python'} 06:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:24 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:31:24 INFO - Cleaning up... 06:31:24 INFO - Return code: 0 06:31:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:31: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:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:24 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:24 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:31:24 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:31:24 INFO - Using env: {'DISPLAY': ':0', 06:31:24 INFO - 'HOME': '/home/cltbld', 06:31:24 INFO - 'LANG': 'en_US.UTF-8', 06:31:24 INFO - 'LANGUAGE': 'en_US:en', 06:31:24 INFO - 'LOGNAME': 'cltbld', 06:31:24 INFO - 'MAIL': '/var/mail/cltbld', 06:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:24 INFO - 'MOZ_NO_REMOTE': '1', 06:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:24 INFO - 'NO_EM_RESTART': '1', 06:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:24 INFO - 'PWD': '/builds/slave/test', 06:31:24 INFO - 'SHELL': '/bin/bash', 06:31:24 INFO - 'SHLVL': '1', 06:31:24 INFO - 'TERM': 'linux', 06:31:24 INFO - 'TMOUT': '86400', 06:31:24 INFO - 'USER': 'cltbld', 06:31:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:24 INFO - '_': '/tools/buildbot/bin/python'} 06:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:24 INFO - Downloading/unpacking psutil>=3.1.1 06:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:31:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:26 INFO - Installing collected packages: psutil 06:31:26 INFO - Running setup.py install for psutil 06:31:26 INFO - building 'psutil._psutil_linux' extension 06:31:26 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:31:27 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:31:27 INFO - building 'psutil._psutil_posix' extension 06:31:27 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:31:27 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:31:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:27 INFO - Successfully installed psutil 06:31:27 INFO - Cleaning up... 06:31:27 INFO - Return code: 0 06:31:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:31:27 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:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:27 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:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:27 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:27 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:31:27 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:31:27 INFO - Using env: {'DISPLAY': ':0', 06:31:27 INFO - 'HOME': '/home/cltbld', 06:31:27 INFO - 'LANG': 'en_US.UTF-8', 06:31:27 INFO - 'LANGUAGE': 'en_US:en', 06:31:27 INFO - 'LOGNAME': 'cltbld', 06:31:27 INFO - 'MAIL': '/var/mail/cltbld', 06:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:27 INFO - 'MOZ_NO_REMOTE': '1', 06:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:27 INFO - 'NO_EM_RESTART': '1', 06:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:27 INFO - 'PWD': '/builds/slave/test', 06:31:27 INFO - 'SHELL': '/bin/bash', 06:31:27 INFO - 'SHLVL': '1', 06:31:27 INFO - 'TERM': 'linux', 06:31:27 INFO - 'TMOUT': '86400', 06:31:27 INFO - 'USER': 'cltbld', 06:31:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:27 INFO - '_': '/tools/buildbot/bin/python'} 06:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:31:29 INFO - Installing collected packages: mozsystemmonitor 06:31:29 INFO - Running setup.py install for mozsystemmonitor 06:31:29 INFO - Successfully installed mozsystemmonitor 06:31:29 INFO - Cleaning up... 06:31:29 INFO - Return code: 0 06:31:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:31: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:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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', '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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:31: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 jsonschema==2.5.1 06:31:29 INFO - Using env: {'DISPLAY': ':0', 06:31:29 INFO - 'HOME': '/home/cltbld', 06:31:29 INFO - 'LANG': 'en_US.UTF-8', 06:31:29 INFO - 'LANGUAGE': 'en_US:en', 06:31:29 INFO - 'LOGNAME': 'cltbld', 06:31:29 INFO - 'MAIL': '/var/mail/cltbld', 06:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:29 INFO - 'MOZ_NO_REMOTE': '1', 06:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:29 INFO - 'NO_EM_RESTART': '1', 06:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:29 INFO - 'PWD': '/builds/slave/test', 06:31:29 INFO - 'SHELL': '/bin/bash', 06:31:29 INFO - 'SHLVL': '1', 06:31:29 INFO - 'TERM': 'linux', 06:31:29 INFO - 'TMOUT': '86400', 06:31:29 INFO - 'USER': 'cltbld', 06:31:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:29 INFO - '_': '/tools/buildbot/bin/python'} 06:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:29 INFO - Downloading/unpacking jsonschema==2.5.1 06:31: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:31: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:31: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:31: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:31: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:31: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:31:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:32 INFO - warning: no files found matching '*.txt' 06:31:32 INFO - no previously-included directories found matching 'build' 06:31:32 INFO - no previously-included directories found matching 'dist' 06:31:32 INFO - no previously-included directories found matching '.git*' 06:31:32 INFO - Installing collected packages: jsonschema, functools32 06:31:32 INFO - Running setup.py install for functools32 06:31:32 INFO - warning: no files found matching '*.txt' 06:31:32 INFO - no previously-included directories found matching 'build' 06:31:32 INFO - no previously-included directories found matching 'dist' 06:31:32 INFO - no previously-included directories found matching '.git*' 06:31:32 INFO - Successfully installed jsonschema functools32 06:31:32 INFO - Cleaning up... 06:31:32 INFO - Return code: 0 06:31:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:31:32 INFO - Using env: {'DISPLAY': ':0', 06:31:32 INFO - 'HOME': '/home/cltbld', 06:31:32 INFO - 'LANG': 'en_US.UTF-8', 06:31:32 INFO - 'LANGUAGE': 'en_US:en', 06:31:32 INFO - 'LOGNAME': 'cltbld', 06:31:32 INFO - 'MAIL': '/var/mail/cltbld', 06:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:32 INFO - 'MOZ_NO_REMOTE': '1', 06:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:32 INFO - 'NO_EM_RESTART': '1', 06:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:32 INFO - 'PWD': '/builds/slave/test', 06:31:32 INFO - 'SHELL': '/bin/bash', 06:31:32 INFO - 'SHLVL': '1', 06:31:32 INFO - 'TERM': 'linux', 06:31:32 INFO - 'TMOUT': '86400', 06:31:32 INFO - 'USER': 'cltbld', 06:31:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:32 INFO - '_': '/tools/buildbot/bin/python'} 06:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:31:32 INFO - Cleaning up... 06:31:32 INFO - Return code: 0 06:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:31:32 INFO - Using env: {'DISPLAY': ':0', 06:31:32 INFO - 'HOME': '/home/cltbld', 06:31:32 INFO - 'LANG': 'en_US.UTF-8', 06:31:32 INFO - 'LANGUAGE': 'en_US:en', 06:31:32 INFO - 'LOGNAME': 'cltbld', 06:31:32 INFO - 'MAIL': '/var/mail/cltbld', 06:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:32 INFO - 'MOZ_NO_REMOTE': '1', 06:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:32 INFO - 'NO_EM_RESTART': '1', 06:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:32 INFO - 'PWD': '/builds/slave/test', 06:31:32 INFO - 'SHELL': '/bin/bash', 06:31:32 INFO - 'SHLVL': '1', 06:31:32 INFO - 'TERM': 'linux', 06:31:32 INFO - 'TMOUT': '86400', 06:31:32 INFO - 'USER': 'cltbld', 06:31:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:32 INFO - '_': '/tools/buildbot/bin/python'} 06:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:31: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:31: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:31: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:31: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:31: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:31: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:31:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:31:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:31: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:31: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:31: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:31: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:31: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:31: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:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:31:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:31:35 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:31:35 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:31:35 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:31:35 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:31:35 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:31:35 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:31:35 INFO - Downloading docopt-0.6.1.tar.gz 06:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:31:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:31:35 INFO - Running setup.py install for blobuploader 06:31:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:31:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:31:35 INFO - Running setup.py install for requests 06:31:36 INFO - Running setup.py install for docopt 06:31:36 INFO - Successfully installed blobuploader requests docopt 06:31:36 INFO - Cleaning up... 06:31:36 INFO - Return code: 0 06:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31: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:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:36 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:36 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:31:36 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:31:36 INFO - Using env: {'DISPLAY': ':0', 06:31:36 INFO - 'HOME': '/home/cltbld', 06:31:36 INFO - 'LANG': 'en_US.UTF-8', 06:31:36 INFO - 'LANGUAGE': 'en_US:en', 06:31:36 INFO - 'LOGNAME': 'cltbld', 06:31:36 INFO - 'MAIL': '/var/mail/cltbld', 06:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:36 INFO - 'MOZ_NO_REMOTE': '1', 06:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:36 INFO - 'NO_EM_RESTART': '1', 06:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:36 INFO - 'PWD': '/builds/slave/test', 06:31:36 INFO - 'SHELL': '/bin/bash', 06:31:36 INFO - 'SHLVL': '1', 06:31:36 INFO - 'TERM': 'linux', 06:31:36 INFO - 'TMOUT': '86400', 06:31:36 INFO - 'USER': 'cltbld', 06:31:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:36 INFO - '_': '/tools/buildbot/bin/python'} 06:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:36 INFO - Running setup.py (path:/tmp/pip-v6Z8cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:36 INFO - Running setup.py (path:/tmp/pip-s2uLX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:36 INFO - Running setup.py (path:/tmp/pip-uV6Pge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:36 INFO - Running setup.py (path:/tmp/pip-h5pEff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:36 INFO - Running setup.py (path:/tmp/pip-ZTo4PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:36 INFO - Running setup.py (path:/tmp/pip-KtKA5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:36 INFO - Running setup.py (path:/tmp/pip-o9Wplb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:36 INFO - Running setup.py (path:/tmp/pip-0RPdtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:36 INFO - Running setup.py (path:/tmp/pip-0DW_fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:37 INFO - Running setup.py (path:/tmp/pip-BYft_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:37 INFO - Running setup.py (path:/tmp/pip-Q237ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:37 INFO - Running setup.py (path:/tmp/pip-xQdtGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:37 INFO - Running setup.py (path:/tmp/pip-OXlPjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:37 INFO - Running setup.py (path:/tmp/pip-6gwdv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:37 INFO - Running setup.py (path:/tmp/pip-DxIUmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:37 INFO - Running setup.py (path:/tmp/pip-pxPbeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:37 INFO - Running setup.py (path:/tmp/pip-lqwEFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:31:37 INFO - Running setup.py install for manifestparser 06:31:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:31:37 INFO - Running setup.py install for mozcrash 06:31:37 INFO - Running setup.py install for mozdebug 06:31:37 INFO - Running setup.py install for mozdevice 06:31:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Running setup.py install for mozfile 06:31:38 INFO - Running setup.py install for mozhttpd 06:31:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Running setup.py install for mozinfo 06:31:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Running setup.py install for mozInstall 06:31:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Running setup.py install for mozleak 06:31:38 INFO - Running setup.py install for mozlog 06:31:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Running setup.py install for moznetwork 06:31:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Running setup.py install for mozprocess 06:31:38 INFO - Running setup.py install for mozprofile 06:31:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:31:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:31:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:31:39 INFO - Running setup.py install for mozrunner 06:31:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:31:39 INFO - Running setup.py install for mozscreenshot 06:31:39 INFO - Running setup.py install for moztest 06:31:39 INFO - Running setup.py install for mozversion 06:31:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:31:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:31:39 INFO - Cleaning up... 06:31:39 INFO - Return code: 0 06:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:39 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:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:39 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:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:39 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:39 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:31:39 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:31:39 INFO - Using env: {'DISPLAY': ':0', 06:31:39 INFO - 'HOME': '/home/cltbld', 06:31:39 INFO - 'LANG': 'en_US.UTF-8', 06:31:39 INFO - 'LANGUAGE': 'en_US:en', 06:31:39 INFO - 'LOGNAME': 'cltbld', 06:31:39 INFO - 'MAIL': '/var/mail/cltbld', 06:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:39 INFO - 'MOZ_NO_REMOTE': '1', 06:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:39 INFO - 'NO_EM_RESTART': '1', 06:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:39 INFO - 'PWD': '/builds/slave/test', 06:31:39 INFO - 'SHELL': '/bin/bash', 06:31:39 INFO - 'SHLVL': '1', 06:31:39 INFO - 'TERM': 'linux', 06:31:39 INFO - 'TMOUT': '86400', 06:31:39 INFO - 'USER': 'cltbld', 06:31:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:39 INFO - '_': '/tools/buildbot/bin/python'} 06:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:39 INFO - Running setup.py (path:/tmp/pip-YCPuKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:39 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:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:39 INFO - Running setup.py (path:/tmp/pip-zAuvcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:39 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:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:39 INFO - Running setup.py (path:/tmp/pip-V3ERvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:39 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:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:39 INFO - Running setup.py (path:/tmp/pip-2TrG5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:39 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:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:39 INFO - Running setup.py (path:/tmp/pip-zdCthG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:40 INFO - Running setup.py (path:/tmp/pip-Obw5Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:40 INFO - Running setup.py (path:/tmp/pip-LdFgid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:40 INFO - Running setup.py (path:/tmp/pip-Bbb4Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:40 INFO - Running setup.py (path:/tmp/pip-aOf0wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:40 INFO - Running setup.py (path:/tmp/pip-Ozvj7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:40 INFO - Running setup.py (path:/tmp/pip-2k_LTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:40 INFO - Running setup.py (path:/tmp/pip-WazHzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:40 INFO - Running setup.py (path:/tmp/pip-vdLYOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:40 INFO - Running setup.py (path:/tmp/pip-FmSMsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:40 INFO - Running setup.py (path:/tmp/pip-mKR1WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:40 INFO - Running setup.py (path:/tmp/pip-PkW0cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:40 INFO - Running setup.py (path:/tmp/pip-_R_cWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:40 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:31:40 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:31:40 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:31:40 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:31:40 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:31:40 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:31:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:40 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:31:40 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:31:40 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:31:40 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:31:40 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:31:40 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:31:42 INFO - Downloading blessings-1.6.tar.gz 06:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:42 INFO - Installing collected packages: blessings 06:31:42 INFO - Running setup.py install for blessings 06:31:43 INFO - Successfully installed blessings 06:31:43 INFO - Cleaning up... 06:31:43 INFO - Return code: 0 06:31:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:43 INFO - Reading from file tmpfile_stdout 06:31:43 INFO - Current package versions: 06:31:43 INFO - argparse == 1.2.1 06:31:43 INFO - blessings == 1.6 06:31:43 INFO - blobuploader == 1.2.4 06:31:43 INFO - docopt == 0.6.1 06:31:43 INFO - functools32 == 3.2.3-2 06:31:43 INFO - jsonschema == 2.5.1 06:31:43 INFO - manifestparser == 1.1 06:31:43 INFO - mozInstall == 1.12 06:31:43 INFO - mozcrash == 1.0 06:31:43 INFO - mozdebug == 0.1 06:31:43 INFO - mozdevice == 0.48 06:31:43 INFO - mozfile == 1.2 06:31:43 INFO - mozhttpd == 0.7 06:31:43 INFO - mozinfo == 0.9 06:31:43 INFO - mozleak == 0.1 06:31:43 INFO - mozlog == 3.4 06:31:43 INFO - moznetwork == 0.27 06:31:43 INFO - mozprocess == 0.23 06:31:43 INFO - mozprofile == 0.28 06:31:43 INFO - mozrunner == 6.13 06:31:43 INFO - mozscreenshot == 0.1 06:31:43 INFO - mozsystemmonitor == 0.3 06:31:43 INFO - moztest == 0.7 06:31:43 INFO - mozversion == 1.4 06:31:43 INFO - psutil == 3.1.1 06:31:43 INFO - requests == 1.2.3 06:31:43 INFO - wsgiref == 0.1.2 06:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31: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:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:43 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:43 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:31:43 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:31:43 INFO - Using env: {'DISPLAY': ':0', 06:31:43 INFO - 'HOME': '/home/cltbld', 06:31:43 INFO - 'LANG': 'en_US.UTF-8', 06:31:43 INFO - 'LANGUAGE': 'en_US:en', 06:31:43 INFO - 'LOGNAME': 'cltbld', 06:31:43 INFO - 'MAIL': '/var/mail/cltbld', 06:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:43 INFO - 'MOZ_NO_REMOTE': '1', 06:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:43 INFO - 'NO_EM_RESTART': '1', 06:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:43 INFO - 'PWD': '/builds/slave/test', 06:31:43 INFO - 'SHELL': '/bin/bash', 06:31:43 INFO - 'SHLVL': '1', 06:31:43 INFO - 'TERM': 'linux', 06:31:43 INFO - 'TMOUT': '86400', 06:31:43 INFO - 'USER': 'cltbld', 06:31:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:43 INFO - '_': '/tools/buildbot/bin/python'} 06:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 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:31:43 INFO - Cleaning up... 06:31:43 INFO - Return code: 0 06:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31: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:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:43 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 0x7fc342398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, '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': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', '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:31:43 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:31:43 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:31:43 INFO - Using env: {'DISPLAY': ':0', 06:31:43 INFO - 'HOME': '/home/cltbld', 06:31:43 INFO - 'LANG': 'en_US.UTF-8', 06:31:43 INFO - 'LANGUAGE': 'en_US:en', 06:31:43 INFO - 'LOGNAME': 'cltbld', 06:31:43 INFO - 'MAIL': '/var/mail/cltbld', 06:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:43 INFO - 'MOZ_NO_REMOTE': '1', 06:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:43 INFO - 'NO_EM_RESTART': '1', 06:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:43 INFO - 'PWD': '/builds/slave/test', 06:31:43 INFO - 'SHELL': '/bin/bash', 06:31:43 INFO - 'SHLVL': '1', 06:31:43 INFO - 'TERM': 'linux', 06:31:43 INFO - 'TMOUT': '86400', 06:31:43 INFO - 'USER': 'cltbld', 06:31:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:43 INFO - '_': '/tools/buildbot/bin/python'} 06:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:31:43 INFO - Cleaning up... 06:31:43 INFO - Return code: 0 06:31:43 INFO - Running post-action listener: _resource_record_post_action 06:31:43 INFO - Running post-action listener: _start_resource_monitoring 06:31:43 INFO - Starting resource monitoring. 06:31:43 INFO - [mozharness: 2016-11-15 14:31:43.830345Z] Finished create-virtualenv step (success) 06:31:43 INFO - [mozharness: 2016-11-15 14:31:43.830802Z] Running install step. 06:31:43 INFO - Running pre-action listener: _resource_record_pre_action 06:31:43 INFO - Running main action method: install 06:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:44 INFO - Reading from file tmpfile_stdout 06:31:44 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:44 INFO - Reading from file tmpfile_stdout 06:31:44 INFO - Output received: 06:31:44 INFO - Usage: mozinstall [options] installer 06:31:44 INFO - Options: 06:31:44 INFO - -h, --help show this help message and exit 06:31:44 INFO - -d DEST, --destination=DEST 06:31:44 INFO - Directory to install application into. [default: 06:31:44 INFO - "/builds/slave/test"] 06:31:44 INFO - --app=APP Application being installed. [default: firefox] 06:31:44 INFO - mkdir: /builds/slave/test/build/application 06:31:44 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:31:44 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:32:00 INFO - Reading from file tmpfile_stdout 06:32:00 INFO - Output received: 06:32:00 INFO - /builds/slave/test/build/application/firefox/firefox 06:32:00 INFO - Running post-action listener: _resource_record_post_action 06:32:00 INFO - [mozharness: 2016-11-15 14:32:00.200064Z] Finished install step (success) 06:32:00 INFO - [mozharness: 2016-11-15 14:32:00.200317Z] Running run-tests step. 06:32:00 INFO - Running pre-action listener: _resource_record_pre_action 06:32:00 INFO - Running main action method: run_tests 06:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:32:00 INFO - Python 2.7.3 06:32:00 INFO - Return code: 0 06:32:00 INFO - grabbing minidump binary from tooltool 06:32:00 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:32:00 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 0x29bff60>, '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 0x29c0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:32:00 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:32:00 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:32:00 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:32:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:32:00 INFO - Return code: 0 06:32:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:32:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:32:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:32:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:32:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:32:00 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', '--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-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:32:00 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 --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-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:32:00 INFO - Using env: {'DISPLAY': ':0', 06:32:00 INFO - 'HOME': '/home/cltbld', 06:32:00 INFO - 'LANG': 'en_US.UTF-8', 06:32:00 INFO - 'LANGUAGE': 'en_US:en', 06:32:00 INFO - 'LOGNAME': 'cltbld', 06:32:00 INFO - 'MAIL': '/var/mail/cltbld', 06:32:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:00 INFO - 'MOZ_NO_REMOTE': '1', 06:32:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:00 INFO - 'NO_EM_RESTART': '1', 06:32:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:00 INFO - 'PWD': '/builds/slave/test', 06:32:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:00 INFO - 'SHELL': '/bin/bash', 06:32:00 INFO - 'SHLVL': '1', 06:32:00 INFO - 'TERM': 'linux', 06:32:00 INFO - 'TMOUT': '86400', 06:32:00 INFO - 'USER': 'cltbld', 06:32:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816', 06:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:00 INFO - '_': '/tools/buildbot/bin/python'} 06:32:00 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', '--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-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:32:00 INFO - mozversion application_buildid: 20161115050514 06:32:00 INFO - mozversion application_changeset: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 06:32:00 INFO - mozversion application_display_name: Nightly 06:32:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:32:00 INFO - mozversion application_name: Firefox 06:32:00 INFO - mozversion application_remotingname: firefox 06:32:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:32:00 INFO - mozversion application_vendor: Mozilla 06:32:00 INFO - mozversion application_version: 53.0a1 06:32:00 INFO - mozversion platform_buildid: 20161115050514 06:32:00 INFO - mozversion platform_changeset: fb3473c1770d3dace1ec09dfbb574fabe7cb26b1 06:32:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:32:00 INFO - mozversion platform_version: 53.0a1 06:32:00 INFO - using testdate: 1479220320 06:32:00 INFO - actual date: 1479220320 06:32:00 INFO - starting webserver on 'localhost:39033' 06:32:00 INFO - SUITE-START | Running 2 tests 06:32:00 INFO - TEST-START | dromaeo_css 06:32:00 INFO - operating with platform_type : linux_ 06:32:00 INFO - Initialising browser for dromaeo_css test... 06:32:00 INFO - TEST-INFO | started process 5032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEwJE63/profile http://localhost:39033/getInfo.html) 06:32:04 INFO - PROCESS | 5032 | __metrics Screen width/height:1600/1200 06:32:04 INFO - PROCESS | 5032 | colorDepth:24 06:32:04 INFO - PROCESS | 5032 | Browser inner width/height: 1024/697 06:32:04 INFO - PROCESS | 5032 | __metrics 06:32:05 INFO - PROCESS | 5032 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:32:05 INFO - PROCESS | 5032 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:32:05 INFO - PROCESS | 5032 | console.error: PushService: 06:32:05 INFO - PROCESS | 5032 | stateChangeProcessEnqueue: Error transitioning state 06:32:05 INFO - PROCESS | 5032 | UnknownError 06:32:06 INFO - TEST-INFO | 5032: exit 0 06:32:06 INFO - Browser initialized. 06:32:06 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:06 INFO - TEST-INFO | started process 5117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEwJE63/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:18 INFO - PROCESS | 5117 | RSS: Main: 175304704 06:32:18 INFO - PROCESS | 5117 | 06:33:10 INFO - PROCESS | 5117 | 1479220390406 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:35:25 INFO - PROCESS | 5117 | Cycle 1(1): loaded http://localhost:39033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39033/tests/dromaeo/cssquery-ext.html) 06:35:27 INFO - PROCESS | 5117 | RSS: Main: 319975424 06:35:27 INFO - PROCESS | 5117 | 06:38:30 INFO - PROCESS | 5117 | Cycle 1(1): loaded http://localhost:39033/tests/dromaeo/cssquery-ext.html (next: http://localhost:39033/tests/dromaeo/cssquery-jquery.html) 06:38:30 INFO - PROCESS | 5117 | RSS: Main: 281939968 06:38:30 INFO - PROCESS | 5117 | 06:41:33 INFO - PROCESS | 5117 | Cycle 1(1): loaded http://localhost:39033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39033/tests/dromaeo/cssquery-mootools.html) 06:41:33 INFO - PROCESS | 5117 | RSS: Main: 220372992 06:41:33 INFO - PROCESS | 5117 | 06:44:35 INFO - PROCESS | 5117 | Cycle 1(1): loaded http://localhost:39033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39033/tests/dromaeo/cssquery-prototype.html) 06:44:36 INFO - PROCESS | 5117 | RSS: Main: 252846080 06:44:36 INFO - PROCESS | 5117 | 06:47:39 INFO - PROCESS | 5117 | Cycle 1(1): loaded http://localhost:39033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39033/tests/dromaeo/cssquery-yui.html) 06:47:40 INFO - PROCESS | 5117 | RSS: Main: 224088064 06:47:40 INFO - PROCESS | 5117 | 06:50:43 INFO - PROCESS | 5117 | Cycle 1(1): loaded http://localhost:39033/tests/dromaeo/cssquery-yui.html (next: http://localhost:39033/tests/dromaeo/cssquery-dojo.html) 06:50:44 INFO - PROCESS | 5117 | RSS: Main: 317419520 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | __start_tp_report 06:50:44 INFO - PROCESS | 5117 | _x_x_mozilla_page_load 06:50:44 INFO - PROCESS | 5117 | _x_x_mozilla_page_load_details 06:50:44 INFO - PROCESS | 5117 | |i|pagename|runs| 06:50:44 INFO - PROCESS | 5117 | |0;dojo.html;2595.7144714081455;2618.4108575570485;2632.02615032438;2651.231142968538;2666.2401215653545;4578.1301552705045;4637.489876113633;4721.527847215277;4729.668923175379;4733.7159770413755;4685.601723853468;4724.976375118128;4757;4789.2097803862325;4821.011692603017;4354.738715677054;4382.211201983641;4417.293233082707;4422.358757980091;4456.131054444385;4382.496012958519;4451.221036318648;4476.977615111936;4480.820767169309;4484.932726009112;4258.6380157686635;4405.427294451732;4428.977855110736;4447.710898791584;4532.116237333721;4280.850170244058;4350.477942646871;4355.107203023373;4358.629516491102;4359.302511598161;4307.461567304087;4321;4329.393884856123;4426.26966550522;4431.047324825146;4749;4752.691075080109;4753.429588449409;4755.239161734141;4815.374001379833;5083.618728595333;5086.872828179326;5098.923516147261;5099.847004589868;5147.330846989905;4915.3855768029;4982.252662100677;4988.077205716954;4998.700077995332;5046.19260918255;4702.952970470252;4706.458757242893;4713.316569097462;4753.35829662998;4762.690425122356;5151.6136289778415;5151.896962060738;5155.793768249228;5155.922661160085;5196.376434827769;4828.637852161031;4873.147199240189;4877.878053048631;4894;5003.324551185616;4994.825181118644;5023.974880125649;5025.6482046256415;5043.5965122790085;5064.620153488503;5016.072026675004;5059.367579052619;5066.06277838601;5097.057044446789;5101.974490127525;5058.822941197114;5065.8733531662;5067.46791586878;5070.442251352349;5132.56373208274;4233.449651545279;4405.295152775605;4415.845445409395;4421.469423669116;4447.865794222517;3763.774173549541;3780.2628487445236;3781.640744129303;3822.10180607557;3824.584903585691;4394.099209662011;4395.890102747457;4399.758013309235;4412.294032954712;4452.599266066005;5115.97442012795;5125.4874512549195;5127.282180494733;5130.999455106293;5174.197999310113;4300.311950087971;4320.373545835836;4343.04453020335;4355.477342718831;4365.017870979068;4619.376384188159;4620.53794620542;4622.121796858586;4644.210484217691;4654.371659825948;4743.573078422958;4753.263244197155;4754.857354279377;4781.593564547053;4793.784279707491;5001.524855138756;5065.822696205615;5066.265391518283;5071.77177027042;5079.974600126976;4706.34111224422;4753.287006948985;4753.405824271966;4788.425388953208;4817.686850354716;5011.223260394645;5021.573166280761;5022.096022715946;5023.874403139951;5060.1903695408555;5027.044861476308;5037.949620503748;5041.218611115283;5063.1898896176435;5106.080905437057;4773.522647735199;4774.069056534081;4820.566149046603;4872.244802055687;4890.24201248807;4852.636052296162;4875.341828853059;4879.926801098058;4881.780319885685;4882.096812089775;4807.326974223542;4809.182438985451;4811.807527698853;4820.132376172322;4852.927206091841;4995.300657907823;5041.445441001413;5049.384197057054;5085.898282034264;5089.949100508948;4925.679830810986;4936.7284799336385;4938.950610493993;4946.727929963887;4948.678335908155 06:50:44 INFO - PROCESS | 5117 | |1;ext.html;561.1330494386173;562.5471495446166;567.5998421113115;576.5358886096692;596.8209537138857;27238.591421128673;29866.850665746642;29920.850395748017;29946;36633;35043.2991340173;38962.22075558487;39005.609943900556;39030.804845975734;39094.99999999993;7545.170031296553;7674.309312161904;7682.807929801772;7691.8077048073965;7720.15078341382;7494.812629684274;7571.507851989603;7578.280063393969;7579.696812127509;7581.734639287626;7550.7734767957045;7595.886061709079;7599.772006839776;7600.923990760105;7604.087509498868;7531.171571127172;7557.206493318233;7558.546487210785;7569.280918312751;7570.091589009354;7620.428467864932;7670.923290767132;7673.11759147694;7679.961600192019;7680.500767450154;36460.63539364599;36675.26649466996;36742.81628591866;36814.447783283;36828.631713682786;2905.244636394553;3002.4445477586496;3059.72462478378;3063.326068264978;3131.4519959007084;27612;27796.30509237265;27832.443351133068;28224.435511289863;29335.2666183345;3408.8977330679872;3419.9658003420145;3428.674275943806;3448.3103379323984;3458.1354661334667;231890;232173;232686.9999999983;232699;232718;32164.678353216168;50350;50764;50781.144545486626;50809.49190508122;32243;32350.676493234765;32383.838080809917;32437;32439.35121297561;12792.360381980863;12861.742765144645;12880.871191288155;12888.742225155633;12892.80660790089;10676.412797296223;10679;10680.092192163753;10682.359058456517;10716.249862509549;7658.846823063619;7687.2697093776005;7725.9956205694025;7799.883001754978;7802.882956755653;3058.648255450607;3099.767517436201;3134.2164458885277;3141.1204862638497;3156.1320636825058;831.3349320543541;838.4550042472441;863.887694599698;880.3793325705362;883.7702197428587;26166.34584135412;26648.333791655365;27221.727782722315;27350.589741153897;27484.175474735788;747.6784982457596;935.9953200233955;945.281585994649;1012.8379459286479;1043.3426941027255;14301.28493575317;14303;14318.713625727427;14510.564683059314;14538.563843084725;365195;366803;366823;366877.47786482034;368904;47350.526494734615;47646.28530572044;47806.76096619495;47817.52182478131;47868.76065619649;1036.3522798251092;1069.9197560183018;1111.2665640677276;1130.3048625095507;1172.935488548121;26730.59904101479;28078.57882131729;28548.286292842844;29113.27216819512;29192.124236272946;40489.392659109544;41138.1772364545;41170;41224;41248.58751412568;282614;283591;283603;284021;284611;37555.248895022494;38252;38765.2246955065;39112.217755645295;41295.7935210322;37558.62441375551;38408.42387364136;40896.094822331484;41377.586224137376;41794.79102604467;34724.65275347214;34836.477452838735;35288;35528.822355888056;35568.28863422665;34628.826855866566;34965.825170873984;35028.64971350254;35145.47281790724;35396.64603354037;34035;34088.48867267043;34324;34440.48339274963;34517.309653807286;30197.849010754806;31925.36149277048;32369.51445728269;32629.18427039343;32708;24344.634830477913;24720;24762.25713228606;25337.113201037875;25398.365040874127 06:50:44 INFO - PROCESS | 5117 | |2;jquery.html;347.35565525949346;358.32276996476645;370.2982847503979;375.883476122402;389.3031473662145;12413.379331033446;12983.48066077357;14956.40174393023;15659.451919182831;15843.524694259162;13869.583912482616;13931.93034034831;14027.298635068257;14042;14069.71860562788;3921.784301863396;4765.714057156564;4802.303665968432;4945.480724523927;5047.47001564836;4911.778969946343;5005.499450055002;5007.273945277932;5008.073506401309;5011.323471331379;4757.310190022445;4919.360483137187;4978.128827455199;4984.725840078794;4985.700857948516;4904.950950490485;4948.87627809304;4952.529509696573;4961.975190124044;4962.280469331963;4293.5706429356815;4407.858479839921;4449.666275029385;4452.577005184502;4453.576910193527;18446.815531844644;18641.347552835723;18920;18942.905285473622;19170.520736981547;1804.6571151481176;1808.8010318864915;2047.3550831488183;2424.7211570669247;2469.6789417375808;11322.886771132347;11635.95900788344;12109.93945030278;12607.936960315232;12873.935630321883;1633.8366163383685;1663.7587549805332;1700.6513664698707;1724.9482515524555;1784.5666372726264;64054.359456405306;64795.28070789372;65527.67236163836;66902.33097669059;67775;8261.669533218725;8337.416380853403;8543.914560854437;8684.826303473896;8734.082921293173;11032.179690351002;11065.668029959113;11080.612178573872;11614;11707.239029463057;7192.3886469649615;7217.979185037968;7250.897239800504;7475.476716629783;7480.812979675443;6778.898316525256;6927.7228910843005;7187.460940429489;7259.9274007259255;7269.8546029079125;5125.64120511568;5364.1417373220875;5431.701256430855;5755.309362876482;6031.8793624127275;1631.7226071567861;1685.8398452147026;1772.2733679191726;1773.2463702926204;1833.1475863723433;758.8823732321499;843.4644001059249;892.4605056277999;893.8748575199477;895.9462432253955;15825.287862046236;15900.12549309799;16300.42948496797;16400.671986560203;17070;863.7754183912228;870.56906831119;899.7795540092719;900.6082354175954;928.6099838068028;9223.907760922304;9291.58187881547;9566.90433095674;9639.843218813787;9814.901850981541;342606;347029;351147;354333;354504;62924.37075629185;63080.684596577645;63777.36222637807;64303;65364;797.9202079792091;818.9099199088096;819.3281509162549;819.5779173725537;821.5440430560976;14526.983111182115;14542.345594448063;14595.635109122357;14667.266636668337;15214;33017.33965320728;33656.49515257322;33714.98855034353;34444.82777586096;34450.48324275088;41876.37185442282;42035.579644203164;42368;42586.57413425826;42651.7867410661;6478.1578394808375;6749.460043196631;6910;7050.753223637148;7111.359977602041;10267.640632577824;10465.529051192867;10555.824842467242;10729;11021.614243501439;8464.957675211585;8661.826763464822;8963.955180224057;9079.954600226956;9214.631414743335;9005.864912026456;9141.908580914105;9311.394759340621;9387.577559009724;9424.905750942677;9308.162265396148;9373.718788436357;9467.337286389886;9611.183049440875;9619.374740641835;6745.12313399255;6758.4931130166415;6900.861982760417;6920.30796920304;7083.2208457068655;8167;8912.73261802147;9235.953820230856;9354.97095319528;9520.952395237979 06:50:44 INFO - PROCESS | 5117 | |3;mootools.html;1313.034919334289;1346.293196072062;1377.2425166158616;1630.8450697183764;1637.2223193982852;6226.501879849612;6458.515611329146;6639.502037347194;7058.894116588255;7084.504084714072;6726.293739157391;6961.095057642512;6964.338387853159;7086.610236436994;7121.572705637665;2050.6411378008866;2079.334612923865;2079.9272025479113;2081.750189977205;2083.6353638113346;1774.8313910178513;1842.68674325365;1999.81011298278;2001.3395579458816;2012.1046134470166;1973.1614064022804;2049.5286084200643;2052.5586998795256;2071.2957594417894;2072.046858445117;2024.1498570600384;2061.701053347256;2078.2206672497814;2100.0654708654656;2101.8003289687454;1978.495483651674;1978.7526559180103;1993.880367177974;1999.720039194514;2003.3589251439546;7016;7159;7160.212376638566;7169.175544812361;7180.928190718078;4076.979615101935;4200.957990420118;4204.2432362174795;4210.242156411845;4210.9578904210875;2534.252395543319;2684.516856849047;2807.143821134553;2821.604975303459;2830.4622121796997;832.1262674192135;835.1898658301499;851.0425771007616;852.1691350932853;868.1492137705021;9535.47554884481;9540.045995400404;9571.473568953705;9573.664921727706;9592.472414017297;3538.221591249921;3727.4408838674417;3730.086128898383;3827.942580861289;3830.4254361845387;8078.8788168177525;8112.6349314281;8113.472624279403;8124.350051995826;8124.959375203086;4125.319322311845;4131.235721391552;4131.50421949368;4132.876013719593;4151.481064866892;3705.5923848376656;3800.0879788850475;3801.9619803801606;3806.6383693549624;3807.809609519513;3168.5722427472456;3195.792273502215;3229.8869539566003;3257.446234140202;3289.1612638777437;917.4724533393193;952.1430712358793;997.1922742578535;998.9650362237287;1018.7351288665001;741.7181471040969;759.1080480435467;795.4948607634078;824.7195953375762;868.2446271743497;4734.147853386424;4800.423949126127;5060.1903695408555;5070.721110338893;5106.336176297132;783.2637320918318;858.596195220806;859.776458120893;861.5347712235448;918.2883265469181;3355.8489867956;3409.1817963688536;3420.0936751760305;3421.4867769834723;3449.7930124192126;7981.561014144278;8263.421560490828;8418.242358187792;8516.318694504549;8533.871991920127;8460.78848028792;8463.36524760633;8475.237228649452;8480;8485.703000394957;6378.107065010902;6420.325865784119;6464.09502669636;6469.385408386196;6546.312637173123;4729.101470720552;4737.668363214542;4783.44990326103;4783.545563171493;4844.878878028077;7727.652255648397;7760.340371068297;7762.92237077622;7804.648790804314;7829.138794732688;7369.226231245856;7729.265719756614;7742.915991761271;7796.961015194887;7821.726239581587;6128.356522565066;6251.9062214067735;6255.374462553708;6263.718132683949;6264.812055638338;6598.637074960923;6636.469082473487;6642.103316052464;6643.036759669917;6666.733330666719;5261.237120617566;5947.078202878561;6097.908531372122;6140;6266.749330026748;5908.172855800105;5909.261342332208;5925.022371308858;6125.050617154348;6243.063540468966;5463.098588732814;5488.69812160335;5534.169874518854;5534.39121696605;5554.777808887599;4237.322028475429;4240.893977650583;4314.956850431456;4366.868993930188;4376.737395756265;4308.116836048665;4309.91380172401;4313.180495705806;4351.608355248043;4415.2494076006515 06:50:44 INFO - PROCESS | 5117 | |4;prototype.html;292.9311611771235;298.3570405775554;301.22434730568784;307.6016558556669;308.2540252588735;4734.431868175815;4825.975870120653;4868.075065737507;4902.65681402302;4942.999999999995;4666.393368862043;4769;4798.808047678089;4813.49458306878;4815.446223684277;3803.7717736935733;3816.9121800286925;3830.885073447787;3833.501644786174;3834.9424758628575;3531.7174626029982;3577.62434944331;3827.4067519534515;3842.654161125498;3846.961530384702;3677.834497447608;3801.657850793428;3810.1236715555438;3819.8663046793367;3828.7894165820867;3806.2197249563774;3807.428885667144;3825.464434979105;3827.9808600957094;3829.80850957451;3396;3397.5560386835496;3407.880724174642;3410.198603328216;3420.4698271767916;4638.0491999140095;4645.581897629229;4700.647451441156;4707.435107787088;4757.405324334458;4299.892502687427;4311.060022989635;4334.69959012295;4337.457817772778;4340.066885619575;5004.599632029465;5006.6245031622775;5011;5018.673786203922;5024.19612861944;3381.611114721814;3551.8401671924566;3676.246369494247;3682.5396825396824;3694.3534881395917;5254.264402983586;5256.237845512417;5256.553192978639;5258.684478931276;5260.368755749335;3604.3151801157696;3605.7656252343513;3612.7290453216115;3621.311950729353;3629.564452265745;3655.1541471556693;3660.926781464356;3665.9266814663556;3673.3020726062496;3685.8894233173046;4012.558618551957;4159.9600099975005;4188.727732697365;4200.516940551875;4250.744955302692;4969.2546118081855;5022.246663000579;5023.924641130386;5032.093708634053;5047.798088076436;1170.6136974798296;1195.8744331845205;1241.5654520917788;1245.6761242077125;1252.1780808922995;814.3444527155697;833.737372727601;837.1837458477935;840.2018082821344;844.7118144829062;4335.523092459827;4336.739795612273;4348.434703488526;4358.430964852714;4372.846950356722;5031.23906632683;5041.638757535445;5068.847934561895;5074.695518268842;5098.107831129538;4198.6641068714425;4322.524522302544;4326.913461730748;4346.326319420495;4381.78091095444;2652.323657467372;2673.385121422084;2677.799165062628;2684.1813246959473;2701.689305729827;4708.246680531167;4712.693674911188;4730.148573256847;4734.313524538922;4742.4309082909585;4901.411830580353;5098.980203959223;5124.231365295235;5141.948580514222;5157.613179011589;4653.74238033378;4682.267561002451;4686.5629872466125;4699.906001880012;4709.621641071169;5022.755771373184;5032.194848824171;5050.595952323879;5061.544460998528;5069.718626617963;4904.950950490449;4949.109160351028;5206;5210.374755029421;5236.869078273074;4917.434495033117;4918.458969513422;4926.630502712239;4932.21084626458;4932.802687892444;3800.6959443243923;3817.866374676984;3826.3877779555137;3828.7128465364653;3834.8466061357235;5050.444451110448;5191.402988656353;5226.771708648541;5235.921461178009;5284.894302113859;5035.370578677665;5059.544640982329;5065.696058236517;5066.214736715815;5068.518490743373;5018.4981501849525;5021.949780502295;5113.616478764182;5117.769700363418;5123.205903085028;4757.643176761688;4794.688345257687;5013.373328333958;5020.24696295544;5030.798768049237;4952.975235123801;5009.649324547247;5123.743812809419;5127.230915362726;5132.127538318569;5004.074246264453;5020.523050310215;5021.623378246573;5022;5023.246513023076 06:50:44 INFO - PROCESS | 5117 | |5;yui.html;642;684.1072400517326;713.8429545499988;725.3798002707684;739.7854622159574;11721.648350549476;12503;12620.495180192804;12664.366781660927;12672;11813.350265735382;11962.700932476671;11972.28166310022;11974.34141122238;11981.10141739371;605.3976293587887;623.815974287584;741.0921621014269;750.5571712689513;756.3079781999464;754.5397307642361;754.935830454412;758.3743411685354;759.7758661194933;759.7986533568609;799.5083023940293;799.8440304140695;800.4316934976174;800.8478389106051;801.4550105927966;636.710296814948;651.2152855808787;794.051108924835;794.1899262751961;794.3922898982283;570.3839852958795;586.6216290492652;586.6685322792608;587.9294484661868;589.3134498309464;11759.7060073498;11775.175737698364;11782.646520604396;11799.764004719858;11806.40967951599;11174.608888688937;11269.323840569592;11282.887171128266;11320.660380188607;11727.824082638683;9644.951775241148;9811.411315321104;10561.155107591374;10601.151907847354;10738.08726258269;3977.482927219472;4033.1127152026506;4042.413849991735;4117.505899292074;4201.474815648044;41525.37711934323;43097.35353969693;43161.35257971133;47744.28383574214;48241.75879120617;9512.90487095134;9628.90371096294;9719.83361996565;9845.80308393828;9901.603935842486;16676.91661541709;16800.579985500215;16805;16838.747418788727;16861.578460538585;6303.684815759194;6350.396712312416;6402.199725034371;6447.838804029937;6551.80344589663;3500.212452198235;3527.4356103023392;3559.519464872261;3594.7483676142942;3630.1832087780567;2634.9077782277527;2680.798940079502;2733.562629979194;2736.233854520737;2737.3293543082073;466.5031741195616;467.55115089513765;467.99766001169775;479.20452049597503;482.6910777102657;561.2871653000748;571.2488078177183;581.2124571205956;589.19280585598;601.59392410123;7292.838581853998;7395.445341599401;7531.096268447822;7662.272084152108;7811.101723301779;479.928010798383;522.7219448448507;559.683778665053;565.366789196103;580.2833500626723;3437.2781715839956;3572.7052468522797;3693.686036686858;3759.887203383903;3856.903577410531;53098.73450632722;68774;69008.4090750017;75155.24844751591;75471.24528754642;36386.09034774099;36398.63601363952;44219.11561768811;61775.38224617696;62252.688736556025;55294.44705552974;56003.719981400645;57549.712251438476;59336.40663593309;59487.40512594905;7004.299570042955;7202.495825292389;7288.08898887639;7419.888701669587;7550.848983020419;36604.63395366012;38140;38732.2253554933;39122.413163802;39344.2131157381;45878.54121458743;54433;54773.72613136909;55335.723321383135;55956.44043559513;9283.814323713623;9535.760351154306;9657.661981830603;10330.535125919501;10518.421486817992;11423.086153107564;11769.411529423665;11945.462454189408;12410;12503.87496125027;11089.5564177432;11750.118741094622;11792.115591330514;12079.818802718142;12477.812832807334;11070.612528561462;11742.119341049285;11806.881931180922;11820.172587918763;11892.76214475723;10114.29199955996;10134.847977280198;10190;10579.418132002813;10703.518341674799;8785.780355491164;9227.76930576741;9303.302252331237;9468.14786669203;9509.857352139585;9018.413803102778;9497.667581634609;9564.378315409476;9580.808383832424;9636.903630963881 06:50:44 INFO - PROCESS | 5117 | __end_tp_report 06:50:44 INFO - PROCESS | 5117 | __start_cc_report 06:50:44 INFO - PROCESS | 5117 | _x_x_mozilla_cycle_collect,1507 06:50:44 INFO - PROCESS | 5117 | __end_cc_report 06:50:44 INFO - PROCESS | 5117 | __startTimestamp1479221444031__endTimestamp 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | ------- Summary: start ------- 06:50:44 INFO - PROCESS | 5117 | Number of tests: 6 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | [#0] dojo.html Cycles:165 Average:4689.15 Median:4789.21 stddev:481.98 (10.1%) stddev-sans-first:454.62 06:50:44 INFO - PROCESS | 5117 | Values: 2595.7 2618.4 2632.0 2651.2 2666.2 4578.1 4637.5 4721.5 4729.7 4733.7 4685.6 4725.0 4757.0 4789.2 4821.0 4354.7 4382.2 4417.3 4422.4 4456.1 4382.5 4451.2 4477.0 4480.8 4484.9 4258.6 4405.4 4429.0 4447.7 4532.1 4280.9 4350.5 4355.1 4358.6 4359.3 4307.5 4321.0 4329.4 4426.3 4431.0 4749.0 4752.7 4753.4 4755.2 4815.4 5083.6 5086.9 5098.9 5099.8 5147.3 4915.4 4982.3 4988.1 4998.7 5046.2 4703.0 4706.5 4713.3 4753.4 4762.7 5151.6 5151.9 5155.8 5155.9 5196.4 4828.6 4873.1 4877.9 4894.0 5003.3 4994.8 5024.0 5025.6 5043.6 5064.6 5016.1 5059.4 5066.1 5097.1 5102.0 5058.8 5065.9 5067.5 5070.4 5132.6 4233.4 4405.3 4415.8 4421.5 4447.9 3763.8 3780.3 3781.6 3822.1 3824.6 4394.1 4395.9 4399.8 4412.3 4452.6 5116.0 5125.5 5127.3 5131.0 5174.2 4300.3 4320.4 4343.0 4355.5 4365.0 4619.4 4620.5 4622.1 4644.2 4654.4 4743.6 4753.3 4754.9 4781.6 4793.8 5001.5 5065.8 5066.3 5071.8 5080.0 4706.3 4753.3 4753.4 4788.4 4817.7 5011.2 5021.6 5022.1 5023.9 5060.2 5027.0 5037.9 5041.2 5063.2 5106.1 4773.5 4774.1 4820.6 4872.2 4890.2 4852.6 4875.3 4879.9 4881.8 4882.1 4807.3 4809.2 4811.8 4820.1 4852.9 4995.3 5041.4 5049.4 5085.9 5089.9 4925.7 4936.7 4939.0 4946.7 4948.7 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | [#1] ext.html Cycles:180 Average:43817.12 Median:34997.24 stddev:78863.88 (225.3%) stddev-sans-first:79018.24 06:50:44 INFO - PROCESS | 5117 | Values: 561.1 562.5 567.6 576.5 596.8 27238.6 29866.9 29920.9 29946.0 36633.0 35043.3 38962.2 39005.6 39030.8 39095.0 7545.2 7674.3 7682.8 7691.8 7720.2 7494.8 7571.5 7578.3 7579.7 7581.7 7550.8 7595.9 7599.8 7600.9 7604.1 7531.2 7557.2 7558.5 7569.3 7570.1 7620.4 7670.9 7673.1 7680.0 7680.5 36460.6 36675.3 36742.8 36814.4 36828.6 2905.2 3002.4 3059.7 3063.3 3131.5 27612.0 27796.3 27832.4 28224.4 29335.3 3408.9 3420.0 3428.7 3448.3 3458.1 231890.0 232173.0 232687.0 232699.0 232718.0 32164.7 50350.0 50764.0 50781.1 50809.5 32243.0 32350.7 32383.8 32437.0 32439.4 12792.4 12861.7 12880.9 12888.7 12892.8 10676.4 10679.0 10680.1 10682.4 10716.2 7658.8 7687.3 7726.0 7799.9 7802.9 3058.6 3099.8 3134.2 3141.1 3156.1 831.3 838.5 863.9 880.4 883.8 26166.3 26648.3 27221.7 27350.6 27484.2 747.7 936.0 945.3 1012.8 1043.3 14301.3 14303.0 14318.7 14510.6 14538.6 365195.0 366803.0 366823.0 366877.5 368904.0 47350.5 47646.3 47806.8 47817.5 47868.8 1036.4 1069.9 1111.3 1130.3 1172.9 26730.6 28078.6 28548.3 29113.3 29192.1 40489.4 41138.2 41170.0 41224.0 41248.6 282614.0 283591.0 283603.0 284021.0 284611.0 37555.2 38252.0 38765.2 39112.2 41295.8 37558.6 38408.4 40896.1 41377.6 41794.8 34724.7 34836.5 35288.0 35528.8 35568.3 34628.8 34965.8 35028.6 35145.5 35396.6 34035.0 34088.5 34324.0 34440.5 34517.3 30197.8 31925.4 32369.5 32629.2 32708.0 24344.6 24720.0 24762.3 25337.1 25398.4 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | [#2] jquery.html Cycles:180 Average:21911.26 Median:4962.13 stddev:57659.27 (1162.0%) stddev-sans-first:57798.29 06:50:44 INFO - PROCESS | 5117 | Values: 347.4 358.3 370.3 375.9 389.3 12413.4 12983.5 14956.4 15659.5 15843.5 13869.6 13931.9 14027.3 14042.0 14069.7 3921.8 4765.7 4802.3 4945.5 5047.5 4911.8 5005.5 5007.3 5008.1 5011.3 4757.3 4919.4 4978.1 4984.7 4985.7 4905.0 4948.9 4952.5 4962.0 4962.3 4293.6 4407.9 4449.7 4452.6 4453.6 18446.8 18641.3 18920.0 18942.9 19170.5 1804.7 1808.8 2047.4 2424.7 2469.7 11322.9 11636.0 12109.9 12607.9 12873.9 1633.8 1663.8 1700.7 1724.9 1784.6 64054.4 64795.3 65527.7 66902.3 67775.0 8261.7 8337.4 8543.9 8684.8 8734.1 11032.2 11065.7 11080.6 11614.0 11707.2 7192.4 7218.0 7250.9 7475.5 7480.8 6778.9 6927.7 7187.5 7259.9 7269.9 5125.6 5364.1 5431.7 5755.3 6031.9 1631.7 1685.8 1772.3 1773.2 1833.1 758.9 843.5 892.5 893.9 895.9 15825.3 15900.1 16300.4 16400.7 17070.0 863.8 870.6 899.8 900.6 928.6 9223.9 9291.6 9566.9 9639.8 9814.9 342606.0 347029.0 351147.0 354333.0 354504.0 62924.4 63080.7 63777.4 64303.0 65364.0 797.9 818.9 819.3 819.6 821.5 14527.0 14542.3 14595.6 14667.3 15214.0 33017.3 33656.5 33715.0 34444.8 34450.5 41876.4 42035.6 42368.0 42586.6 42651.8 6478.2 6749.5 6910.0 7050.8 7111.4 10267.6 10465.5 10555.8 10729.0 11021.6 8465.0 8661.8 8964.0 9080.0 9214.6 9005.9 9141.9 9311.4 9387.6 9424.9 9308.2 9373.7 9467.3 9611.2 9619.4 6745.1 6758.5 6900.9 6920.3 7083.2 8167.0 8912.7 9236.0 9355.0 9521.0 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | [#3] mootools.html Cycles:180 Average:4616.60 Median:5544.58 stddev:2507.60 (45.2%) stddev-sans-first:2502.34 06:50:44 INFO - PROCESS | 5117 | Values: 1313.0 1346.3 1377.2 1630.8 1637.2 6226.5 6458.5 6639.5 7058.9 7084.5 6726.3 6961.1 6964.3 7086.6 7121.6 2050.6 2079.3 2079.9 2081.8 2083.6 1774.8 1842.7 1999.8 2001.3 2012.1 1973.2 2049.5 2052.6 2071.3 2072.0 2024.1 2061.7 2078.2 2100.1 2101.8 1978.5 1978.8 1993.9 1999.7 2003.4 7016.0 7159.0 7160.2 7169.2 7180.9 4077.0 4201.0 4204.2 4210.2 4211.0 2534.3 2684.5 2807.1 2821.6 2830.5 832.1 835.2 851.0 852.2 868.1 9535.5 9540.0 9571.5 9573.7 9592.5 3538.2 3727.4 3730.1 3827.9 3830.4 8078.9 8112.6 8113.5 8124.4 8125.0 4125.3 4131.2 4131.5 4132.9 4151.5 3705.6 3800.1 3802.0 3806.6 3807.8 3168.6 3195.8 3229.9 3257.4 3289.2 917.5 952.1 997.2 999.0 1018.7 741.7 759.1 795.5 824.7 868.2 4734.1 4800.4 5060.2 5070.7 5106.3 783.3 858.6 859.8 861.5 918.3 3355.8 3409.2 3420.1 3421.5 3449.8 7981.6 8263.4 8418.2 8516.3 8533.9 8460.8 8463.4 8475.2 8480.0 8485.7 6378.1 6420.3 6464.1 6469.4 6546.3 4729.1 4737.7 4783.4 4783.5 4844.9 7727.7 7760.3 7762.9 7804.6 7829.1 7369.2 7729.3 7742.9 7797.0 7821.7 6128.4 6251.9 6255.4 6263.7 6264.8 6598.6 6636.5 6642.1 6643.0 6666.7 5261.2 5947.1 6097.9 6140.0 6266.7 5908.2 5909.3 5925.0 6125.1 6243.1 5463.1 5488.7 5534.2 5534.4 5554.8 4237.3 4240.9 4315.0 4366.9 4376.7 4308.1 4309.9 4313.2 4351.6 4415.2 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | [#4] prototype.html Cycles:180 Average:4167.77 Median:4711.16 stddev:1208.61 (25.7%) stddev-sans-first:1176.49 06:50:44 INFO - PROCESS | 5117 | Values: 292.9 298.4 301.2 307.6 308.3 4734.4 4826.0 4868.1 4902.7 4943.0 4666.4 4769.0 4798.8 4813.5 4815.4 3803.8 3816.9 3830.9 3833.5 3834.9 3531.7 3577.6 3827.4 3842.7 3847.0 3677.8 3801.7 3810.1 3819.9 3828.8 3806.2 3807.4 3825.5 3828.0 3829.8 3396.0 3397.6 3407.9 3410.2 3420.5 4638.0 4645.6 4700.6 4707.4 4757.4 4299.9 4311.1 4334.7 4337.5 4340.1 5004.6 5006.6 5011.0 5018.7 5024.2 3381.6 3551.8 3676.2 3682.5 3694.4 5254.3 5256.2 5256.6 5258.7 5260.4 3604.3 3605.8 3612.7 3621.3 3629.6 3655.2 3660.9 3665.9 3673.3 3685.9 4012.6 4160.0 4188.7 4200.5 4250.7 4969.3 5022.2 5023.9 5032.1 5047.8 1170.6 1195.9 1241.6 1245.7 1252.2 814.3 833.7 837.2 840.2 844.7 4335.5 4336.7 4348.4 4358.4 4372.8 5031.2 5041.6 5068.8 5074.7 5098.1 4198.7 4322.5 4326.9 4346.3 4381.8 2652.3 2673.4 2677.8 2684.2 2701.7 4708.2 4712.7 4730.1 4734.3 4742.4 4901.4 5099.0 5124.2 5141.9 5157.6 4653.7 4682.3 4686.6 4699.9 4709.6 5022.8 5032.2 5050.6 5061.5 5069.7 4905.0 4949.1 5206.0 5210.4 5236.9 4917.4 4918.5 4926.6 4932.2 4932.8 3800.7 3817.9 3826.4 3828.7 3834.8 5050.4 5191.4 5226.8 5235.9 5284.9 5035.4 5059.5 5065.7 5066.2 5068.5 5018.5 5021.9 5113.6 5117.8 5123.2 4757.6 4794.7 5013.4 5020.2 5030.8 4953.0 5009.6 5123.7 5127.2 5132.1 5004.1 5020.5 5021.6 5022.0 5023.2 06:50:44 INFO - PROCESS | 5117 | 06:50:44 INFO - PROCESS | 5117 | [#5] yui.html Cycles:180 Average:14175.73 Median:26810.73 stddev:18047.10 (67.3%) stddev-sans-first:18069.12 06:50:44 INFO - PROCESS | 5117 | Values: 642.0 684.1 713.8 725.4 739.8 11721.6 12503.0 12620.5 12664.4 12672.0 11813.4 11962.7 11972.3 11974.3 11981.1 605.4 623.8 741.1 750.6 756.3 754.5 754.9 758.4 759.8 759.8 799.5 799.8 800.4 800.8 801.5 636.7 651.2 794.1 794.2 794.4 570.4 586.6 586.7 587.9 589.3 11759.7 11775.2 11782.6 11799.8 11806.4 11174.6 11269.3 11282.9 11320.7 11727.8 9645.0 9811.4 10561.2 10601.2 10738.1 3977.5 4033.1 4042.4 4117.5 4201.5 41525.4 43097.4 43161.4 47744.3 48241.8 9512.9 9628.9 9719.8 9845.8 9901.6 16676.9 16800.6 16805.0 16838.7 16861.6 6303.7 6350.4 6402.2 6447.8 6551.8 3500.2 3527.4 3559.5 3594.7 3630.2 2634.9 2680.8 2733.6 2736.2 2737.3 466.5 467.6 468.0 479.2 482.7 561.3 571.2 581.2 589.2 601.6 7292.8 7395.4 7531.1 7662.3 7811.1 479.9 522.7 559.7 565.4 580.3 3437.3 3572.7 3693.7 3759.9 3856.9 53098.7 68774.0 69008.4 75155.2 75471.2 36386.1 36398.6 44219.1 61775.4 62252.7 55294.4 56003.7 57549.7 59336.4 59487.4 7004.3 7202.5 7288.1 7419.9 7550.8 36604.6 38140.0 38732.2 39122.4 39344.2 45878.5 54433.0 54773.7 55335.7 55956.4 9283.8 9535.8 9657.7 10330.5 10518.4 11423.1 11769.4 11945.5 12410.0 12503.9 11089.6 11750.1 11792.1 12079.8 12477.8 11070.6 11742.1 11806.9 11820.2 11892.8 10114.3 10134.8 10190.0 10579.4 10703.5 8785.8 9227.8 9303.3 9468.1 9509.9 9018.4 9497.7 9564.4 9580.8 9636.9 06:50:44 INFO - PROCESS | 5117 | -------- Summary: end -------- 06:50:44 INFO - PROCESS | 5117 | 06:50:45 INFO - TEST-INFO | 5117: exit 0 06:50:45 INFO - TEST-OK | dromaeo_css | took 1124584ms 06:50:45 INFO - TEST-START | kraken 06:50:45 INFO - operating with platform_type : linux_ 06:50:45 INFO - Initialising browser for kraken test... 06:50:45 INFO - TEST-INFO | started process 5421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBEwnbP/profile http://localhost:39033/getInfo.html) 06:50:49 INFO - PROCESS | 5421 | __metrics Screen width/height:1600/1200 06:50:49 INFO - PROCESS | 5421 | colorDepth:24 06:50:49 INFO - PROCESS | 5421 | Browser inner width/height: 1024/697 06:50:49 INFO - PROCESS | 5421 | __metrics 06:50:49 INFO - PROCESS | 5421 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:50:49 INFO - PROCESS | 5421 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:50 INFO - PROCESS | 5421 | console.error: PushService: 06:50:50 INFO - PROCESS | 5421 | stateChangeProcessEnqueue: Error transitioning state 06:50:50 INFO - PROCESS | 5421 | UnknownError 06:50:51 INFO - TEST-INFO | 5421: exit 0 06:50:51 INFO - Browser initialized. 06:50:51 INFO - Running cycle 1/1 for kraken test... 06:50:51 INFO - TEST-INFO | started process 5504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBEwnbP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:03 INFO - PROCESS | 5504 | RSS: Main: 175706112 06:51:03 INFO - PROCESS | 5504 | 06:51:06 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39033/tests/kraken/driver.html?testName=audio-beat-detection) 06:51:07 INFO - PROCESS | 5504 | RSS: Main: 235524096 06:51:07 INFO - PROCESS | 5504 | 06:51:09 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39033/tests/kraken/driver.html?testName=audio-dft) 06:51:10 INFO - PROCESS | 5504 | RSS: Main: 218202112 06:51:10 INFO - PROCESS | 5504 | 06:51:13 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39033/tests/kraken/driver.html?testName=audio-fft) 06:51:14 INFO - PROCESS | 5504 | RSS: Main: 300011520 06:51:14 INFO - PROCESS | 5504 | 06:51:16 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39033/tests/kraken/driver.html?testName=audio-oscillator) 06:51:17 INFO - PROCESS | 5504 | RSS: Main: 210984960 06:51:17 INFO - PROCESS | 5504 | 06:51:19 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:20 INFO - PROCESS | 5504 | RSS: Main: 214147072 06:51:20 INFO - PROCESS | 5504 | 06:51:23 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39033/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:23 INFO - PROCESS | 5504 | RSS: Main: 253816832 06:51:23 INFO - PROCESS | 5504 | 06:51:27 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39033/tests/kraken/driver.html?testName=imaging-desaturate) 06:51:28 INFO - PROCESS | 5504 | RSS: Main: 248500224 06:51:28 INFO - PROCESS | 5504 | 06:51:30 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39033/tests/kraken/driver.html?testName=json-parse-financial) 06:51:31 INFO - PROCESS | 5504 | RSS: Main: 250023936 06:51:31 INFO - PROCESS | 5504 | 06:51:33 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:33 INFO - PROCESS | 5504 | RSS: Main: 213610496 06:51:33 INFO - PROCESS | 5504 | 06:51:35 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:36 INFO - PROCESS | 5504 | RSS: Main: 221282304 06:51:36 INFO - PROCESS | 5504 | 06:51:38 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:39 INFO - PROCESS | 5504 | RSS: Main: 229445632 06:51:39 INFO - PROCESS | 5504 | 06:51:42 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:51:42 INFO - PROCESS | 5504 | RSS: Main: 238600192 06:51:42 INFO - PROCESS | 5504 | 06:51:45 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:46 INFO - PROCESS | 5504 | RSS: Main: 234897408 06:51:46 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | Cycle 1(1): loaded http://localhost:39033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39033/tests/kraken/driver.html?testName=ai-astar) 06:51:48 INFO - PROCESS | 5504 | RSS: Main: 285847552 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | __start_tp_report 06:51:48 INFO - PROCESS | 5504 | _x_x_mozilla_page_load 06:51:48 INFO - PROCESS | 5504 | _x_x_mozilla_page_load_details 06:51:48 INFO - PROCESS | 5504 | |i|pagename|runs| 06:51:48 INFO - PROCESS | 5504 | |0;ai-astar;106;116;116;114;115;116;116;115;117;114 06:51:48 INFO - PROCESS | 5504 | |1;audio-beat-detection;157;129;132;168;128;129;127;129;164;128 06:51:48 INFO - PROCESS | 5504 | |2;audio-dft;160;160;161;161;161;160;162;161;160;160 06:51:48 INFO - PROCESS | 5504 | |3;audio-fft;76;77;76;107;77;77;78;77;107;77 06:51:48 INFO - PROCESS | 5504 | |4;audio-oscillator;85;83;118;83;83;83;107;83;83;115 06:51:48 INFO - PROCESS | 5504 | |5;imaging-gaussian-blur;117;117;118;117;116;118;121;116;117;117 06:51:48 INFO - PROCESS | 5504 | |6;imaging-darkroom;148;149;148;147;147;148;148;148;148;147 06:51:48 INFO - PROCESS | 5504 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 06:51:48 INFO - PROCESS | 5504 | |8;json-parse-financial;63;63;71;63;63;63;63;63;64;63 06:51:48 INFO - PROCESS | 5504 | |9;json-stringify-tinderbox;66;66;67;65;66;67;66;66;67;67 06:51:48 INFO - PROCESS | 5504 | |10;stanford-crypto-aes;84;85;83;84;85;85;84;83;90;83 06:51:48 INFO - PROCESS | 5504 | |11;stanford-crypto-ccm;146;152;144;153;159;143;146;146;185;144 06:51:48 INFO - PROCESS | 5504 | |12;stanford-crypto-pbkdf2;180;179;178;179;180;178;183;178;178;175 06:51:48 INFO - PROCESS | 5504 | |13;stanford-crypto-sha256-iterative;69;69;71;70;69;69;70;70;69;77 06:51:48 INFO - PROCESS | 5504 | __end_tp_report 06:51:48 INFO - PROCESS | 5504 | __start_cc_report 06:51:48 INFO - PROCESS | 5504 | _x_x_mozilla_cycle_collect,1988 06:51:48 INFO - PROCESS | 5504 | __end_cc_report 06:51:48 INFO - PROCESS | 5504 | __startTimestamp1479221508563__endTimestamp 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | ------- Summary: start ------- 06:51:48 INFO - PROCESS | 5504 | Number of tests: 14 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:3.14 (2.7%) stddev-sans-first:1.01 06:51:48 INFO - PROCESS | 5504 | Values: 106.0 116.0 116.0 114.0 115.0 116.0 116.0 115.0 117.0 114.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:130.50 stddev:16.75 (12.8%) stddev-sans-first:16.47 06:51:48 INFO - PROCESS | 5504 | Values: 157.0 129.0 132.0 168.0 128.0 129.0 127.0 129.0 164.0 128.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 06:51:48 INFO - PROCESS | 5504 | Values: 160.0 160.0 161.0 161.0 161.0 160.0 162.0 161.0 160.0 160.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:12.71 (16.5%) stddev-sans-first:13.24 06:51:48 INFO - PROCESS | 5504 | Values: 76.0 77.0 76.0 107.0 77.0 77.0 78.0 77.0 107.0 77.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:14.77 (17.8%) stddev-sans-first:15.43 06:51:48 INFO - PROCESS | 5504 | Values: 85.0 83.0 118.0 83.0 83.0 83.0 107.0 83.0 83.0 115.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:1.43 (1.2%) stddev-sans-first:1.51 06:51:48 INFO - PROCESS | 5504 | Values: 117.0 117.0 118.0 117.0 116.0 118.0 121.0 116.0 117.0 117.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:51:48 INFO - PROCESS | 5504 | Values: 148.0 149.0 148.0 147.0 147.0 148.0 148.0 148.0 148.0 147.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:51:48 INFO - PROCESS | 5504 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:63.00 stddev:2.51 (4.0%) stddev-sans-first:2.65 06:51:48 INFO - PROCESS | 5504 | Values: 63.0 63.0 71.0 63.0 63.0 63.0 63.0 63.0 64.0 63.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:51:48 INFO - PROCESS | 5504 | Values: 66.0 66.0 67.0 65.0 66.0 67.0 66.0 66.0 67.0 67.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:2.07 (2.4%) stddev-sans-first:2.18 06:51:48 INFO - PROCESS | 5504 | Values: 84.0 85.0 83.0 84.0 85.0 85.0 84.0 83.0 90.0 83.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:149.00 stddev:12.72 (8.5%) stddev-sans-first:13.31 06:51:48 INFO - PROCESS | 5504 | Values: 146.0 152.0 144.0 153.0 159.0 143.0 146.0 146.0 185.0 144.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:179.00 stddev:2.04 (1.1%) stddev-sans-first:2.12 06:51:48 INFO - PROCESS | 5504 | Values: 180.0 179.0 178.0 179.0 180.0 178.0 183.0 178.0 178.0 175.0 06:51:48 INFO - PROCESS | 5504 | 06:51:48 INFO - PROCESS | 5504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.45 (3.5%) stddev-sans-first:2.55 06:51:48 INFO - PROCESS | 5504 | Values: 69.0 69.0 71.0 70.0 69.0 69.0 70.0 70.0 69.0 77.0 06:51:48 INFO - PROCESS | 5504 | -------- Summary: end -------- 06:51:48 INFO - PROCESS | 5504 | 06:51:49 INFO - TEST-INFO | 5504: exit 0 06:51:49 INFO - TEST-OK | kraken | took 64856ms 06:51:49 INFO - SUITE-END | took 1189s 06:51:50 INFO - Completed test suite (00:19:49) 06:51:50 INFO - javascript benchmark 06:51:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.7144714081455, 2618.4108575570485, 2632.02615032438, 2651.231142968538, 2666.2401215653545, 4578.1301552705045, 4637.489876113633, 4721.527847215277, 4729.668923175379, 4733.7159770413755, 4685.601723853468, 4724.976375118128, 4757.0, 4789.2097803862325, 4821.011692603017, 4354.738715677054, 4382.211201983641, 4417.293233082707, 4422.358757980091, 4456.131054444385, 4382.496012958519, 4451.221036318648, 4476.977615111936, 4480.820767169309, 4484.932726009112, 4258.6380157686635, 4405.427294451732, 4428.977855110736, 4447.710898791584, 4532.116237333721, 4280.850170244058, 4350.477942646871, 4355.107203023373, 4358.629516491102, 4359.302511598161, 4307.461567304087, 4321.0, 4329.393884856123, 4426.26966550522, 4431.047324825146, 4749.0, 4752.691075080109, 4753.429588449409, 4755.239161734141, 4815.374001379833, 5083.618728595333, 5086.872828179326, 5098.923516147261, 5099.847004589868, 5147.330846989905, 4915.3855768029, 4982.252662100677, 4988.077205716954, 4998.700077995332, 5046.19260918255, 4702.952970470252, 4706.458757242893, 4713.316569097462, 4753.35829662998, 4762.690425122356, 5151.6136289778415, 5151.896962060738, 5155.793768249228, 5155.922661160085, 5196.376434827769, 4828.637852161031, 4873.147199240189, 4877.878053048631, 4894.0, 5003.324551185616, 4994.825181118644, 5023.974880125649, 5025.6482046256415, 5043.5965122790085, 5064.620153488503, 5016.072026675004, 5059.367579052619, 5066.06277838601, 5097.057044446789, 5101.974490127525, 5058.822941197114, 5065.8733531662, 5067.46791586878, 5070.442251352349, 5132.56373208274, 4233.449651545279, 4405.295152775605, 4415.845445409395, 4421.469423669116, 4447.865794222517, 3763.774173549541, 3780.2628487445236, 3781.640744129303, 3822.10180607557, 3824.584903585691, 4394.099209662011, 4395.890102747457, 4399.758013309235, 4412.294032954712, 4452.599266066005, 5115.97442012795, 5125.4874512549195, 5127.282180494733, 5130.999455106293, 5174.197999310113, 4300.311950087971, 4320.373545835836, 4343.04453020335, 4355.477342718831, 4365.017870979068, 4619.376384188159, 4620.53794620542, 4622.121796858586, 4644.210484217691, 4654.371659825948, 4743.573078422958, 4753.263244197155, 4754.857354279377, 4781.593564547053, 4793.784279707491, 5001.524855138756, 5065.822696205615, 5066.265391518283, 5071.77177027042, 5079.974600126976, 4706.34111224422, 4753.287006948985, 4753.405824271966, 4788.425388953208, 4817.686850354716, 5011.223260394645, 5021.573166280761, 5022.096022715946, 5023.874403139951, 5060.1903695408555, 5027.044861476308, 5037.949620503748, 5041.218611115283, 5063.1898896176435, 5106.080905437057, 4773.522647735199, 4774.069056534081, 4820.566149046603, 4872.244802055687, 4890.24201248807, 4852.636052296162, 4875.341828853059, 4879.926801098058, 4881.780319885685, 4882.096812089775, 4807.326974223542, 4809.182438985451, 4811.807527698853, 4820.132376172322, 4852.927206091841, 4995.300657907823, 5041.445441001413, 5049.384197057054, 5085.898282034264, 5089.949100508948, 4925.679830810986, 4936.7284799336385, 4938.950610493993, 4946.727929963887, 4948.678335908155], "value": 4658.546074310108, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1330494386173, 562.5471495446166, 567.5998421113115, 576.5358886096692, 596.8209537138857, 27238.591421128673, 29866.850665746642, 29920.850395748017, 29946.0, 36633.0, 35043.2991340173, 38962.22075558487, 39005.609943900556, 39030.804845975734, 39094.99999999993, 7545.170031296553, 7674.309312161904, 7682.807929801772, 7691.8077048073965, 7720.15078341382, 7494.812629684274, 7571.507851989603, 7578.280063393969, 7579.696812127509, 7581.734639287626, 7550.7734767957045, 7595.886061709079, 7599.772006839776, 7600.923990760105, 7604.087509498868, 7531.171571127172, 7557.206493318233, 7558.546487210785, 7569.280918312751, 7570.091589009354, 7620.428467864932, 7670.923290767132, 7673.11759147694, 7679.961600192019, 7680.500767450154, 36460.63539364599, 36675.26649466996, 36742.81628591866, 36814.447783283, 36828.631713682786, 2905.244636394553, 3002.4445477586496, 3059.72462478378, 3063.326068264978, 3131.4519959007084, 27612.0, 27796.30509237265, 27832.443351133068, 28224.435511289863, 29335.2666183345, 3408.8977330679872, 3419.9658003420145, 3428.674275943806, 3448.3103379323984, 3458.1354661334667, 231890.0, 232173.0, 232686.9999999983, 232699.0, 232718.0, 32164.678353216168, 50350.0, 50764.0, 50781.144545486626, 50809.49190508122, 32243.0, 32350.676493234765, 32383.838080809917, 32437.0, 32439.35121297561, 12792.360381980863, 12861.742765144645, 12880.871191288155, 12888.742225155633, 12892.80660790089, 10676.412797296223, 10679.0, 10680.092192163753, 10682.359058456517, 10716.249862509549, 7658.846823063619, 7687.2697093776005, 7725.9956205694025, 7799.883001754978, 7802.882956755653, 3058.648255450607, 3099.767517436201, 3134.2164458885277, 3141.1204862638497, 3156.1320636825058, 831.3349320543541, 838.4550042472441, 863.887694599698, 880.3793325705362, 883.7702197428587, 26166.34584135412, 26648.333791655365, 27221.727782722315, 27350.589741153897, 27484.175474735788, 747.6784982457596, 935.9953200233955, 945.281585994649, 1012.8379459286479, 1043.3426941027255, 14301.28493575317, 14303.0, 14318.713625727427, 14510.564683059314, 14538.563843084725, 365195.0, 366803.0, 366823.0, 366877.47786482034, 368904.0, 47350.526494734615, 47646.28530572044, 47806.76096619495, 47817.52182478131, 47868.76065619649, 1036.3522798251092, 1069.9197560183018, 1111.2665640677276, 1130.3048625095507, 1172.935488548121, 26730.59904101479, 28078.57882131729, 28548.286292842844, 29113.27216819512, 29192.124236272946, 40489.392659109544, 41138.1772364545, 41170.0, 41224.0, 41248.58751412568, 282614.0, 283591.0, 283603.0, 284021.0, 284611.0, 37555.248895022494, 38252.0, 38765.2246955065, 39112.217755645295, 41295.7935210322, 37558.62441375551, 38408.42387364136, 40896.094822331484, 41377.586224137376, 41794.79102604467, 34724.65275347214, 34836.477452838735, 35288.0, 35528.822355888056, 35568.28863422665, 34628.826855866566, 34965.825170873984, 35028.64971350254, 35145.47281790724, 35396.64603354037, 34035.0, 34088.48867267043, 34324.0, 34440.48339274963, 34517.309653807286, 30197.849010754806, 31925.36149277048, 32369.51445728269, 32629.18427039343, 32708.0, 24344.634830477913, 24720.0, 24762.25713228606, 25337.113201037875, 25398.365040874127], "value": 16008.724663798663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.35565525949346, 358.32276996476645, 370.2982847503979, 375.883476122402, 389.3031473662145, 12413.379331033446, 12983.48066077357, 14956.40174393023, 15659.451919182831, 15843.524694259162, 13869.583912482616, 13931.93034034831, 14027.298635068257, 14042.0, 14069.71860562788, 3921.784301863396, 4765.714057156564, 4802.303665968432, 4945.480724523927, 5047.47001564836, 4911.778969946343, 5005.499450055002, 5007.273945277932, 5008.073506401309, 5011.323471331379, 4757.310190022445, 4919.360483137187, 4978.128827455199, 4984.725840078794, 4985.700857948516, 4904.950950490485, 4948.87627809304, 4952.529509696573, 4961.975190124044, 4962.280469331963, 4293.5706429356815, 4407.858479839921, 4449.666275029385, 4452.577005184502, 4453.576910193527, 18446.815531844644, 18641.347552835723, 18920.0, 18942.905285473622, 19170.520736981547, 1804.6571151481176, 1808.8010318864915, 2047.3550831488183, 2424.7211570669247, 2469.6789417375808, 11322.886771132347, 11635.95900788344, 12109.93945030278, 12607.936960315232, 12873.935630321883, 1633.8366163383685, 1663.7587549805332, 1700.6513664698707, 1724.9482515524555, 1784.5666372726264, 64054.359456405306, 64795.28070789372, 65527.67236163836, 66902.33097669059, 67775.0, 8261.669533218725, 8337.416380853403, 8543.914560854437, 8684.826303473896, 8734.082921293173, 11032.179690351002, 11065.668029959113, 11080.612178573872, 11614.0, 11707.239029463057, 7192.3886469649615, 7217.979185037968, 7250.897239800504, 7475.476716629783, 7480.812979675443, 6778.898316525256, 6927.7228910843005, 7187.460940429489, 7259.9274007259255, 7269.8546029079125, 5125.64120511568, 5364.1417373220875, 5431.701256430855, 5755.309362876482, 6031.8793624127275, 1631.7226071567861, 1685.8398452147026, 1772.2733679191726, 1773.2463702926204, 1833.1475863723433, 758.8823732321499, 843.4644001059249, 892.4605056277999, 893.8748575199477, 895.9462432253955, 15825.287862046236, 15900.12549309799, 16300.42948496797, 16400.671986560203, 17070.0, 863.7754183912228, 870.56906831119, 899.7795540092719, 900.6082354175954, 928.6099838068028, 9223.907760922304, 9291.58187881547, 9566.90433095674, 9639.843218813787, 9814.901850981541, 342606.0, 347029.0, 351147.0, 354333.0, 354504.0, 62924.37075629185, 63080.684596577645, 63777.36222637807, 64303.0, 65364.0, 797.9202079792091, 818.9099199088096, 819.3281509162549, 819.5779173725537, 821.5440430560976, 14526.983111182115, 14542.345594448063, 14595.635109122357, 14667.266636668337, 15214.0, 33017.33965320728, 33656.49515257322, 33714.98855034353, 34444.82777586096, 34450.48324275088, 41876.37185442282, 42035.579644203164, 42368.0, 42586.57413425826, 42651.7867410661, 6478.1578394808375, 6749.460043196631, 6910.0, 7050.753223637148, 7111.359977602041, 10267.640632577824, 10465.529051192867, 10555.824842467242, 10729.0, 11021.614243501439, 8464.957675211585, 8661.826763464822, 8963.955180224057, 9079.954600226956, 9214.631414743335, 9005.864912026456, 9141.908580914105, 9311.394759340621, 9387.577559009724, 9424.905750942677, 9308.162265396148, 9373.718788436357, 9467.337286389886, 9611.183049440875, 9619.374740641835, 6745.12313399255, 6758.4931130166415, 6900.861982760417, 6920.30796920304, 7083.2208457068655, 8167.0, 8912.73261802147, 9235.953820230856, 9354.97095319528, 9520.952395237979], "value": 7689.378813219163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.034919334289, 1346.293196072062, 1377.2425166158616, 1630.8450697183764, 1637.2223193982852, 6226.501879849612, 6458.515611329146, 6639.502037347194, 7058.894116588255, 7084.504084714072, 6726.293739157391, 6961.095057642512, 6964.338387853159, 7086.610236436994, 7121.572705637665, 2050.6411378008866, 2079.334612923865, 2079.9272025479113, 2081.750189977205, 2083.6353638113346, 1774.8313910178513, 1842.68674325365, 1999.81011298278, 2001.3395579458816, 2012.1046134470166, 1973.1614064022804, 2049.5286084200643, 2052.5586998795256, 2071.2957594417894, 2072.046858445117, 2024.1498570600384, 2061.701053347256, 2078.2206672497814, 2100.0654708654656, 2101.8003289687454, 1978.495483651674, 1978.7526559180103, 1993.880367177974, 1999.720039194514, 2003.3589251439546, 7016.0, 7159.0, 7160.212376638566, 7169.175544812361, 7180.928190718078, 4076.979615101935, 4200.957990420118, 4204.2432362174795, 4210.242156411845, 4210.9578904210875, 2534.252395543319, 2684.516856849047, 2807.143821134553, 2821.604975303459, 2830.4622121796997, 832.1262674192135, 835.1898658301499, 851.0425771007616, 852.1691350932853, 868.1492137705021, 9535.47554884481, 9540.045995400404, 9571.473568953705, 9573.664921727706, 9592.472414017297, 3538.221591249921, 3727.4408838674417, 3730.086128898383, 3827.942580861289, 3830.4254361845387, 8078.8788168177525, 8112.6349314281, 8113.472624279403, 8124.350051995826, 8124.959375203086, 4125.319322311845, 4131.235721391552, 4131.50421949368, 4132.876013719593, 4151.481064866892, 3705.5923848376656, 3800.0879788850475, 3801.9619803801606, 3806.6383693549624, 3807.809609519513, 3168.5722427472456, 3195.792273502215, 3229.8869539566003, 3257.446234140202, 3289.1612638777437, 917.4724533393193, 952.1430712358793, 997.1922742578535, 998.9650362237287, 1018.7351288665001, 741.7181471040969, 759.1080480435467, 795.4948607634078, 824.7195953375762, 868.2446271743497, 4734.147853386424, 4800.423949126127, 5060.1903695408555, 5070.721110338893, 5106.336176297132, 783.2637320918318, 858.596195220806, 859.776458120893, 861.5347712235448, 918.2883265469181, 3355.8489867956, 3409.1817963688536, 3420.0936751760305, 3421.4867769834723, 3449.7930124192126, 7981.561014144278, 8263.421560490828, 8418.242358187792, 8516.318694504549, 8533.871991920127, 8460.78848028792, 8463.36524760633, 8475.237228649452, 8480.0, 8485.703000394957, 6378.107065010902, 6420.325865784119, 6464.09502669636, 6469.385408386196, 6546.312637173123, 4729.101470720552, 4737.668363214542, 4783.44990326103, 4783.545563171493, 4844.878878028077, 7727.652255648397, 7760.340371068297, 7762.92237077622, 7804.648790804314, 7829.138794732688, 7369.226231245856, 7729.265719756614, 7742.915991761271, 7796.961015194887, 7821.726239581587, 6128.356522565066, 6251.9062214067735, 6255.374462553708, 6263.718132683949, 6264.812055638338, 6598.637074960923, 6636.469082473487, 6642.103316052464, 6643.036759669917, 6666.733330666719, 5261.237120617566, 5947.078202878561, 6097.908531372122, 6140.0, 6266.749330026748, 5908.172855800105, 5909.261342332208, 5925.022371308858, 6125.050617154348, 6243.063540468966, 5463.098588732814, 5488.69812160335, 5534.169874518854, 5534.39121696605, 5554.777808887599, 4237.322028475429, 4240.893977650583, 4314.956850431456, 4366.868993930188, 4376.737395756265, 4308.116836048665, 4309.91380172401, 4313.180495705806, 4351.608355248043, 4415.2494076006515], "value": 3762.9086061210814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.9311611771235, 298.3570405775554, 301.22434730568784, 307.6016558556669, 308.2540252588735, 4734.431868175815, 4825.975870120653, 4868.075065737507, 4902.65681402302, 4942.999999999995, 4666.393368862043, 4769.0, 4798.808047678089, 4813.49458306878, 4815.446223684277, 3803.7717736935733, 3816.9121800286925, 3830.885073447787, 3833.501644786174, 3834.9424758628575, 3531.7174626029982, 3577.62434944331, 3827.4067519534515, 3842.654161125498, 3846.961530384702, 3677.834497447608, 3801.657850793428, 3810.1236715555438, 3819.8663046793367, 3828.7894165820867, 3806.2197249563774, 3807.428885667144, 3825.464434979105, 3827.9808600957094, 3829.80850957451, 3396.0, 3397.5560386835496, 3407.880724174642, 3410.198603328216, 3420.4698271767916, 4638.0491999140095, 4645.581897629229, 4700.647451441156, 4707.435107787088, 4757.405324334458, 4299.892502687427, 4311.060022989635, 4334.69959012295, 4337.457817772778, 4340.066885619575, 5004.599632029465, 5006.6245031622775, 5011.0, 5018.673786203922, 5024.19612861944, 3381.611114721814, 3551.8401671924566, 3676.246369494247, 3682.5396825396824, 3694.3534881395917, 5254.264402983586, 5256.237845512417, 5256.553192978639, 5258.684478931276, 5260.368755749335, 3604.3151801157696, 3605.7656252343513, 3612.7290453216115, 3621.311950729353, 3629.564452265745, 3655.1541471556693, 3660.926781464356, 3665.9266814663556, 3673.3020726062496, 3685.8894233173046, 4012.558618551957, 4159.9600099975005, 4188.727732697365, 4200.516940551875, 4250.744955302692, 4969.2546118081855, 5022.246663000579, 5023.924641130386, 5032.093708634053, 5047.798088076436, 1170.6136974798296, 1195.8744331845205, 1241.5654520917788, 1245.6761242077125, 1252.1780808922995, 814.3444527155697, 833.737372727601, 837.1837458477935, 840.2018082821344, 844.7118144829062, 4335.523092459827, 4336.739795612273, 4348.434703488526, 4358.430964852714, 4372.846950356722, 5031.23906632683, 5041.638757535445, 5068.847934561895, 5074.695518268842, 5098.107831129538, 4198.6641068714425, 4322.524522302544, 4326.913461730748, 4346.326319420495, 4381.78091095444, 2652.323657467372, 2673.385121422084, 2677.799165062628, 2684.1813246959473, 2701.689305729827, 4708.246680531167, 4712.693674911188, 4730.148573256847, 4734.313524538922, 4742.4309082909585, 4901.411830580353, 5098.980203959223, 5124.231365295235, 5141.948580514222, 5157.613179011589, 4653.74238033378, 4682.267561002451, 4686.5629872466125, 4699.906001880012, 4709.621641071169, 5022.755771373184, 5032.194848824171, 5050.595952323879, 5061.544460998528, 5069.718626617963, 4904.950950490449, 4949.109160351028, 5206.0, 5210.374755029421, 5236.869078273074, 4917.434495033117, 4918.458969513422, 4926.630502712239, 4932.21084626458, 4932.802687892444, 3800.6959443243923, 3817.866374676984, 3826.3877779555137, 3828.7128465364653, 3834.8466061357235, 5050.444451110448, 5191.402988656353, 5226.771708648541, 5235.921461178009, 5284.894302113859, 5035.370578677665, 5059.544640982329, 5065.696058236517, 5066.214736715815, 5068.518490743373, 5018.4981501849525, 5021.949780502295, 5113.616478764182, 5117.769700363418, 5123.205903085028, 4757.643176761688, 4794.688345257687, 5013.373328333958, 5020.24696295544, 5030.798768049237, 4952.975235123801, 5009.649324547247, 5123.743812809419, 5127.230915362726, 5132.127538318569, 5004.074246264453, 5020.523050310215, 5021.623378246573, 5022.0, 5023.246513023076], "value": 3780.7673171011847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.0, 684.1072400517326, 713.8429545499988, 725.3798002707684, 739.7854622159574, 11721.648350549476, 12503.0, 12620.495180192804, 12664.366781660927, 12672.0, 11813.350265735382, 11962.700932476671, 11972.28166310022, 11974.34141122238, 11981.10141739371, 605.3976293587887, 623.815974287584, 741.0921621014269, 750.5571712689513, 756.3079781999464, 754.5397307642361, 754.935830454412, 758.3743411685354, 759.7758661194933, 759.7986533568609, 799.5083023940293, 799.8440304140695, 800.4316934976174, 800.8478389106051, 801.4550105927966, 636.710296814948, 651.2152855808787, 794.051108924835, 794.1899262751961, 794.3922898982283, 570.3839852958795, 586.6216290492652, 586.6685322792608, 587.9294484661868, 589.3134498309464, 11759.7060073498, 11775.175737698364, 11782.646520604396, 11799.764004719858, 11806.40967951599, 11174.608888688937, 11269.323840569592, 11282.887171128266, 11320.660380188607, 11727.824082638683, 9644.951775241148, 9811.411315321104, 10561.155107591374, 10601.151907847354, 10738.08726258269, 3977.482927219472, 4033.1127152026506, 4042.413849991735, 4117.505899292074, 4201.474815648044, 41525.37711934323, 43097.35353969693, 43161.35257971133, 47744.28383574214, 48241.75879120617, 9512.90487095134, 9628.90371096294, 9719.83361996565, 9845.80308393828, 9901.603935842486, 16676.91661541709, 16800.579985500215, 16805.0, 16838.747418788727, 16861.578460538585, 6303.684815759194, 6350.396712312416, 6402.199725034371, 6447.838804029937, 6551.80344589663, 3500.212452198235, 3527.4356103023392, 3559.519464872261, 3594.7483676142942, 3630.1832087780567, 2634.9077782277527, 2680.798940079502, 2733.562629979194, 2736.233854520737, 2737.3293543082073, 466.5031741195616, 467.55115089513765, 467.99766001169775, 479.20452049597503, 482.6910777102657, 561.2871653000748, 571.2488078177183, 581.2124571205956, 589.19280585598, 601.59392410123, 7292.838581853998, 7395.445341599401, 7531.096268447822, 7662.272084152108, 7811.101723301779, 479.928010798383, 522.7219448448507, 559.683778665053, 565.366789196103, 580.2833500626723, 3437.2781715839956, 3572.7052468522797, 3693.686036686858, 3759.887203383903, 3856.903577410531, 53098.73450632722, 68774.0, 69008.4090750017, 75155.24844751591, 75471.24528754642, 36386.09034774099, 36398.63601363952, 44219.11561768811, 61775.38224617696, 62252.688736556025, 55294.44705552974, 56003.719981400645, 57549.712251438476, 59336.40663593309, 59487.40512594905, 7004.299570042955, 7202.495825292389, 7288.08898887639, 7419.888701669587, 7550.848983020419, 36604.63395366012, 38140.0, 38732.2253554933, 39122.413163802, 39344.2131157381, 45878.54121458743, 54433.0, 54773.72613136909, 55335.723321383135, 55956.44043559513, 9283.814323713623, 9535.760351154306, 9657.661981830603, 10330.535125919501, 10518.421486817992, 11423.086153107564, 11769.411529423665, 11945.462454189408, 12410.0, 12503.87496125027, 11089.5564177432, 11750.118741094622, 11792.115591330514, 12079.818802718142, 12477.812832807334, 11070.612528561462, 11742.119341049285, 11806.881931180922, 11820.172587918763, 11892.76214475723, 10114.29199955996, 10134.847977280198, 10190.0, 10579.418132002813, 10703.518341674799, 8785.780355491164, 9227.76930576741, 9303.302252331237, 9468.14786669203, 9509.857352139585, 9018.413803102778, 9497.667581634609, 9564.378315409476, 9580.808383832424, 9636.903630963881], "value": 5963.543055363446, "unit": "score"}], "name": "dromaeo_css", "value": 6042.163944116002, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 114.0, 115.0, 116.0, 116.0, 115.0, 117.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 132.0, 168.0, 128.0, 129.0, 127.0, 129.0, 164.0, 128.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 107.0, 77.0, 77.0, 78.0, 77.0, 107.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 118.0, 83.0, 83.0, 83.0, 107.0, 83.0, 83.0, 115.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 118.0, 121.0, 116.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 71.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 84.0, 85.0, 85.0, 84.0, 83.0, 90.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 152.0, 144.0, 153.0, 159.0, 143.0, 146.0, 146.0, 185.0, 144.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 178.0, 179.0, 180.0, 178.0, 183.0, 178.0, 178.0, 175.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 77.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1565.3999999999996, "alertThreshold": 2.0}]} 06:51:50 INFO - Return code: 0 06:51:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:51:50 INFO - # TBPL SUCCESS # 06:51:50 INFO - Running post-action listener: _resource_record_post_action 06:51:50 INFO - [mozharness: 2016-11-15 14:51:50.348548Z] Finished run-tests step (success) 06:51:50 INFO - Running post-run listener: _resource_record_post_run 06:51:50 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401743872; Read time: 12; Write time: 435460 06:51:50 INFO - TinderboxPrint: CPU usage
13.1% 06:51:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:51:50 INFO - TinderboxPrint: I/O write bytes / time
401,743,872 / 435,460 06:51:50 INFO - TinderboxPrint: CPU idle
8,360.3 (86.9%) 06:51:50 INFO - TinderboxPrint: CPU user
1,212.2 (12.6%) 06:51:50 INFO - TinderboxPrint: Swap in / out
0 / 0 06:51:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111067136; Read time: 0; Write time: 143488 06:51:50 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 290676736; Read time: 0; Write time: 291972 06:51:51 INFO - Running post-run listener: _upload_blobber_files 06:51:51 INFO - Blob upload gear active. 06:51:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51:51 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:51:51 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:51:51 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:51:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:52 INFO - (blobuploader) - INFO - Done attempting. 06:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:52 INFO - (blobuploader) - INFO - Done attempting. 06:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:56 INFO - (blobuploader) - INFO - Done attempting. 06:51:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:51:56 INFO - Return code: 0 06:51:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:51:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:51:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b49ee3b310748041c84395d4aa8a2ca1f7cc32eb67feb06b03a9beef78134015ce27bfcb21ccfc9e8785a0d84e58e584b4ceaff8765b2538238656b78095221", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff595c4455390289cbb4bf3a0400921db7f3c52e78364720293dbd3053b2c7ff9c1dca85e35d48d0a4e81530c5d9031684e7f139ef843ffa6d8f39b587f6a72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5cf50d49d15acb3bc2dd9a6bacff56c422328b9e7cf7c918aa03caf1977448b3bd95e9d304c509a84b298b916feb549977117239c01fc8746d2f5115f3b171"} 06:51:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:51:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:51:56 INFO - Contents: 06:51:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b49ee3b310748041c84395d4aa8a2ca1f7cc32eb67feb06b03a9beef78134015ce27bfcb21ccfc9e8785a0d84e58e584b4ceaff8765b2538238656b78095221", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff595c4455390289cbb4bf3a0400921db7f3c52e78364720293dbd3053b2c7ff9c1dca85e35d48d0a4e81530c5d9031684e7f139ef843ffa6d8f39b587f6a72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5cf50d49d15acb3bc2dd9a6bacff56c422328b9e7cf7c918aa03caf1977448b3bd95e9d304c509a84b298b916feb549977117239c01fc8746d2f5115f3b171"} 06:51:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:51:56 INFO - Copying logs to upload dir... 06:51:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:51:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1670.997854 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-11-15 06:51:56.146853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 06:51:56.150506) ========= 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=0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b49ee3b310748041c84395d4aa8a2ca1f7cc32eb67feb06b03a9beef78134015ce27bfcb21ccfc9e8785a0d84e58e584b4ceaff8765b2538238656b78095221", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff595c4455390289cbb4bf3a0400921db7f3c52e78364720293dbd3053b2c7ff9c1dca85e35d48d0a4e81530c5d9031684e7f139ef843ffa6d8f39b587f6a72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5cf50d49d15acb3bc2dd9a6bacff56c422328b9e7cf7c918aa03caf1977448b3bd95e9d304c509a84b298b916feb549977117239c01fc8746d2f5115f3b171"} 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.011421 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b49ee3b310748041c84395d4aa8a2ca1f7cc32eb67feb06b03a9beef78134015ce27bfcb21ccfc9e8785a0d84e58e584b4ceaff8765b2538238656b78095221", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff595c4455390289cbb4bf3a0400921db7f3c52e78364720293dbd3053b2c7ff9c1dca85e35d48d0a4e81530c5d9031684e7f139ef843ffa6d8f39b587f6a72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5cf50d49d15acb3bc2dd9a6bacff56c422328b9e7cf7c918aa03caf1977448b3bd95e9d304c509a84b298b916feb549977117239c01fc8746d2f5115f3b171"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 06:51:56.176557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:51:56.176927) ========= 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=0333a256a5e4f052382dd180000001b1-1479219775.824304-1161944816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:51:56.262461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 06:51:56.262774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 06:51:56.263050) ========= ========= Total master_lag: 0.18 =========