builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1473504211.58 results: success (0) buildid: 20160910004004 builduid: 94c0de8f63194c5890e8ffe344faa424 revision: 28878b37a89e309b3311bc9cc6aa864a74a96d3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.580245) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.580735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.581057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.600694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.600985) ========= 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=4300f881736b422476174874000001bc-1473504114.208304-109008610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-10 03:43:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-09-10 03:43:32 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.731284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.731621) ========= 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=4300f881736b422476174874000001bc-1473504114.208304-109008610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.784175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:31.784531) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28878b37a89e309b3311bc9cc6aa864a74a96d3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28878b37a89e309b3311bc9cc6aa864a74a96d3e --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=4300f881736b422476174874000001bc-1473504114.208304-109008610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-10 03:43:32,140 truncating revision to first 12 chars 2016-09-10 03:43:32,140 Setting DEBUG logging. 2016-09-10 03:43:32,140 attempt 1/10 2016-09-10 03:43:32,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/28878b37a89e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-10 03:43:32,462 unpacking tar archive at: mozilla-aurora-28878b37a89e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716173 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:32.515442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:32.515804) ========= script_repo_revision: 28878b37a89e309b3311bc9cc6aa864a74a96d3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:32.516229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:32.516560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-10 03:43:32.526357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-10 03:43:32.526704) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=4300f881736b422476174874000001bc-1473504114.208304-109008610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:32 INFO - MultiFileLogger online at 20160910 03:43:32 in /builds/slave/test 03:43:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:43:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:32 INFO - {'append_to_log': False, 03:43:32 INFO - 'base_work_dir': '/builds/slave/test', 03:43:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:43:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:32 INFO - 'branch': 'Mozilla-Aurora', 03:43:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:32 INFO - 'config_files': ('talos/linux_config.py',), 03:43:32 INFO - 'default_actions': ('clobber', 03:43:32 INFO - 'read-buildbot-config', 03:43:32 INFO - 'download-and-extract', 03:43:32 INFO - 'populate-webroot', 03:43:32 INFO - 'create-virtualenv', 03:43:32 INFO - 'install', 03:43:32 INFO - 'run-tests'), 03:43:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:32 INFO - 'download_minidump_stackwalk': True, 03:43:32 INFO - 'download_symbols': 'ondemand', 03:43:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:32 INFO - 'installer_path': 'installer.exe', 03:43:32 INFO - 'log_level': 'info', 03:43:32 INFO - 'log_name': 'talos', 03:43:32 INFO - 'log_to_console': True, 03:43:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:32 INFO - 'opt_config_files': (), 03:43:32 INFO - 'pip_index': False, 03:43:32 INFO - 'sps_profile': False, 03:43:32 INFO - 'sps_profile_interval': 0, 03:43:32 INFO - 'suite': 'dromaeojs-e10s', 03:43:32 INFO - 'system_bits': '32', 03:43:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:32 INFO - 'title': 'talos-linux64-ix-045', 03:43:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:32 INFO - 'use_talos_json': True, 03:43:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:32 INFO - 'work_dir': 'build'} 03:43:32 INFO - [mozharness: 2016-09-10 10:43:32.981338Z] Running clobber step. 03:43:32 INFO - Running pre-action listener: _resource_record_pre_action 03:43:32 INFO - Running main action method: clobber 03:43:32 INFO - rmtree: /builds/slave/test/build 03:43:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:33 INFO - Running post-action listener: _resource_record_post_action 03:43:33 INFO - [mozharness: 2016-09-10 10:43:33.438452Z] Finished clobber step (success) 03:43:33 INFO - [mozharness: 2016-09-10 10:43:33.438554Z] Running read-buildbot-config step. 03:43:33 INFO - Running pre-action listener: _resource_record_pre_action 03:43:33 INFO - Running main action method: read_buildbot_config 03:43:33 INFO - Using buildbot properties: 03:43:33 INFO - { 03:43:33 INFO - "project": "", 03:43:33 INFO - "product": "firefox", 03:43:33 INFO - "script_repo_revision": "production", 03:43:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:43:33 INFO - "repository": "", 03:43:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:43:33 INFO - "buildid": "20160910004004", 03:43:33 INFO - "stage_platform": "linux64-pgo", 03:43:33 INFO - "basedir": "/builds/slave/test", 03:43:33 INFO - "nightly_build": "True", 03:43:33 INFO - "buildnumber": 548, 03:43:33 INFO - "slavename": "talos-linux64-ix-045", 03:43:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:43:33 INFO - "platform": "ubuntu64_hw", 03:43:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:43:33 INFO - "branch": "mozilla-aurora", 03:43:33 INFO - "repo_path": "releases/mozilla-aurora", 03:43:33 INFO - "revision": "28878b37a89e309b3311bc9cc6aa864a74a96d3e", 03:43:33 INFO - "pgo_build": "True", 03:43:33 INFO - "builduid": "94c0de8f63194c5890e8ffe344faa424", 03:43:33 INFO - "slavebuilddir": "test" 03:43:33 INFO - } 03:43:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:43:33 INFO - Running post-action listener: _resource_record_post_action 03:43:33 INFO - [mozharness: 2016-09-10 10:43:33.441086Z] Finished read-buildbot-config step (success) 03:43:33 INFO - [mozharness: 2016-09-10 10:43:33.441176Z] Running download-and-extract step. 03:43:33 INFO - Running pre-action listener: _resource_record_pre_action 03:43:33 INFO - Running main action method: download_and_extract 03:43:33 INFO - mkdir: /builds/slave/test/build/tests 03:43:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:33 INFO - https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:43:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:33 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:43:33 INFO - retry: Failed, sleeping 30 seconds before retrying 03:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:44:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:03 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:44:03 INFO - retry: Failed, sleeping 60 seconds before retrying 03:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:45:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:03 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:45:03 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:45:03 INFO - Caught exception: HTTP Error 404: Not Found 03:45:03 INFO - Caught exception: HTTP Error 404: Not Found 03:45:03 INFO - Caught exception: HTTP Error 404: Not Found 03:45:03 INFO - trying https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:03 INFO - Downloading https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:45:04 INFO - Downloaded 1361 bytes. 03:45:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:04 INFO - Using the following test package requirements: 03:45:04 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:04 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:45:04 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:45:04 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'jsshell-linux-x86_64.zip'], 03:45:04 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:45:04 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:04 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:45:04 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:45:04 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:45:04 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:45:04 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:04 INFO - https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:45:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:45:04 INFO - retry: Failed, sleeping 30 seconds before retrying 03:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:45:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:45:34 INFO - retry: Failed, sleeping 60 seconds before retrying 03:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:46:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:46:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:46:34 INFO - Caught exception: HTTP Error 404: Not Found 03:46:34 INFO - Caught exception: HTTP Error 404: Not Found 03:46:34 INFO - Caught exception: HTTP Error 404: Not Found 03:46:34 INFO - trying https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:34 INFO - Downloading https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:35 INFO - Downloaded 21768653 bytes. 03:46:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:46:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:46:36 INFO - Return code: 0 03:46:36 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:36 INFO - https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:46:36 INFO - retry: Failed, sleeping 30 seconds before retrying 03:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:47:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:47:06 INFO - retry: Failed, sleeping 60 seconds before retrying 03:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:48:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:48:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:48:06 INFO - Caught exception: HTTP Error 404: Not Found 03:48:06 INFO - Caught exception: HTTP Error 404: Not Found 03:48:06 INFO - Caught exception: HTTP Error 404: Not Found 03:48:06 INFO - trying https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:06 INFO - Downloading https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:07 INFO - Downloaded 21768653 bytes. 03:48:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:48:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:48:08 INFO - Return code: 0 03:48:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:08 INFO - https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:48:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:08 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:48:08 INFO - retry: Failed, sleeping 30 seconds before retrying 03:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:48:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:38 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:48:38 INFO - retry: Failed, sleeping 60 seconds before retrying 03:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:49:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:38 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:49:38 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:49:38 INFO - Caught exception: HTTP Error 404: Not Found 03:49:38 INFO - Caught exception: HTTP Error 404: Not Found 03:49:38 INFO - Caught exception: HTTP Error 404: Not Found 03:49:38 INFO - trying https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:38 INFO - Downloading https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:49:39 INFO - Downloaded 14413740 bytes. 03:49:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:49:39 INFO - Return code: 0 03:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:39 INFO - https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:49:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:49:39 INFO - retry: Failed, sleeping 30 seconds before retrying 03:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:50:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:50:09 INFO - retry: Failed, sleeping 60 seconds before retrying 03:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:51:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:51:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:51:09 INFO - Caught exception: HTTP Error 404: Not Found 03:51:09 INFO - Caught exception: HTTP Error 404: Not Found 03:51:09 INFO - Caught exception: HTTP Error 404: Not Found 03:51:09 INFO - trying https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:51:11 INFO - Downloaded 63890420 bytes. 03:51:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:11 INFO - mkdir: /builds/slave/test/properties 03:51:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:11 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:11 INFO - Contents: 03:51:11 INFO - build_url:https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:11 INFO - Running post-action listener: _resource_record_post_action 03:51:11 INFO - Running post-action listener: set_extra_try_arguments 03:51:11 INFO - [mozharness: 2016-09-10 10:51:11.826208Z] Finished download-and-extract step (success) 03:51:11 INFO - [mozharness: 2016-09-10 10:51:11.826441Z] Running populate-webroot step. 03:51:11 INFO - Running pre-action listener: _resource_record_pre_action 03:51:11 INFO - Running main action method: populate_webroot 03:51:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:11 INFO - '--tppagecycles', 03:51:11 INFO - '7'], 03:51:11 INFO - 'tests': ['tsvgm']}}, 03:51:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:51:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['damp', 'tps']}, 03:51:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'tests': ['damp', 'tps']}, 03:51:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['dromaeo_dom']}, 03:51:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['basic_compositor_video']}, 03:51:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:51:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['a11yr', 03:51:11 INFO - 'ts_paint', 03:51:11 INFO - 'tpaint', 03:51:11 INFO - 'sessionrestore', 03:51:11 INFO - 'sessionrestore_no_auto_restore', 03:51:11 INFO - 'tabpaint']}, 03:51:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:11 INFO - 'ts_paint', 03:51:11 INFO - 'tpaint', 03:51:11 INFO - 'sessionrestore', 03:51:11 INFO - 'sessionrestore_no_auto_restore', 03:51:11 INFO - 'tabpaint']}, 03:51:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:11 INFO - 'ts_paint', 03:51:11 INFO - 'tpaint', 03:51:11 INFO - 'sessionrestore', 03:51:11 INFO - 'sessionrestore_no_auto_restore', 03:51:11 INFO - 'tabpaint']}, 03:51:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:11 INFO - 'ts_paint', 03:51:11 INFO - 'tpaint', 03:51:11 INFO - 'sessionrestore', 03:51:11 INFO - 'sessionrestore_no_auto_restore', 03:51:11 INFO - 'tabpaint']}, 03:51:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['a11yr', 03:51:11 INFO - 'ts_paint', 03:51:11 INFO - 'tpaint', 03:51:11 INFO - 'sessionrestore', 03:51:11 INFO - 'sessionrestore_no_auto_restore', 03:51:11 INFO - 'tabpaint']}, 03:51:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['a11yr', 03:51:11 INFO - 'ts_paint', 03:51:11 INFO - 'tpaint', 03:51:11 INFO - 'sessionrestore', 03:51:11 INFO - 'sessionrestore_no_auto_restore', 03:51:11 INFO - 'tabpaint']}, 03:51:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['tsvgx', 03:51:11 INFO - 'tsvgr_opacity', 03:51:11 INFO - 'tart', 03:51:11 INFO - 'tscrollx', 03:51:11 INFO - 'cart']}, 03:51:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:11 INFO - 'tsvgr_opacity', 03:51:11 INFO - 'tart', 03:51:11 INFO - 'tscrollx', 03:51:11 INFO - 'cart']}, 03:51:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'talos_options': ['--disable-e10s'], 03:51:11 INFO - 'tests': ['tp5o']}, 03:51:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'tests': ['tp5o']}, 03:51:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'talos_options': ['--disable-e10s', 03:51:11 INFO - '--xperf_path', 03:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:11 INFO - 'tests': ['tp5n']}, 03:51:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:11 INFO - 'talos_options': ['--xperf_path', 03:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:11 INFO - 'tests': ['tp5n']}}, 03:51:11 INFO - 'talos.zip': {'path': '', 03:51:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:11 INFO - Running post-action listener: _resource_record_post_action 03:51:11 INFO - [mozharness: 2016-09-10 10:51:11.846375Z] Finished populate-webroot step (success) 03:51:11 INFO - [mozharness: 2016-09-10 10:51:11.846464Z] Running create-virtualenv step. 03:51:11 INFO - Running pre-action listener: _resource_record_pre_action 03:51:11 INFO - Running main action method: create_virtualenv 03:51:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:11 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 03:51:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:11 INFO - Using real prefix '/usr' 03:51:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:14 INFO - Installing pip.................done. 03:51:14 INFO - Return code: 0 03:51:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:14 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 03:51:14 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 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:14 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 03:51:14 INFO - Cleaning up... 03:51:14 INFO - Return code: 0 03:51:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:14 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 03:51:14 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 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:14 INFO - Downloading/unpacking psutil>=3.1.1 03:51:14 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 03:51:14 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 03:51:14 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 03:51:14 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 03:51:14 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 03:51:14 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 03:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:16 INFO - Installing collected packages: psutil 03:51:16 INFO - Running setup.py install for psutil 03:51:16 INFO - building 'psutil._psutil_linux' extension 03:51:16 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 03:51:17 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 03:51:17 INFO - building 'psutil._psutil_posix' extension 03:51:17 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 03:51:17 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 03:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:17 INFO - Successfully installed psutil 03:51:17 INFO - Cleaning up... 03:51:17 INFO - Return code: 0 03:51:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:17 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:17 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 03:51:17 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 03:51:17 INFO - Using env: {'DISPLAY': ':0', 03:51:17 INFO - 'HOME': '/home/cltbld', 03:51:17 INFO - 'LANG': 'en_US.UTF-8', 03:51:17 INFO - 'LANGUAGE': 'en_US:en', 03:51:17 INFO - 'LOGNAME': 'cltbld', 03:51:17 INFO - 'MAIL': '/var/mail/cltbld', 03:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:17 INFO - 'MOZ_NO_REMOTE': '1', 03:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:17 INFO - 'NO_EM_RESTART': '1', 03:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:17 INFO - 'PWD': '/builds/slave/test', 03:51:17 INFO - 'SHELL': '/bin/bash', 03:51:17 INFO - 'SHLVL': '1', 03:51:17 INFO - 'TERM': 'linux', 03:51:17 INFO - 'TMOUT': '86400', 03:51:17 INFO - 'USER': 'cltbld', 03:51:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:17 INFO - '_': '/tools/buildbot/bin/python'} 03:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:17 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 03:51:17 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 03:51:17 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 03:51:17 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 03:51:17 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 03:51:17 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 03:51:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:19 INFO - Installing collected packages: mozsystemmonitor 03:51:19 INFO - Running setup.py install for mozsystemmonitor 03:51:19 INFO - Successfully installed mozsystemmonitor 03:51:19 INFO - Cleaning up... 03:51:19 INFO - Return code: 0 03:51:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:19 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:19 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 03:51:19 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 03:51:19 INFO - Using env: {'DISPLAY': ':0', 03:51:19 INFO - 'HOME': '/home/cltbld', 03:51:19 INFO - 'LANG': 'en_US.UTF-8', 03:51:19 INFO - 'LANGUAGE': 'en_US:en', 03:51:19 INFO - 'LOGNAME': 'cltbld', 03:51:19 INFO - 'MAIL': '/var/mail/cltbld', 03:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:19 INFO - 'MOZ_NO_REMOTE': '1', 03:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:19 INFO - 'NO_EM_RESTART': '1', 03:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:19 INFO - 'PWD': '/builds/slave/test', 03:51:19 INFO - 'SHELL': '/bin/bash', 03:51:19 INFO - 'SHLVL': '1', 03:51:19 INFO - 'TERM': 'linux', 03:51:19 INFO - 'TMOUT': '86400', 03:51:19 INFO - 'USER': 'cltbld', 03:51:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:19 INFO - '_': '/tools/buildbot/bin/python'} 03:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:19 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:19 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 03:51:19 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 03:51:19 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 03:51:19 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 03:51:19 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 03:51:19 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 03:51:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:22 INFO - warning: no files found matching '*.txt' 03:51:22 INFO - no previously-included directories found matching 'build' 03:51:22 INFO - no previously-included directories found matching 'dist' 03:51:22 INFO - no previously-included directories found matching '.git*' 03:51:22 INFO - Installing collected packages: jsonschema, functools32 03:51:22 INFO - Running setup.py install for functools32 03:51:22 INFO - warning: no files found matching '*.txt' 03:51:22 INFO - no previously-included directories found matching 'build' 03:51:22 INFO - no previously-included directories found matching 'dist' 03:51:22 INFO - no previously-included directories found matching '.git*' 03:51:22 INFO - Successfully installed jsonschema functools32 03:51:22 INFO - Cleaning up... 03:51:22 INFO - Return code: 0 03:51:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:22 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:22 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 03:51:22 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 03:51:22 INFO - Using env: {'DISPLAY': ':0', 03:51:22 INFO - 'HOME': '/home/cltbld', 03:51:22 INFO - 'LANG': 'en_US.UTF-8', 03:51:22 INFO - 'LANGUAGE': 'en_US:en', 03:51:22 INFO - 'LOGNAME': 'cltbld', 03:51:22 INFO - 'MAIL': '/var/mail/cltbld', 03:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:22 INFO - 'MOZ_NO_REMOTE': '1', 03:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:22 INFO - 'NO_EM_RESTART': '1', 03:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:22 INFO - 'PWD': '/builds/slave/test', 03:51:22 INFO - 'SHELL': '/bin/bash', 03:51:22 INFO - 'SHLVL': '1', 03:51:22 INFO - 'TERM': 'linux', 03:51:22 INFO - 'TMOUT': '86400', 03:51:22 INFO - 'USER': 'cltbld', 03:51:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:22 INFO - '_': '/tools/buildbot/bin/python'} 03:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:22 INFO - Cleaning up... 03:51:22 INFO - Return code: 0 03:51:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:22 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:22 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 03:51:22 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 03:51:22 INFO - Using env: {'DISPLAY': ':0', 03:51:22 INFO - 'HOME': '/home/cltbld', 03:51:22 INFO - 'LANG': 'en_US.UTF-8', 03:51:22 INFO - 'LANGUAGE': 'en_US:en', 03:51:22 INFO - 'LOGNAME': 'cltbld', 03:51:22 INFO - 'MAIL': '/var/mail/cltbld', 03:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:22 INFO - 'MOZ_NO_REMOTE': '1', 03:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:22 INFO - 'NO_EM_RESTART': '1', 03:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:22 INFO - 'PWD': '/builds/slave/test', 03:51:22 INFO - 'SHELL': '/bin/bash', 03:51:22 INFO - 'SHLVL': '1', 03:51:22 INFO - 'TERM': 'linux', 03:51:22 INFO - 'TMOUT': '86400', 03:51:22 INFO - 'USER': 'cltbld', 03:51:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:22 INFO - '_': '/tools/buildbot/bin/python'} 03:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:22 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:22 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 03:51:22 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 03:51:22 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 03:51:22 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 03:51:22 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 03:51:22 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 03:51:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:25 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 03:51:25 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 03:51:25 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 03:51:25 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 03:51:25 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 03:51:25 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 03:51:25 INFO - Downloading docopt-0.6.1.tar.gz 03:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:25 INFO - Running setup.py install for blobuploader 03:51:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:25 INFO - Running setup.py install for requests 03:51:25 INFO - Running setup.py install for docopt 03:51:26 INFO - Successfully installed blobuploader requests docopt 03:51:26 INFO - Cleaning up... 03:51:26 INFO - Return code: 0 03:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:26 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:26 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 03:51:26 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 03:51:26 INFO - Using env: {'DISPLAY': ':0', 03:51:26 INFO - 'HOME': '/home/cltbld', 03:51:26 INFO - 'LANG': 'en_US.UTF-8', 03:51:26 INFO - 'LANGUAGE': 'en_US:en', 03:51:26 INFO - 'LOGNAME': 'cltbld', 03:51:26 INFO - 'MAIL': '/var/mail/cltbld', 03:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:26 INFO - 'MOZ_NO_REMOTE': '1', 03:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:26 INFO - 'NO_EM_RESTART': '1', 03:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:26 INFO - 'PWD': '/builds/slave/test', 03:51:26 INFO - 'SHELL': '/bin/bash', 03:51:26 INFO - 'SHLVL': '1', 03:51:26 INFO - 'TERM': 'linux', 03:51:26 INFO - 'TMOUT': '86400', 03:51:26 INFO - 'USER': 'cltbld', 03:51:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:26 INFO - '_': '/tools/buildbot/bin/python'} 03:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:26 INFO - Running setup.py (path:/tmp/pip-z0i_sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:26 INFO - Running setup.py (path:/tmp/pip-Z7PVvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:26 INFO - Running setup.py (path:/tmp/pip-hji0bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:26 INFO - Running setup.py (path:/tmp/pip-JRoSNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:26 INFO - Running setup.py (path:/tmp/pip-kV_5Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:26 INFO - Running setup.py (path:/tmp/pip-hKHdgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:26 INFO - Running setup.py (path:/tmp/pip-dPe81F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:26 INFO - Running setup.py (path:/tmp/pip-fXGd2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:26 INFO - Running setup.py (path:/tmp/pip-eqDB5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:26 INFO - Running setup.py (path:/tmp/pip-zMbUEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:27 INFO - Running setup.py (path:/tmp/pip-UK_ZDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:27 INFO - Running setup.py (path:/tmp/pip-nz2JGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:27 INFO - Running setup.py (path:/tmp/pip-9C0Hus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:27 INFO - Running setup.py (path:/tmp/pip-iPWl4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:27 INFO - Running setup.py (path:/tmp/pip-dQhDYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:27 INFO - Running setup.py (path:/tmp/pip-FzPaM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:27 INFO - Running setup.py (path:/tmp/pip-iD3B_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:27 INFO - Running setup.py install for manifestparser 03:51:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:27 INFO - Running setup.py install for mozcrash 03:51:27 INFO - Running setup.py install for mozdebug 03:51:27 INFO - Running setup.py install for mozdevice 03:51:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:27 INFO - Running setup.py install for mozfile 03:51:28 INFO - Running setup.py install for mozhttpd 03:51:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozinfo 03:51:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozInstall 03:51:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozleak 03:51:28 INFO - Running setup.py install for mozlog 03:51:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for moznetwork 03:51:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozprocess 03:51:28 INFO - Running setup.py install for mozprofile 03:51:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozrunner 03:51:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Running setup.py install for mozscreenshot 03:51:29 INFO - Running setup.py install for moztest 03:51:29 INFO - Running setup.py install for mozversion 03:51:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:29 INFO - Cleaning up... 03:51:29 INFO - Return code: 0 03:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:29 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:29 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 03:51:29 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 03:51:29 INFO - Using env: {'DISPLAY': ':0', 03:51:29 INFO - 'HOME': '/home/cltbld', 03:51:29 INFO - 'LANG': 'en_US.UTF-8', 03:51:29 INFO - 'LANGUAGE': 'en_US:en', 03:51:29 INFO - 'LOGNAME': 'cltbld', 03:51:29 INFO - 'MAIL': '/var/mail/cltbld', 03:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:29 INFO - 'MOZ_NO_REMOTE': '1', 03:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:29 INFO - 'NO_EM_RESTART': '1', 03:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:29 INFO - 'PWD': '/builds/slave/test', 03:51:29 INFO - 'SHELL': '/bin/bash', 03:51:29 INFO - 'SHLVL': '1', 03:51:29 INFO - 'TERM': 'linux', 03:51:29 INFO - 'TMOUT': '86400', 03:51:29 INFO - 'USER': 'cltbld', 03:51:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:29 INFO - '_': '/tools/buildbot/bin/python'} 03:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:29 INFO - Running setup.py (path:/tmp/pip-4tiUy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:29 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)) 03:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:29 INFO - Running setup.py (path:/tmp/pip-emzQGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:29 INFO - Running setup.py (path:/tmp/pip-a3YDMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:29 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)) 03:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:29 INFO - Running setup.py (path:/tmp/pip-5tbPFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:29 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)) 03:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:29 INFO - Running setup.py (path:/tmp/pip-tjv4Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:29 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)) 03:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:29 INFO - Running setup.py (path:/tmp/pip-wxhZ38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:30 INFO - Running setup.py (path:/tmp/pip-wBdNeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:30 INFO - Running setup.py (path:/tmp/pip-SUqJ1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:30 INFO - Running setup.py (path:/tmp/pip-Sp8GrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:30 INFO - Running setup.py (path:/tmp/pip-BzwYZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:30 INFO - Running setup.py (path:/tmp/pip-VXj123-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:30 INFO - Running setup.py (path:/tmp/pip-H2Mjrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:30 INFO - Running setup.py (path:/tmp/pip-F8rpIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:30 INFO - Running setup.py (path:/tmp/pip-x_7sx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:30 INFO - Running setup.py (path:/tmp/pip-G22PbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:30 INFO - Running setup.py (path:/tmp/pip-NuNizL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:30 INFO - Running setup.py (path:/tmp/pip-eUsgFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:30 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)) 03:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:51:30 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)) 03:51:30 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)) 03:51:30 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)) 03:51:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:30 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 03:51:30 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 03:51:30 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 03:51:30 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 03:51:30 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 03:51:30 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 03:51:32 INFO - Downloading blessings-1.6.tar.gz 03:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:32 INFO - Installing collected packages: blessings 03:51:32 INFO - Running setup.py install for blessings 03:51:32 INFO - Successfully installed blessings 03:51:32 INFO - Cleaning up... 03:51:32 INFO - Return code: 0 03:51:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:33 INFO - Reading from file tmpfile_stdout 03:51:33 INFO - Current package versions: 03:51:33 INFO - argparse == 1.2.1 03:51:33 INFO - blessings == 1.6 03:51:33 INFO - blobuploader == 1.2.4 03:51:33 INFO - docopt == 0.6.1 03:51:33 INFO - functools32 == 3.2.3-2 03:51:33 INFO - jsonschema == 2.5.1 03:51:33 INFO - manifestparser == 1.1 03:51:33 INFO - mozInstall == 1.12 03:51:33 INFO - mozcrash == 0.17 03:51:33 INFO - mozdebug == 0.1 03:51:33 INFO - mozdevice == 0.48 03:51:33 INFO - mozfile == 1.2 03:51:33 INFO - mozhttpd == 0.7 03:51:33 INFO - mozinfo == 0.9 03:51:33 INFO - mozleak == 0.1 03:51:33 INFO - mozlog == 3.3 03:51:33 INFO - moznetwork == 0.27 03:51:33 INFO - mozprocess == 0.23 03:51:33 INFO - mozprofile == 0.28 03:51:33 INFO - mozrunner == 6.12 03:51:33 INFO - mozscreenshot == 0.1 03:51:33 INFO - mozsystemmonitor == 0.3 03:51:33 INFO - moztest == 0.7 03:51:33 INFO - mozversion == 1.4 03:51:33 INFO - psutil == 3.1.1 03:51:33 INFO - requests == 1.2.3 03:51:33 INFO - wsgiref == 0.1.2 03:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:33 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:33 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 03:51:33 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 03:51:33 INFO - Using env: {'DISPLAY': ':0', 03:51:33 INFO - 'HOME': '/home/cltbld', 03:51:33 INFO - 'LANG': 'en_US.UTF-8', 03:51:33 INFO - 'LANGUAGE': 'en_US:en', 03:51:33 INFO - 'LOGNAME': 'cltbld', 03:51:33 INFO - 'MAIL': '/var/mail/cltbld', 03:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:33 INFO - 'MOZ_NO_REMOTE': '1', 03:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:33 INFO - 'NO_EM_RESTART': '1', 03:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:33 INFO - 'PWD': '/builds/slave/test', 03:51:33 INFO - 'SHELL': '/bin/bash', 03:51:33 INFO - 'SHLVL': '1', 03:51:33 INFO - 'TERM': 'linux', 03:51:33 INFO - 'TMOUT': '86400', 03:51:33 INFO - 'USER': 'cltbld', 03:51:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:33 INFO - '_': '/tools/buildbot/bin/python'} 03:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 INFO - Cleaning up... 03:51:33 INFO - Return code: 0 03:51:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:33 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 0x2116030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, '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': '4300f881736b422476174874000001bc-1473504114.208304-109008610', '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 03:51:33 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 03:51:33 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 03:51:33 INFO - Using env: {'DISPLAY': ':0', 03:51:33 INFO - 'HOME': '/home/cltbld', 03:51:33 INFO - 'LANG': 'en_US.UTF-8', 03:51:33 INFO - 'LANGUAGE': 'en_US:en', 03:51:33 INFO - 'LOGNAME': 'cltbld', 03:51:33 INFO - 'MAIL': '/var/mail/cltbld', 03:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:33 INFO - 'MOZ_NO_REMOTE': '1', 03:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:33 INFO - 'NO_EM_RESTART': '1', 03:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:33 INFO - 'PWD': '/builds/slave/test', 03:51:33 INFO - 'SHELL': '/bin/bash', 03:51:33 INFO - 'SHLVL': '1', 03:51:33 INFO - 'TERM': 'linux', 03:51:33 INFO - 'TMOUT': '86400', 03:51:33 INFO - 'USER': 'cltbld', 03:51:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:33 INFO - '_': '/tools/buildbot/bin/python'} 03:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:33 INFO - Cleaning up... 03:51:33 INFO - Return code: 0 03:51:33 INFO - Running post-action listener: _resource_record_post_action 03:51:33 INFO - Running post-action listener: _start_resource_monitoring 03:51:33 INFO - Starting resource monitoring. 03:51:33 INFO - [mozharness: 2016-09-10 10:51:33.609842Z] Finished create-virtualenv step (success) 03:51:33 INFO - [mozharness: 2016-09-10 10:51:33.610306Z] Running install step. 03:51:33 INFO - Running pre-action listener: _resource_record_pre_action 03:51:33 INFO - Running main action method: install 03:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:33 INFO - Reading from file tmpfile_stdout 03:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:33 INFO - Reading from file tmpfile_stdout 03:51:33 INFO - Output received: 03:51:33 INFO - Usage: mozinstall [options] installer 03:51:33 INFO - Options: 03:51:33 INFO - -h, --help show this help message and exit 03:51:33 INFO - -d DEST, --destination=DEST 03:51:33 INFO - Directory to install application into. [default: 03:51:33 INFO - "/builds/slave/test"] 03:51:33 INFO - --app=APP Application being installed. [default: firefox] 03:51:33 INFO - mkdir: /builds/slave/test/build/application 03:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:51:50 INFO - Reading from file tmpfile_stdout 03:51:50 INFO - Output received: 03:51:50 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:50 INFO - Running post-action listener: _resource_record_post_action 03:51:50 INFO - [mozharness: 2016-09-10 10:51:50.200141Z] Finished install step (success) 03:51:50 INFO - [mozharness: 2016-09-10 10:51:50.200422Z] Running run-tests step. 03:51:50 INFO - Running pre-action listener: _resource_record_pre_action 03:51:50 INFO - Running main action method: run_tests 03:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:50 INFO - Python 2.7.3 03:51:50 INFO - Return code: 0 03:51:50 INFO - grabbing minidump binary from tooltool 03:51:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:50 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 0x23d4570>, '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 0x23d5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:50 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 03:51:50 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 03:51:50 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 03:51:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:50 INFO - Return code: 0 03:51:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:51:50 INFO - Using env: {'DISPLAY': ':0', 03:51:50 INFO - 'HOME': '/home/cltbld', 03:51:50 INFO - 'LANG': 'en_US.UTF-8', 03:51:50 INFO - 'LANGUAGE': 'en_US:en', 03:51:50 INFO - 'LOGNAME': 'cltbld', 03:51:50 INFO - 'MAIL': '/var/mail/cltbld', 03:51:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:50 INFO - 'MOZ_NO_REMOTE': '1', 03:51:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:50 INFO - 'NO_EM_RESTART': '1', 03:51:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:50 INFO - 'PWD': '/builds/slave/test', 03:51:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:50 INFO - 'SHELL': '/bin/bash', 03:51:50 INFO - 'SHLVL': '1', 03:51:50 INFO - 'TERM': 'linux', 03:51:50 INFO - 'TMOUT': '86400', 03:51:50 INFO - 'USER': 'cltbld', 03:51:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1473504114.208304-109008610', 03:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:50 INFO - '_': '/tools/buildbot/bin/python'} 03:51:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:51:50 INFO - mozversion application_buildid: 20160910004004 03:51:50 INFO - mozversion application_changeset: 28878b37a89e309b3311bc9cc6aa864a74a96d3e 03:51:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:51:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:50 INFO - mozversion application_name: Firefox 03:51:50 INFO - mozversion application_remotingname: firefox-dev 03:51:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:51:50 INFO - mozversion application_vendor: Mozilla 03:51:50 INFO - mozversion application_version: 50.0a2 03:51:50 INFO - mozversion platform_buildid: 20160910004004 03:51:50 INFO - mozversion platform_changeset: 28878b37a89e309b3311bc9cc6aa864a74a96d3e 03:51:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:51:50 INFO - mozversion platform_version: 50.0a2 03:51:50 INFO - using testdate: 1473504710 03:51:50 INFO - actual date: 1473504710 03:51:50 INFO - starting webserver on 'localhost:35819' 03:51:50 INFO - SUITE-START | Running 2 tests 03:51:50 INFO - TEST-START | dromaeo_css 03:51:50 INFO - operating with platform_type : linux_ 03:51:50 INFO - Initialising browser for dromaeo_css test... 03:51:50 INFO - TEST-INFO | started process 3227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCl7gT5/profile http://localhost:35819/getInfo.html) 03:51:54 INFO - PROCESS | 3227 | __metrics Screen width/height:1600/1200 03:51:54 INFO - PROCESS | 3227 | colorDepth:24 03:51:54 INFO - PROCESS | 3227 | Browser inner width/height: 1024/697 03:51:54 INFO - PROCESS | 3227 | __metrics 03:51:55 ERROR - PROCESS | 3227 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:51:56 INFO - TEST-INFO | 3227: exit 0 03:51:56 INFO - Browser initialized. 03:51:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:56 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCl7gT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:08 INFO - PROCESS | 3351 | RSS: Main: 153415680 03:52:08 INFO - PROCESS | 3351 | 03:52:58 INFO - PROCESS | 3351 | 1473504778058 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] 03:55:06 INFO - PROCESS | 3351 | Cycle 1(1): loaded http://localhost:35819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35819/tests/dromaeo/cssquery-ext.html) 03:55:07 INFO - PROCESS | 3351 | RSS: Main: 159514624 03:55:07 INFO - PROCESS | 3351 | 03:58:09 INFO - PROCESS | 3351 | Cycle 1(1): loaded http://localhost:35819/tests/dromaeo/cssquery-ext.html (next: http://localhost:35819/tests/dromaeo/cssquery-jquery.html) 03:58:10 INFO - PROCESS | 3351 | RSS: Main: 155828224 03:58:10 INFO - PROCESS | 3351 | 04:01:12 INFO - PROCESS | 3351 | Cycle 1(1): loaded http://localhost:35819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35819/tests/dromaeo/cssquery-mootools.html) 04:01:12 INFO - PROCESS | 3351 | RSS: Main: 156618752 04:01:12 INFO - PROCESS | 3351 | 04:04:14 INFO - PROCESS | 3351 | Cycle 1(1): loaded http://localhost:35819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35819/tests/dromaeo/cssquery-prototype.html) 04:04:15 INFO - PROCESS | 3351 | RSS: Main: 155488256 04:04:15 INFO - PROCESS | 3351 | 04:07:17 INFO - PROCESS | 3351 | Cycle 1(1): loaded http://localhost:35819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35819/tests/dromaeo/cssquery-yui.html) 04:07:18 INFO - PROCESS | 3351 | RSS: Main: 157855744 04:07:18 INFO - PROCESS | 3351 | 04:10:20 INFO - PROCESS | 3351 | Cycle 1(1): loaded http://localhost:35819/tests/dromaeo/cssquery-yui.html (next: http://localhost:35819/tests/dromaeo/cssquery-dojo.html) 04:10:21 INFO - PROCESS | 3351 | RSS: Main: 157601792 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | __start_tp_report 04:10:21 INFO - PROCESS | 3351 | _x_x_mozilla_page_load 04:10:21 INFO - PROCESS | 3351 | _x_x_mozilla_page_load_details 04:10:21 INFO - PROCESS | 3351 | |i|pagename|runs| 04:10:21 INFO - PROCESS | 3351 | |0;dojo.html;3303.933921321573;3325.7339412846973;3339.74951878609;3342.231286804035;3357.916052098697;5693.03218452863;5705.971470142648;5787.450192231731;5821.67980761058;5822.737976791044;5725.2843394575675;5727.3699893011735;5742.6841523716175;5755.165501002352;5772.769089236425;5202.713850738208;5233.267342572043;5299.178627312773;5302.151655735083;5341.679499230058;5113.6931784092885;5115.028144652504;5158;5176.974115129419;5214.270002199676;5186.559142472895;5187.766550505217;5207.4792520748;5266.368035835686;5294.4176140624695;5253.185756207775;5260.342457192851;5270.789168433296;5271;5304.416514183436;5014.197728363444;5087.592992560586;5160.664556803796;5174.482551744795;5248.422673505911;5547.11246200606;5636.267285252932;5648.519875810561;5649;5652.519535839418;6071.2714474263375;6095.329513753483;6109.236345456818;6125.938740612626;6127.5710700251;5908.940910590882;6067.908981365283;6163.476104531121;6174.660393678346;6185.041318595625;5643.209950606918;5743.511801496836;5749.137629355547;5779.855503612402;5791.391903850077;6167.444929956326;6190.102435146879;6237.781677641261;6254.405831446005;6261.060840873905;5839.562032847553;5954;5966.134910437962;6029.246344206974;6036.3360030396625;6121.112438696364;6195.659238741912;6211.2857021442205;6215.254169499599;6228.159198508143;6131.938680613137;6202.875942481125;6209.223847019122;6210.378962103844;6214.844628884314;5842.977478941169;5926.67403292823;6157.630542167484;6192.411720886508;6201.937980620226;4640.280756482751;4649.883752906137;4667.043256132485;4708.128996135726;4762.571368576775;4173.749575025508;4186.790660466964;4196.349565817303;4234.1108367242605;4245.405643209953;5549.1676248563035;5866.325372582208;5887.735051922588;5900.409959004065;5903.881922361615;6038;6053.092036194606;6101.755929762849;6145.723442445101;6179.969100154561;5826.446487583673;5837.9124313135335;5872.970635146882;5875.9118613220835;5887.322957859816;5131.127708289525;5255.159174532057;5262.763175657028;5271.288376069181;5274.050670879202;6143.112737013686;6315.242170939517;6346.746130154835;6379.043143528415;6471.126397936312;6256.937430625636;6260.718267678057;6261.812145635638;6266.874662506815;6283.120363149254;6379.617222966637;6423.293437721753;6428.325025872216;6444.4844412445955;6446.29090800021;5840.532757379485;6029.4874935629205;6061.090836374579;6068;6162.907556386568;6196.535259855439;6204.689765511616;6223.097650840693;6229.937700622936;6252.812415627538;6053.3946605339115;6056.121862330026;6067.120267561268;6075.787347442818;6099.420555047263;5662.178984047207;5982.820515384546;5994.550408719277;6012.5791194617705;6116.418940200674;6027.487663548647;6049.243844519435;6058.757649693963;6062.848428789139;6063.969680151571;6004.0093384591055;6096.817095487142;6124.846878828065;6126.571140020156;6133.754649813957;5663.093904975184;5826.359100498857;5893.764249430146;5910.497607703393;6023.578349515492 04:10:21 INFO - PROCESS | 3351 | |1;ext.html;587.5681374189969;638.1225814505055;663.5521023309267;668.742534124362;672.0624728503741;33872.66127338726;45915.540844591545;46499.767501162445;47050.52949470504;47354.526454735445;47000.294995575096;47360.28959565609;47514;47539.28691069637;47562.76218618911;9164.175224229835;9247.306452016091;9299.163075323253;9319.534023298842;9347.065293470632;9146.31402644801;9155.038720934306;9170.908290917072;9180.403273787182;9181.265498760084;9235.168834804866;9312.8603070954;9314.673986410477;9317.208037316836;9341.065893410672;9180.265578753684;9180.357374983754;9198.816023679523;9215.769605759877;9233.353665243436;9101.908980910172;9173.770655733593;9231.584578693908;9242.953785231031;9248.861267081;44039.339409908556;44131.55868441307;44231;44259.55740442587;44340.55659443429;3682.981585092084;3808.409696497047;3823.598522155189;3841;3882.8835134946;34001.48997765035;34099;34169.487457688156;34642.30715385678;35660;4613.538646135393;4615.20055035445;4624.3757092792375;4732.881677958044;4744.14605371033;330538;330618;330623.34688326647;331099;332310;37253.25493490115;38380.42429363562;60127.699361503786;60496.69751651213;60603.69698151569;40127.59872401297;40276.194476110315;40643;40821.18357632831;40826.59173408228;15374.9231253843;15428.768568471482;15508.51863701825;15543.766843497357;15606.14166220846;12942.288174150512;12988.675283117998;12995.935020324838;13085.672858178432;13090.410931508104;9043;9128.726138215865;9140.497272649935;9192.81614367709;9206.493642849573;3607.783532988029;3614.0784100054843;3619.800910949923;3624.4925710400566;3626.8575398749836;1081.9242653014214;1088.7931293054294;1092.1549363907066;1162.0993729859426;1193.6299747078433;29983.250418739706;32763.344733105205;33126.503102453484;33399.16502087467;33778.8311058448;1168.1297433411992;1193.9522419103312;1248.7814632439467;1259.3514340114848;1262.5265525427965;17196.570085747957;17423.303067877143;17441.7383739244;17520.737188942177;17889.821101789075;333609;335997;425527;429341;432276;58211;58992.41007589869;59082.40917590769;59097.70451147717;59144;1417.688108616103;1440.3302464354126;1449.4564538298139;1458.0741229319246;1458.1761304862719;31931.201719957186;32397.676023239466;32588.674113259513;33189.834050830555;33530.161745956546;45225.773871130434;45549.31676024796;45607.31589026233;45744.54255457536;45824.54175458203;297822;298120;299050;299362;299684;28595.714042859305;28629.713702862704;28833.135005949855;28841.42317153687;29028.12915612535;46721.53278467172;46860;46934.29598556093;47298;47380;39589;39617.40573891336;39926.401103982884;39958.60041399549;41243.38134927918;39549.80225098856;39773.60226397699;40123.79938100291;40186.39720404255;41418.58581414147;39581.80209098936;41055.79472102621;42302.36546451867;43799.781001094794;45260.321095184256;35640.82179589189;37067;37549;37810.81094594619;38094.8095259533;28834.567481488215;29104.854475727487;29281.85359073191;29395.85302073476;29759.702402975694 04:10:21 INFO - PROCESS | 3351 | |2;jquery.html;417.8161608892089;426.33278918492556;430.18842445900907;433.7072476078648;437.8183054032577;18776.530586735338;19449.80550194496;20322;20464;20573.794262057374;19714.507137321572;20260.797392026074;20305.18779248832;20674.379768606967;21017;5702.4012478689765;5817.8836423271505;5868.677222752747;5890.5582081343855;5895.086261629454;5771.711414429262;5773.538116950634;5791.507721843648;5795.1017592273265;5855.033919403315;5666.093425051992;5777.277840269966;5818.0400233961345;5819.30168379795;5832.795852145176;5715.3141623005085;5775.249217601706;5783.826485205451;5787.074068149118;5846.590738648296;5268.157094864803;5270.841874743764;5277.366715994067;5283.313169288006;5286.497782710637;23424.414389640224;24382.878085609635;24440.14459493909;24505.63241551378;24841.378965525826;2486.925392238236;2499.237732491589;2522.785563227128;2552.6681531400986;2584.431425086497;15620.531384058382;15648.608784780357;15746.685066298724;15892.76160857588;16004;2079.1475495046957;2131.531063166101;2182.0835249195375;2184.5740080684272;2186.737591489016;51498.22752658713;68229;84211.57894210551;84681.15318846855;86331;11179.4969226385;11192.216544841946;11407.543698251977;11532;11728;16155;16164.919175404048;16198.75701864473;16238.75641865373;16275;8476.660933562713;8508.787280318042;8523.701670441505;8604.956975215084;8793.252573531194;8354.164583541597;8380.622871970776;8444.957775211085;8565.100664430145;8686.391952563386;6726.091977582963;6880.621565813928;7004.793490050618;7039.225685174627;7056.576605403692;2082.4793801549613;2098.9055492502875;2116.6190085784706;2116.8941552922292;2123.384218576626;970.7281961050917;1059.3590877519143;1092.126298960844;1100.301308669001;1167.5038108803894;20813.89593052025;21014.57970840605;21145.78854211438;21306.36080917575;21356.893215533823;1094.2285688589525;1121.7812526557243;1144.9484773185227;1147.4205526209378;1187.8752730963297;11803.822942655866;11829.52681892732;11885.22746021506;11999.760004799855;12016.819747703792;500913;525112;528272;530775;532085;80241;82526.58736706278;83008.58495707603;85993.57003214944;88307.55846220856;1073.0771536478621;1079.4279032112993;1080.68660088575;1083.0847933496184;1114.3815182573749;18274.90862545679;18338;18497.352592659194;18673.813261867206;18792.436226913214;39585.80207098946;41620.375694364004;41642;42053.1589368217;43454;53939.730301348245;61062;62358.688206560495;62549.37450625435;63444;9135.588898499716;9213.355065145375;9247.213986810928;9286.6285348588;9402.482863442303;10188.64339748135;14208.289585520475;14237.145771253758;14757.188354640597;14871.256437178314;12135.393230338625;12143.14997950135;12413.875861241271;12488.500459981498;12746.745065098832;11405.600803971822;11580.189386743185;12001.099917506397;12265.877341226473;12530.74938501243;12537.498500059895;12628;12739.426725797546;12781.8082728761;13130;9159.496227707274;9302.255819534555;9358.11097945694;9378.343515953818;9561.474118923526;11562.075033997091;12027.45876435545;12415.193012454161;12480;12700.488058048057 04:10:21 INFO - PROCESS | 3351 | |3;mootools.html;1544.3359355477144;1592.5938885584178;1752.7370894365843;1852.8425083867871;1871.1018711018703;8227.62975666095;8756.255718263947;8901.109889011095;9515.80968380632;9522.238220942325;8833.823323533525;9168.404053736502;9170.128837760401;9171.77070573236;9237.861432078524;2508.0594776958596;2548.1081621432536;2562.7309132541095;2563.346346681603;2569.704483984338;2448.375664205625;2582.457683886386;2584.095566551711;2584.328074700582;2600.6749156355454;2532.392225865788;2559.5520783862844;2569.280601431593;2575.7037940636787;2583.870806459679;2521.13021007752;2524.9621255681086;2530.734272901337;2553.8467691938545;2557.322309587942;2473.245660073677;2475.913343033003;2488.726240113586;2499.662545556363;2521.1428114440996;9047.54762261891;9327.673531426435;9364.953175234148;9382.014888436752;9387.530623468867;5509.972450137764;5563.749631266603;5591.3569939456665;5605.32736071674;5606.607537472379;3479.1997840496574;3655.5430571178604;3671.2473942841652;3682.834272457746;3701.777893326409;1211.8606360268593;1243.1360204657767;1247.3638444393334;1254.736505333881;1260.319427509144;11621.360825154614;11697.122715796264;11941.701457463547;12273.20224185434;12757.936210318981;4909.091818013679;4942.827001054946;4973.676711013773;5010.1733214020005;5060.240963855377;10069.345492542961;10090.848637270446;10102.444365559964;10231;10297.485125743682;5584.022796010682;5592.189132575753;5595.916061259084;5617.41017193197;5624.55003599711;4785;5060.240963855451;5143.948560514422;5164.535191832753;5282.392524859691;4099.327217125382;4132.504099508078;4140.710150289451;4160.438340824011;4182.477190351206;1242.9067819913362;1277.7444511097817;1279.0982357437983;1280.7182419867613;1282.185812009362;959.2949182350967;983.7098056073476;992.7815880506278;1014.1177175857051;1029.563758556824;5622.8313150605545;6047.697615119315;6051.092336149525;6208.099825525273;6214.347493513206;982.9705108846746;985.9014098590084;1014.3660212367271;1057.7884423115254;1060.1942523681903;4010.839566417369;4043.9191216175514;4098.180363927167;4165.75005499671;4187.14163596462;11460.255083419552;11809.291442513477;11812.645620631394;11814.586489472998;11823.527058917547;10844.186685998582;11580.247283926517;11616.88383116175;11632.767344653059;11683.474243659055;8322.29260512851;8867.246284065926;8893.4663920165;8917.152870477294;8917.974432940166;6176.320604733565;6239.844003899757;6340.461060809698;6341.334159913327;6356.491480681442;10824.350538967687;11034.503447344729;11086.944565277123;11229.4385280734;11248.100151987657;10807.405592692478;11040.613578524713;11107.72230694239;11115.333080015225;11132.944335278271;7471.925280747123;7875.960620196863;7976.960115199387;8222.753317400247;8379.539125347921;9155.908440915506;9156.175944165057;9227.907720922973;9230;9231.492267925329;8217.671293148207;8258.298044666271;8303.335733141455;8311.95844020776;8475.279601233964;7974.601269936596;8010.279074883289;8048.718294859652;8059.073206581318;8208.261256486945;7139.393151581966;7150.463715221275;7178.246284140299;7260.782176534713;7333.889991650023;5026.623003274842;5209.609279303992;5236.240745092016;5271.7891284349735;5325.627206095536;5249.868753281198;5339.145736682112;5342.6260161788305;5378.139497680352;5428.15863541136 04:10:21 INFO - PROCESS | 3351 | |4;prototype.html;353.094313086932;358.18512883190743;358.7309517861604;369.16384389358126;377.2473914540492;5756.107803290486;5763;5873.853153671161;5946.940530594693;5984.700764961751;5733.111367738007;5784.768609255625;5809.559984806381;5821.563382746301;5844.357120716718;4605.585497305242;4625.167469855424;4637.9100911285905;4640.118377508263;4656.649571624225;4470.8882277942985;4589.128065667529;4598.919253975329;4621.560951709582;4656.953430465703;4532.3881276027805;4537;4540.523245059271;4552.430946131733;4605.309203619468;4397.494288156839;4603.677742558039;4617.399738034051;4621.098885717286;4636.698614590075;3987.182627561343;3995.161016186575;3995.700322475826;3996.18078293949;3998.460207871929;5662.745176467028;5663.630140066653;5682.602217844753;5712.057510510761;5735.885282294331;5117.513836185556;5171.612129090333;5187.403448603422;5220.817271395483;5255.842324730226;6007.729652165663;6037.577369584131;6039.969800151015;6077;6082.391760823926;4390.824367025315;4397.032652816375;4416.933745993812;4424.159409712144;4439.5560443955665;6101.237345331833;6378.712957916859;6378.712957916905;6379.776707815251;6380.213540208749;4504.220832771102;4512.932306015412;4518.096380723869;4525.434320709911;4526.253168227206;4576.748278844629;4579.740571342841;4589.908201835945;4593;4601.148787474328;4963.45402005779;5202.479752024768;5225.477452254744;5237.816676416307;5246.7638956247065;5921.5558833086825;6083.266269113282;6109.297430795426;6109.358517355702;6109.5112391008615;1561.6017915431491;1565.506865337415;1580.0045971038173;1590.9443169489243;1591.4191320168286;977.9657711980046;1001.7578203028338;1005.5324274212526;1011.8532812742111;1021.7803172317987;5195.467337135554;5265.761556642714;5280.894382112413;5286;5291.444398338119;5434.347878254634;5502.697351645698;5546.639468434539;5570.693611851306;5611.466910643482;4886.60907127429;5175.353080864892;5221.269022336875;5251.579873610179;5262.7631756571045;2955.674875763664;2980.1953472562286;2982.6569944456232;3002.7597792176575;3024.5765592816583;5710.714464276853;5716.399778023331;5750.367459579443;5794.246747922743;5807.506361959281;6011.939880601138;6444.742210311629;6491.123698300669;6531.967340163269;6538.332725155055;6586.4401525870835;6621.172353455818;6624.834379140464;6634.341414646338;6667.233268174222;6166.784162554289;6270.498360131087;6349.904751428825;6379.298277189599;6468.676566171766;6174.969125154345;6282.277538083179;6352.333005034589;6361.236651601837;6365.61806291624;6404.487640988803;6504.869902601827;6522.608643481406;6579.440747536321;6676.933230667825;4511.120331535319;4517.841875534341;4542.954570454253;4543.568361005699;4558.840440584564;6107.4197951194565;6159;6347.58791659185;6361.522885783677;6386;6155.753769849335;6225.937740622536;6237.157983672146;6244.313125556276;6244.438000579969;6035.758569657164;6203.348648392034;6203.844903877259;6231.376862313914;6276;6088.6042407243385;6124.38756124384;6140.385961404003;6172.85802126608;6194.5973511721595;6183.319834818077;6249.25008998923;6274.623522588659;6275.6862156892885;6278.215223097113;5875.676837773964;6006.888725585781;6022.608530445507;6062.393760623902;6140.618360868947 04:10:21 INFO - PROCESS | 3351 | |5;yui.html;820.9671613135475;833.1626715151272;833.7540425574455;900.1268769293782;912.171353664267;16118.677626447465;17171;17206.13969301536;17336.306547738106;17408.912955435237;15389.307481163347;15464.22678866055;15566.533004009898;16193.514194574152;16633.334666613322;866.9263112635433;886.4681191285242;887.9822403551957;888.5424006636588;889.1597440418775;840.9243168114868;885.1148851148852;887.3300658003199;893.8301722672671;896.2337201692524;937.7608709778997;942.241495596045;946.2288235088415;946.7065209784988;947.7062110745657;938.0619380619312;938.6010945348233;941.0918463682546;943.3349488610513;944.1549812917435;687.9621620810854;689.4897775645986;689.6207086102673;689.8689249042666;693.4868197533839;16627.584310392216;16634.001959882324;16669.33322667092;16688.916555417265;16718.91640541802;16225.675486490321;16538.173091345383;16550;16736.497905062744;16817.915910420368;11899.821502677467;11989.160758746892;11990.940045299718;12060.276383417024;12207.572734954323;4117.258893399187;4162.21139756844;4230.323148296257;4247.851325203634;4249.978750106261;87346;87572.56213718954;88052;89366.5531672344;90198.5490072552;11519.193656444137;12639.052071094704;12655.367231638382;12666.746665066647;13090.214587124803;22981.310560683207;23139.3058208254;23275.650865237036;23324.65013024806;23356.54756250603;9163.404378715362;9480.194183494481;9624;9728.708138755848;9828.459434731016;5303.814366497154;5311.787528498817;5326.840194794162;5431.728413579305;5486.972565137149;3913.8630147944687;4053.777042262704;4065.2276067547073;4070.5725898780793;4075.694322925733;673.7406098651957;675.6317806795308;699.0876905638191;711.6589992109188;732.9706811727472;698.9021536984826;728.1189760389988;796.832665140327;798.7843282313743;800.7237503061434;10237.590496380062;10598.735031624272;10638.30850494997;10790.136789056856;10909.509072091774;685.2359619024851;731.3271789953255;773.2847116417291;797.2943944608946;812.0336799209041;5201.479852014768;5224.399194092728;5233.162693969023;5260.815871444481;5296.576273898156;132716;133695;133728;135356;140666;110872.44563777291;111225;114686;115058;118160.40919795346;102123;103260.48369758103;104592;106387;107682;9617.855732163884;9783.217342612432;9825.5087245636;9884.555195016097;9905.356151850106;57450;58570.707146463996;58858;60143.097853531355;61319;81478.59260703658;87869.56065219633;88175;90068.5496572513;90163;12702.237865728086;12721.491140354283;13007.219566826021;13053.34733263314;13548.525801596898;12383.69040773988;13015;13274.402651880882;14066.437342506186;14335.211563364115;12850.742985140432;13475.730485390433;13521.526746563823;13758.587242382744;14127.717445651235;14067.718645627236;14297.571072867831;14306.785398219243;14340.354684039035;15137.545873623809;13558.525451609146;13600.523981660594;13760;13916.373763180884;14186.645333866736;10995.450227488753;11393.601223957121;11535.250208736405;11825.586104486645;11828.053755699351;11356.943215284202;11380.829287560859;11537.077033837106;11553.133514986577;11928.76142477163 04:10:21 INFO - PROCESS | 3351 | __end_tp_report 04:10:21 INFO - PROCESS | 3351 | __start_cc_report 04:10:21 INFO - PROCESS | 3351 | _x_x_mozilla_cycle_collect,350 04:10:21 INFO - PROCESS | 3351 | __end_cc_report 04:10:21 INFO - PROCESS | 3351 | __startTimestamp1473505821020__endTimestamp 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | ------- Summary: start ------- 04:10:21 INFO - PROCESS | 3351 | Number of tests: 6 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | [#0] dojo.html Cycles:165 Average:5707.78 Median:5908.94 stddev:654.76 (11.1%) stddev-sans-first:629.02 04:10:21 INFO - PROCESS | 3351 | Values: 3303.9 3325.7 3339.7 3342.2 3357.9 5693.0 5706.0 5787.5 5821.7 5822.7 5725.3 5727.4 5742.7 5755.2 5772.8 5202.7 5233.3 5299.2 5302.2 5341.7 5113.7 5115.0 5158.0 5177.0 5214.3 5186.6 5187.8 5207.5 5266.4 5294.4 5253.2 5260.3 5270.8 5271.0 5304.4 5014.2 5087.6 5160.7 5174.5 5248.4 5547.1 5636.3 5648.5 5649.0 5652.5 6071.3 6095.3 6109.2 6125.9 6127.6 5908.9 6067.9 6163.5 6174.7 6185.0 5643.2 5743.5 5749.1 5779.9 5791.4 6167.4 6190.1 6237.8 6254.4 6261.1 5839.6 5954.0 5966.1 6029.2 6036.3 6121.1 6195.7 6211.3 6215.3 6228.2 6131.9 6202.9 6209.2 6210.4 6214.8 5843.0 5926.7 6157.6 6192.4 6201.9 4640.3 4649.9 4667.0 4708.1 4762.6 4173.7 4186.8 4196.3 4234.1 4245.4 5549.2 5866.3 5887.7 5900.4 5903.9 6038.0 6053.1 6101.8 6145.7 6180.0 5826.4 5837.9 5873.0 5875.9 5887.3 5131.1 5255.2 5262.8 5271.3 5274.1 6143.1 6315.2 6346.7 6379.0 6471.1 6256.9 6260.7 6261.8 6266.9 6283.1 6379.6 6423.3 6428.3 6444.5 6446.3 5840.5 6029.5 6061.1 6068.0 6162.9 6196.5 6204.7 6223.1 6229.9 6252.8 6053.4 6056.1 6067.1 6075.8 6099.4 5662.2 5982.8 5994.6 6012.6 6116.4 6027.5 6049.2 6058.8 6062.8 6064.0 6004.0 6096.8 6124.8 6126.6 6133.8 5663.1 5826.4 5893.8 5910.5 6023.6 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | [#1] ext.html Cycles:180 Average:51000.82 Median:39942.50 stddev:90246.80 (225.9%) stddev-sans-first:90420.59 04:10:21 INFO - PROCESS | 3351 | Values: 587.6 638.1 663.6 668.7 672.1 33872.7 45915.5 46499.8 47050.5 47354.5 47000.3 47360.3 47514.0 47539.3 47562.8 9164.2 9247.3 9299.2 9319.5 9347.1 9146.3 9155.0 9170.9 9180.4 9181.3 9235.2 9312.9 9314.7 9317.2 9341.1 9180.3 9180.4 9198.8 9215.8 9233.4 9101.9 9173.8 9231.6 9243.0 9248.9 44039.3 44131.6 44231.0 44259.6 44340.6 3683.0 3808.4 3823.6 3841.0 3882.9 34001.5 34099.0 34169.5 34642.3 35660.0 4613.5 4615.2 4624.4 4732.9 4744.1 330538.0 330618.0 330623.3 331099.0 332310.0 37253.3 38380.4 60127.7 60496.7 60603.7 40127.6 40276.2 40643.0 40821.2 40826.6 15374.9 15428.8 15508.5 15543.8 15606.1 12942.3 12988.7 12995.9 13085.7 13090.4 9043.0 9128.7 9140.5 9192.8 9206.5 3607.8 3614.1 3619.8 3624.5 3626.9 1081.9 1088.8 1092.2 1162.1 1193.6 29983.3 32763.3 33126.5 33399.2 33778.8 1168.1 1194.0 1248.8 1259.4 1262.5 17196.6 17423.3 17441.7 17520.7 17889.8 333609.0 335997.0 425527.0 429341.0 432276.0 58211.0 58992.4 59082.4 59097.7 59144.0 1417.7 1440.3 1449.5 1458.1 1458.2 31931.2 32397.7 32588.7 33189.8 33530.2 45225.8 45549.3 45607.3 45744.5 45824.5 297822.0 298120.0 299050.0 299362.0 299684.0 28595.7 28629.7 28833.1 28841.4 29028.1 46721.5 46860.0 46934.3 47298.0 47380.0 39589.0 39617.4 39926.4 39958.6 41243.4 39549.8 39773.6 40123.8 40186.4 41418.6 39581.8 41055.8 42302.4 43799.8 45260.3 35640.8 37067.0 37549.0 37810.8 38094.8 28834.6 29104.9 29281.9 29395.9 29759.7 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | [#2] jquery.html Cycles:180 Average:30249.04 Median:24411.51 stddev:85841.26 (351.6%) stddev-sans-first:86052.85 04:10:21 INFO - PROCESS | 3351 | Values: 417.8 426.3 430.2 433.7 437.8 18776.5 19449.8 20322.0 20464.0 20573.8 19714.5 20260.8 20305.2 20674.4 21017.0 5702.4 5817.9 5868.7 5890.6 5895.1 5771.7 5773.5 5791.5 5795.1 5855.0 5666.1 5777.3 5818.0 5819.3 5832.8 5715.3 5775.2 5783.8 5787.1 5846.6 5268.2 5270.8 5277.4 5283.3 5286.5 23424.4 24382.9 24440.1 24505.6 24841.4 2486.9 2499.2 2522.8 2552.7 2584.4 15620.5 15648.6 15746.7 15892.8 16004.0 2079.1 2131.5 2182.1 2184.6 2186.7 51498.2 68229.0 84211.6 84681.2 86331.0 11179.5 11192.2 11407.5 11532.0 11728.0 16155.0 16164.9 16198.8 16238.8 16275.0 8476.7 8508.8 8523.7 8605.0 8793.3 8354.2 8380.6 8445.0 8565.1 8686.4 6726.1 6880.6 7004.8 7039.2 7056.6 2082.5 2098.9 2116.6 2116.9 2123.4 970.7 1059.4 1092.1 1100.3 1167.5 20813.9 21014.6 21145.8 21306.4 21356.9 1094.2 1121.8 1144.9 1147.4 1187.9 11803.8 11829.5 11885.2 11999.8 12016.8 500913.0 525112.0 528272.0 530775.0 532085.0 80241.0 82526.6 83008.6 85993.6 88307.6 1073.1 1079.4 1080.7 1083.1 1114.4 18274.9 18338.0 18497.4 18673.8 18792.4 39585.8 41620.4 41642.0 42053.2 43454.0 53939.7 61062.0 62358.7 62549.4 63444.0 9135.6 9213.4 9247.2 9286.6 9402.5 10188.6 14208.3 14237.1 14757.2 14871.3 12135.4 12143.1 12413.9 12488.5 12746.7 11405.6 11580.2 12001.1 12265.9 12530.7 12537.5 12628.0 12739.4 12781.8 13130.0 9159.5 9302.3 9358.1 9378.3 9561.5 11562.1 12027.5 12415.2 12480.0 12700.5 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | [#3] mootools.html Cycles:180 Average:6096.75 Median:4847.05 stddev:3426.05 (70.7%) stddev-sans-first:3418.57 04:10:21 INFO - PROCESS | 3351 | Values: 1544.3 1592.6 1752.7 1852.8 1871.1 8227.6 8756.3 8901.1 9515.8 9522.2 8833.8 9168.4 9170.1 9171.8 9237.9 2508.1 2548.1 2562.7 2563.3 2569.7 2448.4 2582.5 2584.1 2584.3 2600.7 2532.4 2559.6 2569.3 2575.7 2583.9 2521.1 2525.0 2530.7 2553.8 2557.3 2473.2 2475.9 2488.7 2499.7 2521.1 9047.5 9327.7 9365.0 9382.0 9387.5 5510.0 5563.7 5591.4 5605.3 5606.6 3479.2 3655.5 3671.2 3682.8 3701.8 1211.9 1243.1 1247.4 1254.7 1260.3 11621.4 11697.1 11941.7 12273.2 12757.9 4909.1 4942.8 4973.7 5010.2 5060.2 10069.3 10090.8 10102.4 10231.0 10297.5 5584.0 5592.2 5595.9 5617.4 5624.6 4785.0 5060.2 5143.9 5164.5 5282.4 4099.3 4132.5 4140.7 4160.4 4182.5 1242.9 1277.7 1279.1 1280.7 1282.2 959.3 983.7 992.8 1014.1 1029.6 5622.8 6047.7 6051.1 6208.1 6214.3 983.0 985.9 1014.4 1057.8 1060.2 4010.8 4043.9 4098.2 4165.8 4187.1 11460.3 11809.3 11812.6 11814.6 11823.5 10844.2 11580.2 11616.9 11632.8 11683.5 8322.3 8867.2 8893.5 8917.2 8918.0 6176.3 6239.8 6340.5 6341.3 6356.5 10824.4 11034.5 11086.9 11229.4 11248.1 10807.4 11040.6 11107.7 11115.3 11132.9 7471.9 7876.0 7977.0 8222.8 8379.5 9155.9 9156.2 9227.9 9230.0 9231.5 8217.7 8258.3 8303.3 8312.0 8475.3 7974.6 8010.3 8048.7 8059.1 8208.3 7139.4 7150.5 7178.2 7260.8 7333.9 5026.6 5209.6 5236.2 5271.8 5325.6 5249.9 5339.1 5342.6 5378.1 5428.2 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | [#4] prototype.html Cycles:180 Average:5097.47 Median:5673.12 stddev:1508.72 (26.6%) stddev-sans-first:1470.33 04:10:21 INFO - PROCESS | 3351 | Values: 353.1 358.2 358.7 369.2 377.2 5756.1 5763.0 5873.9 5946.9 5984.7 5733.1 5784.8 5809.6 5821.6 5844.4 4605.6 4625.2 4637.9 4640.1 4656.6 4470.9 4589.1 4598.9 4621.6 4657.0 4532.4 4537.0 4540.5 4552.4 4605.3 4397.5 4603.7 4617.4 4621.1 4636.7 3987.2 3995.2 3995.7 3996.2 3998.5 5662.7 5663.6 5682.6 5712.1 5735.9 5117.5 5171.6 5187.4 5220.8 5255.8 6007.7 6037.6 6040.0 6077.0 6082.4 4390.8 4397.0 4416.9 4424.2 4439.6 6101.2 6378.7 6378.7 6379.8 6380.2 4504.2 4512.9 4518.1 4525.4 4526.3 4576.7 4579.7 4589.9 4593.0 4601.1 4963.5 5202.5 5225.5 5237.8 5246.8 5921.6 6083.3 6109.3 6109.4 6109.5 1561.6 1565.5 1580.0 1590.9 1591.4 978.0 1001.8 1005.5 1011.9 1021.8 5195.5 5265.8 5280.9 5286.0 5291.4 5434.3 5502.7 5546.6 5570.7 5611.5 4886.6 5175.4 5221.3 5251.6 5262.8 2955.7 2980.2 2982.7 3002.8 3024.6 5710.7 5716.4 5750.4 5794.2 5807.5 6011.9 6444.7 6491.1 6532.0 6538.3 6586.4 6621.2 6624.8 6634.3 6667.2 6166.8 6270.5 6349.9 6379.3 6468.7 6175.0 6282.3 6352.3 6361.2 6365.6 6404.5 6504.9 6522.6 6579.4 6676.9 4511.1 4517.8 4543.0 4543.6 4558.8 6107.4 6159.0 6347.6 6361.5 6386.0 6155.8 6225.9 6237.2 6244.3 6244.4 6035.8 6203.3 6203.8 6231.4 6276.0 6088.6 6124.4 6140.4 6172.9 6194.6 6183.3 6249.3 6274.6 6275.7 6278.2 5875.7 6006.9 6022.6 6062.4 6140.6 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - PROCESS | 3351 | [#5] yui.html Cycles:180 Average:23633.74 Median:3983.82 stddev:35349.84 (887.3%) stddev-sans-first:35407.51 04:10:21 INFO - PROCESS | 3351 | Values: 821.0 833.2 833.8 900.1 912.2 16118.7 17171.0 17206.1 17336.3 17408.9 15389.3 15464.2 15566.5 16193.5 16633.3 866.9 886.5 888.0 888.5 889.2 840.9 885.1 887.3 893.8 896.2 937.8 942.2 946.2 946.7 947.7 938.1 938.6 941.1 943.3 944.2 688.0 689.5 689.6 689.9 693.5 16627.6 16634.0 16669.3 16688.9 16718.9 16225.7 16538.2 16550.0 16736.5 16817.9 11899.8 11989.2 11990.9 12060.3 12207.6 4117.3 4162.2 4230.3 4247.9 4250.0 87346.0 87572.6 88052.0 89366.6 90198.5 11519.2 12639.1 12655.4 12666.7 13090.2 22981.3 23139.3 23275.7 23324.7 23356.5 9163.4 9480.2 9624.0 9728.7 9828.5 5303.8 5311.8 5326.8 5431.7 5487.0 3913.9 4053.8 4065.2 4070.6 4075.7 673.7 675.6 699.1 711.7 733.0 698.9 728.1 796.8 798.8 800.7 10237.6 10598.7 10638.3 10790.1 10909.5 685.2 731.3 773.3 797.3 812.0 5201.5 5224.4 5233.2 5260.8 5296.6 132716.0 133695.0 133728.0 135356.0 140666.0 110872.4 111225.0 114686.0 115058.0 118160.4 102123.0 103260.5 104592.0 106387.0 107682.0 9617.9 9783.2 9825.5 9884.6 9905.4 57450.0 58570.7 58858.0 60143.1 61319.0 81478.6 87869.6 88175.0 90068.5 90163.0 12702.2 12721.5 13007.2 13053.3 13548.5 12383.7 13015.0 13274.4 14066.4 14335.2 12850.7 13475.7 13521.5 13758.6 14127.7 14067.7 14297.6 14306.8 14340.4 15137.5 13558.5 13600.5 13760.0 13916.4 14186.6 10995.5 11393.6 11535.3 11825.6 11828.1 11356.9 11380.8 11537.1 11553.1 11928.8 04:10:21 INFO - PROCESS | 3351 | -------- Summary: end -------- 04:10:21 INFO - PROCESS | 3351 | 04:10:21 INFO - TEST-INFO | 3351: exit 0 04:10:21 INFO - TEST-OK | dromaeo_css | took 1111292ms 04:10:21 INFO - TEST-START | kraken 04:10:21 INFO - operating with platform_type : linux_ 04:10:21 INFO - Initialising browser for kraken test... 04:10:21 INFO - TEST-INFO | started process 3619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp55koan/profile http://localhost:35819/getInfo.html) 04:10:26 INFO - PROCESS | 3619 | __metrics Screen width/height:1600/1200 04:10:26 INFO - PROCESS | 3619 | colorDepth:24 04:10:26 INFO - PROCESS | 3619 | Browser inner width/height: 1024/697 04:10:26 INFO - PROCESS | 3619 | __metrics 04:10:27 ERROR - PROCESS | 3619 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:10:27 INFO - TEST-INFO | 3619: exit 0 04:10:27 INFO - Browser initialized. 04:10:27 INFO - Running cycle 1/1 for kraken test... 04:10:27 INFO - TEST-INFO | started process 3749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp55koan/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:39 INFO - PROCESS | 3749 | RSS: Main: 153313280 04:10:39 INFO - PROCESS | 3749 | 04:10:42 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35819/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:43 INFO - PROCESS | 3749 | RSS: Main: 158498816 04:10:43 INFO - PROCESS | 3749 | 04:10:45 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35819/tests/kraken/driver.html?testName=audio-dft) 04:10:46 INFO - PROCESS | 3749 | RSS: Main: 157290496 04:10:46 INFO - PROCESS | 3749 | 04:10:49 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35819/tests/kraken/driver.html?testName=audio-fft) 04:10:49 INFO - PROCESS | 3749 | RSS: Main: 157732864 04:10:49 INFO - PROCESS | 3749 | 04:10:51 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35819/tests/kraken/driver.html?testName=audio-oscillator) 04:10:52 INFO - PROCESS | 3749 | RSS: Main: 157888512 04:10:52 INFO - PROCESS | 3749 | 04:10:54 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:55 INFO - PROCESS | 3749 | RSS: Main: 157515776 04:10:55 INFO - PROCESS | 3749 | 04:10:58 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35819/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:59 INFO - PROCESS | 3749 | RSS: Main: 157945856 04:10:59 INFO - PROCESS | 3749 | 04:11:02 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35819/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:03 INFO - PROCESS | 3749 | RSS: Main: 158326784 04:11:03 INFO - PROCESS | 3749 | 04:11:05 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35819/tests/kraken/driver.html?testName=json-parse-financial) 04:11:06 INFO - PROCESS | 3749 | RSS: Main: 158007296 04:11:06 INFO - PROCESS | 3749 | 04:11:07 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:08 INFO - PROCESS | 3749 | RSS: Main: 157724672 04:11:08 INFO - PROCESS | 3749 | 04:11:10 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:10 INFO - PROCESS | 3749 | RSS: Main: 158363648 04:11:10 INFO - PROCESS | 3749 | 04:11:12 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:13 INFO - PROCESS | 3749 | RSS: Main: 157970432 04:11:13 INFO - PROCESS | 3749 | 04:11:16 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:16 INFO - PROCESS | 3749 | RSS: Main: 158375936 04:11:16 INFO - PROCESS | 3749 | 04:11:19 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:20 INFO - PROCESS | 3749 | RSS: Main: 158248960 04:11:20 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:35819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35819/tests/kraken/driver.html?testName=ai-astar) 04:11:21 INFO - PROCESS | 3749 | RSS: Main: 159956992 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | __start_tp_report 04:11:21 INFO - PROCESS | 3749 | _x_x_mozilla_page_load 04:11:21 INFO - PROCESS | 3749 | _x_x_mozilla_page_load_details 04:11:21 INFO - PROCESS | 3749 | |i|pagename|runs| 04:11:21 INFO - PROCESS | 3749 | |0;ai-astar;102;109;110;105;111;111;108;111;110;119 04:11:21 INFO - PROCESS | 3749 | |1;audio-beat-detection;144;118;152;170;117;150;149;121;184;124 04:11:21 INFO - PROCESS | 3749 | |2;audio-dft;162;162;162;160;161;163;164;166;163;161 04:11:21 INFO - PROCESS | 3749 | |3;audio-fft;76;75;74;175;78;77;74;75;172;75 04:11:21 INFO - PROCESS | 3749 | |4;audio-oscillator;83;83;159;85;84;84;130;83;83;145 04:11:21 INFO - PROCESS | 3749 | |5;imaging-gaussian-blur;117;117;117;118;118;117;118;118;117;118 04:11:21 INFO - PROCESS | 3749 | |6;imaging-darkroom;147;148;147;149;148;148;148;148;151;147 04:11:21 INFO - PROCESS | 3749 | |7;imaging-desaturate;95;94;96;96;95;96;96;95;96;96 04:11:21 INFO - PROCESS | 3749 | |8;json-parse-financial;55;53;51;51;50;51;55;52;51;51 04:11:21 INFO - PROCESS | 3749 | |9;json-stringify-tinderbox;60;61;61;60;61;60;60;60;62;61 04:11:21 INFO - PROCESS | 3749 | |10;stanford-crypto-aes;81;73;73;74;72;71;74;72;78;72 04:11:21 INFO - PROCESS | 3749 | |11;stanford-crypto-ccm;121;119;120;118;130;118;132;131;156;117 04:11:21 INFO - PROCESS | 3749 | |12;stanford-crypto-pbkdf2;150;151;151;161;154;154;150;151;152;151 04:11:21 INFO - PROCESS | 3749 | |13;stanford-crypto-sha256-iterative;64;63;64;62;62;63;61;62;62;61 04:11:21 INFO - PROCESS | 3749 | __end_tp_report 04:11:21 INFO - PROCESS | 3749 | __start_cc_report 04:11:21 INFO - PROCESS | 3749 | _x_x_mozilla_cycle_collect,886 04:11:21 INFO - PROCESS | 3749 | __end_cc_report 04:11:21 INFO - PROCESS | 3749 | __startTimestamp1473505881940__endTimestamp 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | ------- Summary: start ------- 04:11:21 INFO - PROCESS | 3749 | Number of tests: 14 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:4.43 (4.0%) stddev-sans-first:3.75 04:11:21 INFO - PROCESS | 3749 | Values: 102.0 109.0 110.0 105.0 111.0 111.0 108.0 111.0 110.0 119.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.50 stddev:22.91 (15.3%) stddev-sans-first:24.29 04:11:21 INFO - PROCESS | 3749 | Values: 144.0 118.0 152.0 170.0 117.0 150.0 149.0 121.0 184.0 124.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.71 (1.1%) stddev-sans-first:1.81 04:11:21 INFO - PROCESS | 3749 | Values: 162.0 162.0 162.0 160.0 161.0 163.0 164.0 166.0 163.0 161.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:41.35 (55.1%) stddev-sans-first:43.27 04:11:21 INFO - PROCESS | 3749 | Values: 76.0 75.0 74.0 175.0 78.0 77.0 74.0 75.0 172.0 75.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:83.00 stddev:30.30 (36.5%) stddev-sans-first:31.36 04:11:21 INFO - PROCESS | 3749 | Values: 83.0 83.0 159.0 85.0 84.0 84.0 130.0 83.0 83.0 145.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:11:21 INFO - PROCESS | 3749 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 04:11:21 INFO - PROCESS | 3749 | Values: 147.0 148.0 147.0 149.0 148.0 148.0 148.0 148.0 151.0 147.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 04:11:21 INFO - PROCESS | 3749 | Values: 95.0 94.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:51.50 stddev:1.76 (3.4%) stddev-sans-first:1.50 04:11:21 INFO - PROCESS | 3749 | Values: 55.0 53.0 51.0 51.0 50.0 51.0 55.0 52.0 51.0 51.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 04:11:21 INFO - PROCESS | 3749 | Values: 60.0 61.0 61.0 60.0 61.0 60.0 60.0 60.0 62.0 61.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.50 stddev:3.13 (4.3%) stddev-sans-first:2.05 04:11:21 INFO - PROCESS | 3749 | Values: 81.0 73.0 73.0 74.0 72.0 71.0 74.0 72.0 78.0 72.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.50 stddev:12.00 (9.6%) stddev-sans-first:12.58 04:11:21 INFO - PROCESS | 3749 | Values: 121.0 119.0 120.0 118.0 130.0 118.0 132.0 131.0 156.0 117.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:151.50 stddev:3.31 (2.2%) stddev-sans-first:3.38 04:11:21 INFO - PROCESS | 3749 | Values: 150.0 151.0 151.0 161.0 154.0 154.0 150.0 151.0 152.0 151.0 04:11:21 INFO - PROCESS | 3749 | 04:11:21 INFO - PROCESS | 3749 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.07 (1.7%) stddev-sans-first:0.97 04:11:21 INFO - PROCESS | 3749 | Values: 64.0 63.0 64.0 62.0 62.0 63.0 61.0 62.0 62.0 61.0 04:11:21 INFO - PROCESS | 3749 | -------- Summary: end -------- 04:11:21 INFO - PROCESS | 3749 | 04:11:22 INFO - TEST-INFO | 3749: exit 0 04:11:22 INFO - TEST-OK | kraken | took 61135ms 04:11:22 INFO - SUITE-END | took 1172s 04:11:23 INFO - Completed test suite (00:19:32) 04:11:23 INFO - javascript benchmark 04:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7643.017683186979, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.933921321573, 3325.7339412846973, 3339.74951878609, 3342.231286804035, 3357.916052098697, 5693.03218452863, 5705.971470142648, 5787.450192231731, 5821.67980761058, 5822.737976791044, 5725.2843394575675, 5727.3699893011735, 5742.6841523716175, 5755.165501002352, 5772.769089236425, 5202.713850738208, 5233.267342572043, 5299.178627312773, 5302.151655735083, 5341.679499230058, 5113.6931784092885, 5115.028144652504, 5158.0, 5176.974115129419, 5214.270002199676, 5186.559142472895, 5187.766550505217, 5207.4792520748, 5266.368035835686, 5294.4176140624695, 5253.185756207775, 5260.342457192851, 5270.789168433296, 5271.0, 5304.416514183436, 5014.197728363444, 5087.592992560586, 5160.664556803796, 5174.482551744795, 5248.422673505911, 5547.11246200606, 5636.267285252932, 5648.519875810561, 5649.0, 5652.519535839418, 6071.2714474263375, 6095.329513753483, 6109.236345456818, 6125.938740612626, 6127.5710700251, 5908.940910590882, 6067.908981365283, 6163.476104531121, 6174.660393678346, 6185.041318595625, 5643.209950606918, 5743.511801496836, 5749.137629355547, 5779.855503612402, 5791.391903850077, 6167.444929956326, 6190.102435146879, 6237.781677641261, 6254.405831446005, 6261.060840873905, 5839.562032847553, 5954.0, 5966.134910437962, 6029.246344206974, 6036.3360030396625, 6121.112438696364, 6195.659238741912, 6211.2857021442205, 6215.254169499599, 6228.159198508143, 6131.938680613137, 6202.875942481125, 6209.223847019122, 6210.378962103844, 6214.844628884314, 5842.977478941169, 5926.67403292823, 6157.630542167484, 6192.411720886508, 6201.937980620226, 4640.280756482751, 4649.883752906137, 4667.043256132485, 4708.128996135726, 4762.571368576775, 4173.749575025508, 4186.790660466964, 4196.349565817303, 4234.1108367242605, 4245.405643209953, 5549.1676248563035, 5866.325372582208, 5887.735051922588, 5900.409959004065, 5903.881922361615, 6038.0, 6053.092036194606, 6101.755929762849, 6145.723442445101, 6179.969100154561, 5826.446487583673, 5837.9124313135335, 5872.970635146882, 5875.9118613220835, 5887.322957859816, 5131.127708289525, 5255.159174532057, 5262.763175657028, 5271.288376069181, 5274.050670879202, 6143.112737013686, 6315.242170939517, 6346.746130154835, 6379.043143528415, 6471.126397936312, 6256.937430625636, 6260.718267678057, 6261.812145635638, 6266.874662506815, 6283.120363149254, 6379.617222966637, 6423.293437721753, 6428.325025872216, 6444.4844412445955, 6446.29090800021, 5840.532757379485, 6029.4874935629205, 6061.090836374579, 6068.0, 6162.907556386568, 6196.535259855439, 6204.689765511616, 6223.097650840693, 6229.937700622936, 6252.812415627538, 6053.3946605339115, 6056.121862330026, 6067.120267561268, 6075.787347442818, 6099.420555047263, 5662.178984047207, 5982.820515384546, 5994.550408719277, 6012.5791194617705, 6116.418940200674, 6027.487663548647, 6049.243844519435, 6058.757649693963, 6062.848428789139, 6063.969680151571, 6004.0093384591055, 6096.817095487142, 6124.846878828065, 6126.571140020156, 6133.754649813957, 5663.093904975184, 5826.359100498857, 5893.764249430146, 5910.497607703393, 6023.578349515492], "value": 5663.511693201901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.5681374189969, 638.1225814505055, 663.5521023309267, 668.742534124362, 672.0624728503741, 33872.66127338726, 45915.540844591545, 46499.767501162445, 47050.52949470504, 47354.526454735445, 47000.294995575096, 47360.28959565609, 47514.0, 47539.28691069637, 47562.76218618911, 9164.175224229835, 9247.306452016091, 9299.163075323253, 9319.534023298842, 9347.065293470632, 9146.31402644801, 9155.038720934306, 9170.908290917072, 9180.403273787182, 9181.265498760084, 9235.168834804866, 9312.8603070954, 9314.673986410477, 9317.208037316836, 9341.065893410672, 9180.265578753684, 9180.357374983754, 9198.816023679523, 9215.769605759877, 9233.353665243436, 9101.908980910172, 9173.770655733593, 9231.584578693908, 9242.953785231031, 9248.861267081, 44039.339409908556, 44131.55868441307, 44231.0, 44259.55740442587, 44340.55659443429, 3682.981585092084, 3808.409696497047, 3823.598522155189, 3841.0, 3882.8835134946, 34001.48997765035, 34099.0, 34169.487457688156, 34642.30715385678, 35660.0, 4613.538646135393, 4615.20055035445, 4624.3757092792375, 4732.881677958044, 4744.14605371033, 330538.0, 330618.0, 330623.34688326647, 331099.0, 332310.0, 37253.25493490115, 38380.42429363562, 60127.699361503786, 60496.69751651213, 60603.69698151569, 40127.59872401297, 40276.194476110315, 40643.0, 40821.18357632831, 40826.59173408228, 15374.9231253843, 15428.768568471482, 15508.51863701825, 15543.766843497357, 15606.14166220846, 12942.288174150512, 12988.675283117998, 12995.935020324838, 13085.672858178432, 13090.410931508104, 9043.0, 9128.726138215865, 9140.497272649935, 9192.81614367709, 9206.493642849573, 3607.783532988029, 3614.0784100054843, 3619.800910949923, 3624.4925710400566, 3626.8575398749836, 1081.9242653014214, 1088.7931293054294, 1092.1549363907066, 1162.0993729859426, 1193.6299747078433, 29983.250418739706, 32763.344733105205, 33126.503102453484, 33399.16502087467, 33778.8311058448, 1168.1297433411992, 1193.9522419103312, 1248.7814632439467, 1259.3514340114848, 1262.5265525427965, 17196.570085747957, 17423.303067877143, 17441.7383739244, 17520.737188942177, 17889.821101789075, 333609.0, 335997.0, 425527.0, 429341.0, 432276.0, 58211.0, 58992.41007589869, 59082.40917590769, 59097.70451147717, 59144.0, 1417.688108616103, 1440.3302464354126, 1449.4564538298139, 1458.0741229319246, 1458.1761304862719, 31931.201719957186, 32397.676023239466, 32588.674113259513, 33189.834050830555, 33530.161745956546, 45225.773871130434, 45549.31676024796, 45607.31589026233, 45744.54255457536, 45824.54175458203, 297822.0, 298120.0, 299050.0, 299362.0, 299684.0, 28595.714042859305, 28629.713702862704, 28833.135005949855, 28841.42317153687, 29028.12915612535, 46721.53278467172, 46860.0, 46934.29598556093, 47298.0, 47380.0, 39589.0, 39617.40573891336, 39926.401103982884, 39958.60041399549, 41243.38134927918, 39549.80225098856, 39773.60226397699, 40123.79938100291, 40186.39720404255, 41418.58581414147, 39581.80209098936, 41055.79472102621, 42302.36546451867, 43799.781001094794, 45260.321095184256, 35640.82179589189, 37067.0, 37549.0, 37810.81094594619, 38094.8095259533, 28834.567481488215, 29104.854475727487, 29281.85359073191, 29395.85302073476, 29759.702402975694], "value": 19109.722466438496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.8161608892089, 426.33278918492556, 430.18842445900907, 433.7072476078648, 437.8183054032577, 18776.530586735338, 19449.80550194496, 20322.0, 20464.0, 20573.794262057374, 19714.507137321572, 20260.797392026074, 20305.18779248832, 20674.379768606967, 21017.0, 5702.4012478689765, 5817.8836423271505, 5868.677222752747, 5890.5582081343855, 5895.086261629454, 5771.711414429262, 5773.538116950634, 5791.507721843648, 5795.1017592273265, 5855.033919403315, 5666.093425051992, 5777.277840269966, 5818.0400233961345, 5819.30168379795, 5832.795852145176, 5715.3141623005085, 5775.249217601706, 5783.826485205451, 5787.074068149118, 5846.590738648296, 5268.157094864803, 5270.841874743764, 5277.366715994067, 5283.313169288006, 5286.497782710637, 23424.414389640224, 24382.878085609635, 24440.14459493909, 24505.63241551378, 24841.378965525826, 2486.925392238236, 2499.237732491589, 2522.785563227128, 2552.6681531400986, 2584.431425086497, 15620.531384058382, 15648.608784780357, 15746.685066298724, 15892.76160857588, 16004.0, 2079.1475495046957, 2131.531063166101, 2182.0835249195375, 2184.5740080684272, 2186.737591489016, 51498.22752658713, 68229.0, 84211.57894210551, 84681.15318846855, 86331.0, 11179.4969226385, 11192.216544841946, 11407.543698251977, 11532.0, 11728.0, 16155.0, 16164.919175404048, 16198.75701864473, 16238.75641865373, 16275.0, 8476.660933562713, 8508.787280318042, 8523.701670441505, 8604.956975215084, 8793.252573531194, 8354.164583541597, 8380.622871970776, 8444.957775211085, 8565.100664430145, 8686.391952563386, 6726.091977582963, 6880.621565813928, 7004.793490050618, 7039.225685174627, 7056.576605403692, 2082.4793801549613, 2098.9055492502875, 2116.6190085784706, 2116.8941552922292, 2123.384218576626, 970.7281961050917, 1059.3590877519143, 1092.126298960844, 1100.301308669001, 1167.5038108803894, 20813.89593052025, 21014.57970840605, 21145.78854211438, 21306.36080917575, 21356.893215533823, 1094.2285688589525, 1121.7812526557243, 1144.9484773185227, 1147.4205526209378, 1187.8752730963297, 11803.822942655866, 11829.52681892732, 11885.22746021506, 11999.760004799855, 12016.819747703792, 500913.0, 525112.0, 528272.0, 530775.0, 532085.0, 80241.0, 82526.58736706278, 83008.58495707603, 85993.57003214944, 88307.55846220856, 1073.0771536478621, 1079.4279032112993, 1080.68660088575, 1083.0847933496184, 1114.3815182573749, 18274.90862545679, 18338.0, 18497.352592659194, 18673.813261867206, 18792.436226913214, 39585.80207098946, 41620.375694364004, 41642.0, 42053.1589368217, 43454.0, 53939.730301348245, 61062.0, 62358.688206560495, 62549.37450625435, 63444.0, 9135.588898499716, 9213.355065145375, 9247.213986810928, 9286.6285348588, 9402.482863442303, 10188.64339748135, 14208.289585520475, 14237.145771253758, 14757.188354640597, 14871.256437178314, 12135.393230338625, 12143.14997950135, 12413.875861241271, 12488.500459981498, 12746.745065098832, 11405.600803971822, 11580.189386743185, 12001.099917506397, 12265.877341226473, 12530.74938501243, 12537.498500059895, 12628.0, 12739.426725797546, 12781.8082728761, 13130.0, 9159.496227707274, 9302.255819534555, 9358.11097945694, 9378.343515953818, 9561.474118923526, 11562.075033997091, 12027.45876435545, 12415.193012454161, 12480.0, 12700.488058048057], "value": 9863.499088947594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.3359355477144, 1592.5938885584178, 1752.7370894365843, 1852.8425083867871, 1871.1018711018703, 8227.62975666095, 8756.255718263947, 8901.109889011095, 9515.80968380632, 9522.238220942325, 8833.823323533525, 9168.404053736502, 9170.128837760401, 9171.77070573236, 9237.861432078524, 2508.0594776958596, 2548.1081621432536, 2562.7309132541095, 2563.346346681603, 2569.704483984338, 2448.375664205625, 2582.457683886386, 2584.095566551711, 2584.328074700582, 2600.6749156355454, 2532.392225865788, 2559.5520783862844, 2569.280601431593, 2575.7037940636787, 2583.870806459679, 2521.13021007752, 2524.9621255681086, 2530.734272901337, 2553.8467691938545, 2557.322309587942, 2473.245660073677, 2475.913343033003, 2488.726240113586, 2499.662545556363, 2521.1428114440996, 9047.54762261891, 9327.673531426435, 9364.953175234148, 9382.014888436752, 9387.530623468867, 5509.972450137764, 5563.749631266603, 5591.3569939456665, 5605.32736071674, 5606.607537472379, 3479.1997840496574, 3655.5430571178604, 3671.2473942841652, 3682.834272457746, 3701.777893326409, 1211.8606360268593, 1243.1360204657767, 1247.3638444393334, 1254.736505333881, 1260.319427509144, 11621.360825154614, 11697.122715796264, 11941.701457463547, 12273.20224185434, 12757.936210318981, 4909.091818013679, 4942.827001054946, 4973.676711013773, 5010.1733214020005, 5060.240963855377, 10069.345492542961, 10090.848637270446, 10102.444365559964, 10231.0, 10297.485125743682, 5584.022796010682, 5592.189132575753, 5595.916061259084, 5617.41017193197, 5624.55003599711, 4785.0, 5060.240963855451, 5143.948560514422, 5164.535191832753, 5282.392524859691, 4099.327217125382, 4132.504099508078, 4140.710150289451, 4160.438340824011, 4182.477190351206, 1242.9067819913362, 1277.7444511097817, 1279.0982357437983, 1280.7182419867613, 1282.185812009362, 959.2949182350967, 983.7098056073476, 992.7815880506278, 1014.1177175857051, 1029.563758556824, 5622.8313150605545, 6047.697615119315, 6051.092336149525, 6208.099825525273, 6214.347493513206, 982.9705108846746, 985.9014098590084, 1014.3660212367271, 1057.7884423115254, 1060.1942523681903, 4010.839566417369, 4043.9191216175514, 4098.180363927167, 4165.75005499671, 4187.14163596462, 11460.255083419552, 11809.291442513477, 11812.645620631394, 11814.586489472998, 11823.527058917547, 10844.186685998582, 11580.247283926517, 11616.88383116175, 11632.767344653059, 11683.474243659055, 8322.29260512851, 8867.246284065926, 8893.4663920165, 8917.152870477294, 8917.974432940166, 6176.320604733565, 6239.844003899757, 6340.461060809698, 6341.334159913327, 6356.491480681442, 10824.350538967687, 11034.503447344729, 11086.944565277123, 11229.4385280734, 11248.100151987657, 10807.405592692478, 11040.613578524713, 11107.72230694239, 11115.333080015225, 11132.944335278271, 7471.925280747123, 7875.960620196863, 7976.960115199387, 8222.753317400247, 8379.539125347921, 9155.908440915506, 9156.175944165057, 9227.907720922973, 9230.0, 9231.492267925329, 8217.671293148207, 8258.298044666271, 8303.335733141455, 8311.95844020776, 8475.279601233964, 7974.601269936596, 8010.279074883289, 8048.718294859652, 8059.073206581318, 8208.261256486945, 7139.393151581966, 7150.463715221275, 7178.246284140299, 7260.782176534713, 7333.889991650023, 5026.623003274842, 5209.609279303992, 5236.240745092016, 5271.7891284349735, 5325.627206095536, 5249.868753281198, 5339.145736682112, 5342.6260161788305, 5378.139497680352, 5428.15863541136], "value": 4905.038917077027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.094313086932, 358.18512883190743, 358.7309517861604, 369.16384389358126, 377.2473914540492, 5756.107803290486, 5763.0, 5873.853153671161, 5946.940530594693, 5984.700764961751, 5733.111367738007, 5784.768609255625, 5809.559984806381, 5821.563382746301, 5844.357120716718, 4605.585497305242, 4625.167469855424, 4637.9100911285905, 4640.118377508263, 4656.649571624225, 4470.8882277942985, 4589.128065667529, 4598.919253975329, 4621.560951709582, 4656.953430465703, 4532.3881276027805, 4537.0, 4540.523245059271, 4552.430946131733, 4605.309203619468, 4397.494288156839, 4603.677742558039, 4617.399738034051, 4621.098885717286, 4636.698614590075, 3987.182627561343, 3995.161016186575, 3995.700322475826, 3996.18078293949, 3998.460207871929, 5662.745176467028, 5663.630140066653, 5682.602217844753, 5712.057510510761, 5735.885282294331, 5117.513836185556, 5171.612129090333, 5187.403448603422, 5220.817271395483, 5255.842324730226, 6007.729652165663, 6037.577369584131, 6039.969800151015, 6077.0, 6082.391760823926, 4390.824367025315, 4397.032652816375, 4416.933745993812, 4424.159409712144, 4439.5560443955665, 6101.237345331833, 6378.712957916859, 6378.712957916905, 6379.776707815251, 6380.213540208749, 4504.220832771102, 4512.932306015412, 4518.096380723869, 4525.434320709911, 4526.253168227206, 4576.748278844629, 4579.740571342841, 4589.908201835945, 4593.0, 4601.148787474328, 4963.45402005779, 5202.479752024768, 5225.477452254744, 5237.816676416307, 5246.7638956247065, 5921.5558833086825, 6083.266269113282, 6109.297430795426, 6109.358517355702, 6109.5112391008615, 1561.6017915431491, 1565.506865337415, 1580.0045971038173, 1590.9443169489243, 1591.4191320168286, 977.9657711980046, 1001.7578203028338, 1005.5324274212526, 1011.8532812742111, 1021.7803172317987, 5195.467337135554, 5265.761556642714, 5280.894382112413, 5286.0, 5291.444398338119, 5434.347878254634, 5502.697351645698, 5546.639468434539, 5570.693611851306, 5611.466910643482, 4886.60907127429, 5175.353080864892, 5221.269022336875, 5251.579873610179, 5262.7631756571045, 2955.674875763664, 2980.1953472562286, 2982.6569944456232, 3002.7597792176575, 3024.5765592816583, 5710.714464276853, 5716.399778023331, 5750.367459579443, 5794.246747922743, 5807.506361959281, 6011.939880601138, 6444.742210311629, 6491.123698300669, 6531.967340163269, 6538.332725155055, 6586.4401525870835, 6621.172353455818, 6624.834379140464, 6634.341414646338, 6667.233268174222, 6166.784162554289, 6270.498360131087, 6349.904751428825, 6379.298277189599, 6468.676566171766, 6174.969125154345, 6282.277538083179, 6352.333005034589, 6361.236651601837, 6365.61806291624, 6404.487640988803, 6504.869902601827, 6522.608643481406, 6579.440747536321, 6676.933230667825, 4511.120331535319, 4517.841875534341, 4542.954570454253, 4543.568361005699, 4558.840440584564, 6107.4197951194565, 6159.0, 6347.58791659185, 6361.522885783677, 6386.0, 6155.753769849335, 6225.937740622536, 6237.157983672146, 6244.313125556276, 6244.438000579969, 6035.758569657164, 6203.348648392034, 6203.844903877259, 6231.376862313914, 6276.0, 6088.6042407243385, 6124.38756124384, 6140.385961404003, 6172.85802126608, 6194.5973511721595, 6183.319834818077, 6249.25008998923, 6274.623522588659, 6275.6862156892885, 6278.215223097113, 5875.676837773964, 6006.888725585781, 6022.608530445507, 6062.393760623902, 6140.618360868947], "value": 4615.618286142618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.9671613135475, 833.1626715151272, 833.7540425574455, 900.1268769293782, 912.171353664267, 16118.677626447465, 17171.0, 17206.13969301536, 17336.306547738106, 17408.912955435237, 15389.307481163347, 15464.22678866055, 15566.533004009898, 16193.514194574152, 16633.334666613322, 866.9263112635433, 886.4681191285242, 887.9822403551957, 888.5424006636588, 889.1597440418775, 840.9243168114868, 885.1148851148852, 887.3300658003199, 893.8301722672671, 896.2337201692524, 937.7608709778997, 942.241495596045, 946.2288235088415, 946.7065209784988, 947.7062110745657, 938.0619380619312, 938.6010945348233, 941.0918463682546, 943.3349488610513, 944.1549812917435, 687.9621620810854, 689.4897775645986, 689.6207086102673, 689.8689249042666, 693.4868197533839, 16627.584310392216, 16634.001959882324, 16669.33322667092, 16688.916555417265, 16718.91640541802, 16225.675486490321, 16538.173091345383, 16550.0, 16736.497905062744, 16817.915910420368, 11899.821502677467, 11989.160758746892, 11990.940045299718, 12060.276383417024, 12207.572734954323, 4117.258893399187, 4162.21139756844, 4230.323148296257, 4247.851325203634, 4249.978750106261, 87346.0, 87572.56213718954, 88052.0, 89366.5531672344, 90198.5490072552, 11519.193656444137, 12639.052071094704, 12655.367231638382, 12666.746665066647, 13090.214587124803, 22981.310560683207, 23139.3058208254, 23275.650865237036, 23324.65013024806, 23356.54756250603, 9163.404378715362, 9480.194183494481, 9624.0, 9728.708138755848, 9828.459434731016, 5303.814366497154, 5311.787528498817, 5326.840194794162, 5431.728413579305, 5486.972565137149, 3913.8630147944687, 4053.777042262704, 4065.2276067547073, 4070.5725898780793, 4075.694322925733, 673.7406098651957, 675.6317806795308, 699.0876905638191, 711.6589992109188, 732.9706811727472, 698.9021536984826, 728.1189760389988, 796.832665140327, 798.7843282313743, 800.7237503061434, 10237.590496380062, 10598.735031624272, 10638.30850494997, 10790.136789056856, 10909.509072091774, 685.2359619024851, 731.3271789953255, 773.2847116417291, 797.2943944608946, 812.0336799209041, 5201.479852014768, 5224.399194092728, 5233.162693969023, 5260.815871444481, 5296.576273898156, 132716.0, 133695.0, 133728.0, 135356.0, 140666.0, 110872.44563777291, 111225.0, 114686.0, 115058.0, 118160.40919795346, 102123.0, 103260.48369758103, 104592.0, 106387.0, 107682.0, 9617.855732163884, 9783.217342612432, 9825.5087245636, 9884.555195016097, 9905.356151850106, 57450.0, 58570.707146463996, 58858.0, 60143.097853531355, 61319.0, 81478.59260703658, 87869.56065219633, 88175.0, 90068.5496572513, 90163.0, 12702.237865728086, 12721.491140354283, 13007.219566826021, 13053.34733263314, 13548.525801596898, 12383.69040773988, 13015.0, 13274.402651880882, 14066.437342506186, 14335.211563364115, 12850.742985140432, 13475.730485390433, 13521.526746563823, 13758.587242382744, 14127.717445651235, 14067.718645627236, 14297.571072867831, 14306.785398219243, 14340.354684039035, 15137.545873623809, 13558.525451609146, 13600.523981660594, 13760.0, 13916.373763180884, 14186.645333866736, 10995.450227488753, 11393.601223957121, 11535.250208736405, 11825.586104486645, 11828.053755699351, 11356.943215284202, 11380.829287560859, 11537.077033837106, 11553.133514986577, 11928.76142477163], "value": 8247.225424470944, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 110.0, 105.0, 111.0, 111.0, 108.0, 111.0, 110.0, 119.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 152.0, 170.0, 117.0, 150.0, 149.0, 121.0, 184.0, 124.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 163.0, 164.0, 166.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 175.0, 78.0, 77.0, 74.0, 75.0, 172.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 159.0, 85.0, 84.0, 84.0, 130.0, 83.0, 83.0, 145.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 151.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 51.0, 51.0, 50.0, 51.0, 55.0, 52.0, 51.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 62.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 73.0, 74.0, 72.0, 71.0, 74.0, 72.0, 78.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 120.0, 118.0, 130.0, 118.0, 132.0, 131.0, 156.0, 117.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 161.0, 154.0, 154.0, 150.0, 151.0, 152.0, 151.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 62.0, 62.0, 63.0, 61.0, 62.0, 62.0, 61.0], "value": 62.4, "unit": "score"}]}]} 04:11:23 INFO - Return code: 0 04:11:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:23 ERROR - # TBPL SUCCESS # 04:11:23 INFO - Running post-action listener: _resource_record_post_action 04:11:23 INFO - [mozharness: 2016-09-10 11:11:23.237839Z] Finished run-tests step (success) 04:11:23 INFO - Running post-run listener: _resource_record_post_run 04:11:23 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 326676480; Read time: 24; Write time: 225420 04:11:23 INFO - TinderboxPrint: CPU usage
13.3% 04:11:23 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 04:11:23 INFO - TinderboxPrint: I/O write bytes / time
326,676,480 / 225,420 04:11:23 INFO - TinderboxPrint: CPU idle
8,229.2 (86.7%) 04:11:23 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 04:11:23 INFO - TinderboxPrint: Swap in / out
0 / 0 04:11:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78405632; Read time: 0; Write time: 50776 04:11:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247353344; Read time: 12; Write time: 174616 04:11:23 INFO - Running post-run listener: _upload_blobber_files 04:11:23 INFO - Blob upload gear active. 04:11:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:23 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 04:11:23 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:11:23 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:25 INFO - (blobuploader) - INFO - Done attempting. 04:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:29 INFO - (blobuploader) - INFO - Done attempting. 04:11:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:11:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:30 INFO - (blobuploader) - INFO - Done attempting. 04:11:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:30 INFO - Return code: 0 04:11:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/105b4de081caf652395b0644f90cdb7a0a8f0fbd4904df98ea31e386583a1aaf3dbf3945f7de66137b3dc789e95590ed06d50f686054b870ad3b1fc7d75b9724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afc17d458abb2526a809e9e99d86a714331cc6e6e876180d350756395731f42c7b27e8d749aec9fee3d0b1e0998e600ac600b9fddd0c15dd981121a7c652f2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e128f542112ae3c86a9734e05399ac7aacda89e8ddedd2ec9d75b903635dada1c4782b5b9cb77e0b759aacfec649c956002483620264192206537e98e9e72e"} 04:11:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:30 INFO - Contents: 04:11:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/105b4de081caf652395b0644f90cdb7a0a8f0fbd4904df98ea31e386583a1aaf3dbf3945f7de66137b3dc789e95590ed06d50f686054b870ad3b1fc7d75b9724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afc17d458abb2526a809e9e99d86a714331cc6e6e876180d350756395731f42c7b27e8d749aec9fee3d0b1e0998e600ac600b9fddd0c15dd981121a7c652f2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e128f542112ae3c86a9734e05399ac7aacda89e8ddedd2ec9d75b903635dada1c4782b5b9cb77e0b759aacfec649c956002483620264192206537e98e9e72e"} 04:11:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:30 INFO - Copying logs to upload dir... 04:11:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.486273 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-10 04:11:30.056819) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-10 04:11:30.060186) ========= 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=4300f881736b422476174874000001bc-1473504114.208304-109008610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/105b4de081caf652395b0644f90cdb7a0a8f0fbd4904df98ea31e386583a1aaf3dbf3945f7de66137b3dc789e95590ed06d50f686054b870ad3b1fc7d75b9724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afc17d458abb2526a809e9e99d86a714331cc6e6e876180d350756395731f42c7b27e8d749aec9fee3d0b1e0998e600ac600b9fddd0c15dd981121a7c652f2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e128f542112ae3c86a9734e05399ac7aacda89e8ddedd2ec9d75b903635dada1c4782b5b9cb77e0b759aacfec649c956002483620264192206537e98e9e72e"} build_url:https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/UjuVstA-RjelzXaqQS2AcA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/105b4de081caf652395b0644f90cdb7a0a8f0fbd4904df98ea31e386583a1aaf3dbf3945f7de66137b3dc789e95590ed06d50f686054b870ad3b1fc7d75b9724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afc17d458abb2526a809e9e99d86a714331cc6e6e876180d350756395731f42c7b27e8d749aec9fee3d0b1e0998e600ac600b9fddd0c15dd981121a7c652f2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e128f542112ae3c86a9734e05399ac7aacda89e8ddedd2ec9d75b903635dada1c4782b5b9cb77e0b759aacfec649c956002483620264192206537e98e9e72e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-10 04:11:30.090438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 04:11:30.090775) ========= 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=4300f881736b422476174874000001bc-1473504114.208304-109008610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-10 04:11:30.704662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-10 04:11:30.704964) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-10 04:11:30.705447) ========= ========= Total master_lag: 0.73 =========