builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1476795764.58 results: success (0) buildid: 20161018030521 builduid: 0090e1c9cb69429d85fa77d3434b6f65 revision: 62da552138459e86a7c25b1f2836e410454c5e5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.582694) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.583387) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.583838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.602842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.603439) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 06:02:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.5M=0s 2016-10-18 06:02:45 (60.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071448 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.700297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.700889) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014646 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.764492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 06:02:44.765129) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 62da552138459e86a7c25b1f2836e410454c5e5c --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-beta --rev 62da552138459e86a7c25b1f2836e410454c5e5c --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=8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 06:02:45,228 truncating revision to first 12 chars 2016-10-18 06:02:45,228 Setting DEBUG logging. 2016-10-18 06:02:45,228 attempt 1/10 2016-10-18 06:02:45,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/62da55213845?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 06:02:46,369 unpacking tar archive at: mozilla-beta-62da55213845/testing/mozharness/ program finished with exit code 0 elapsedTime=1.493949 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 06:02:46.277116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:46.278013) ========= script_repo_revision: 62da552138459e86a7c25b1f2836e410454c5e5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:46.278704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:46.279283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:46.292103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-18 06:02:46.292649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:02:46 INFO - MultiFileLogger online at 20161018 06:02:46 in /builds/slave/test 06:02:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:02:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:46 INFO - {'append_to_log': False, 06:02:46 INFO - 'base_work_dir': '/builds/slave/test', 06:02:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:02:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:46 INFO - 'branch': 'Mozilla-Beta', 06:02:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:46 INFO - 'config_files': ('talos/linux_config.py',), 06:02:46 INFO - 'default_actions': ('clobber', 06:02:46 INFO - 'read-buildbot-config', 06:02:46 INFO - 'download-and-extract', 06:02:46 INFO - 'populate-webroot', 06:02:46 INFO - 'create-virtualenv', 06:02:46 INFO - 'install', 06:02:46 INFO - 'run-tests'), 06:02:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:46 INFO - 'download_minidump_stackwalk': True, 06:02:46 INFO - 'download_symbols': 'ondemand', 06:02:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:46 INFO - 'installer_path': 'installer.exe', 06:02:46 INFO - 'log_level': 'info', 06:02:46 INFO - 'log_name': 'talos', 06:02:46 INFO - 'log_to_console': True, 06:02:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:02:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:02:46 INFO - 'opt_config_files': (), 06:02:46 INFO - 'pip_index': False, 06:02:46 INFO - 'sps_profile': False, 06:02:46 INFO - 'sps_profile_interval': 0, 06:02:46 INFO - 'suite': 'dromaeojs', 06:02:46 INFO - 'system_bits': '32', 06:02:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:46 INFO - 'title': 'talos-linux64-ix-001', 06:02:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:46 INFO - 'use_talos_json': True, 06:02:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:46 INFO - 'work_dir': 'build'} 06:02:46 INFO - [mozharness: 2016-10-18 13:02:46.852070Z] Running clobber step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: clobber 06:02:46 INFO - rmtree: /builds/slave/test/build 06:02:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:47 INFO - Running post-action listener: _resource_record_post_action 06:02:47 INFO - [mozharness: 2016-10-18 13:02:47.847057Z] Finished clobber step (success) 06:02:47 INFO - [mozharness: 2016-10-18 13:02:47.847159Z] Running read-buildbot-config step. 06:02:47 INFO - Running pre-action listener: _resource_record_pre_action 06:02:47 INFO - Running main action method: read_buildbot_config 06:02:47 INFO - Using buildbot properties: 06:02:47 INFO - { 06:02:47 INFO - "project": "", 06:02:47 INFO - "product": "firefox", 06:02:47 INFO - "script_repo_revision": "production", 06:02:47 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:02:47 INFO - "repository": "", 06:02:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:02:47 INFO - "buildid": "20161018030521", 06:02:47 INFO - "pgo_build": "True", 06:02:47 INFO - "basedir": "/builds/slave/test", 06:02:47 INFO - "buildnumber": 425, 06:02:47 INFO - "slavename": "talos-linux64-ix-001", 06:02:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:02:47 INFO - "platform": "ubuntu64_hw", 06:02:47 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:02:47 INFO - "branch": "mozilla-beta", 06:02:47 INFO - "repo_path": "releases/mozilla-beta", 06:02:47 INFO - "revision": "62da552138459e86a7c25b1f2836e410454c5e5c", 06:02:47 INFO - "stage_platform": "linux64-pgo", 06:02:47 INFO - "builduid": "0090e1c9cb69429d85fa77d3434b6f65", 06:02:47 INFO - "slavebuilddir": "test" 06:02:47 INFO - } 06:02:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 06:02:47 INFO - Running post-action listener: _resource_record_post_action 06:02:47 INFO - [mozharness: 2016-10-18 13:02:47.849614Z] Finished read-buildbot-config step (success) 06:02:47 INFO - [mozharness: 2016-10-18 13:02:47.849704Z] Running download-and-extract step. 06:02:47 INFO - Running pre-action listener: _resource_record_pre_action 06:02:47 INFO - Running main action method: download_and_extract 06:02:47 INFO - mkdir: /builds/slave/test/build/tests 06:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:47 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:02:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:02:47 INFO - retry: Failed, sleeping 30 seconds before retrying 06:03:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 06:03:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:03:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:03:17 INFO - retry: Failed, sleeping 60 seconds before retrying 06:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 06:04:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:04:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 06:04:17 INFO - Caught exception: HTTP Error 404: Not Found 06:04:17 INFO - Caught exception: HTTP Error 404: Not Found 06:04:17 INFO - Caught exception: HTTP Error 404: Not Found 06:04:17 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:17 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:04:18 INFO - Downloaded 1327 bytes. 06:04:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:18 INFO - Using the following test package requirements: 06:04:18 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:04:18 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:18 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 06:04:18 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'jsshell-linux-x86_64.zip'], 06:04:18 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:18 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:04:18 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 06:04:18 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 06:04:18 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:18 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:18 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:18 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:04:18 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:04:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:04:18 INFO - retry: Failed, sleeping 30 seconds before retrying 06:04:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:04:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:04:48 INFO - retry: Failed, sleeping 60 seconds before retrying 06:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:05:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:05:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 06:05:48 INFO - Caught exception: HTTP Error 404: Not Found 06:05:48 INFO - Caught exception: HTTP Error 404: Not Found 06:05:48 INFO - Caught exception: HTTP Error 404: Not Found 06:05:48 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:48 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:05:49 INFO - Downloaded 21774616 bytes. 06:05:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:05:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:05:50 INFO - Return code: 0 06:05:50 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:05: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')]} 06:05:50 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:05:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:05:50 INFO - retry: Failed, sleeping 30 seconds before retrying 06:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:06:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:06:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:06:20 INFO - retry: Failed, sleeping 60 seconds before retrying 06:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:07:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:07:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:07:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 06:07:20 INFO - Caught exception: HTTP Error 404: Not Found 06:07:20 INFO - Caught exception: HTTP Error 404: Not Found 06:07:20 INFO - Caught exception: HTTP Error 404: Not Found 06:07:20 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:07:20 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:21 INFO - Downloaded 21774616 bytes. 06:07:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:07:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:07:23 INFO - Return code: 0 06:07:23 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')]} 06:07:23 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:07:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:07:23 INFO - retry: Failed, sleeping 30 seconds before retrying 06:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 06:07:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:07:53 INFO - retry: Failed, sleeping 60 seconds before retrying 06:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 06:08:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:08:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:08:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 06:08:53 INFO - Caught exception: HTTP Error 404: Not Found 06:08:53 INFO - Caught exception: HTTP Error 404: Not Found 06:08:53 INFO - Caught exception: HTTP Error 404: Not Found 06:08:53 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:08:53 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:08:54 INFO - Downloaded 14413762 bytes. 06:08:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:08:54 INFO - Return code: 0 06:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:54 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:08:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:08:54 INFO - retry: Failed, sleeping 30 seconds before retrying 06:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 06:09:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:09:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:09:24 INFO - retry: Failed, sleeping 60 seconds before retrying 06:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 06:10:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:10:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 06:10:24 INFO - Caught exception: HTTP Error 404: Not Found 06:10:24 INFO - Caught exception: HTTP Error 404: Not Found 06:10:24 INFO - Caught exception: HTTP Error 404: Not Found 06:10:24 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:24 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:10:25 INFO - Downloaded 56809543 bytes. 06:10:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:25 INFO - mkdir: /builds/slave/test/properties 06:10:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:25 INFO - Contents: 06:10:25 INFO - build_url:https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:26 INFO - Running post-action listener: _resource_record_post_action 06:10:26 INFO - Running post-action listener: set_extra_try_arguments 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.593192Z] Finished download-and-extract step (success) 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.593426Z] Running populate-webroot step. 06:10:26 INFO - Running pre-action listener: _resource_record_pre_action 06:10:26 INFO - Running main action method: populate_webroot 06:10:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:26 INFO - '--tppagecycles', 06:10:26 INFO - '7'], 06:10:26 INFO - 'tests': ['tsvgm']}}, 06:10:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:10:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:10:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['damp', 'tps']}, 06:10:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'tests': ['damp', 'tps']}, 06:10:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['dromaeo_dom']}, 06:10:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:10:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['basic_compositor_video']}, 06:10:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:10:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tsvgx', 06:10:26 INFO - 'tsvgr_opacity', 06:10:26 INFO - 'tart', 06:10:26 INFO - 'tscrollx', 06:10:26 INFO - 'cart']}, 06:10:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:10:26 INFO - 'tsvgr_opacity', 06:10:26 INFO - 'tart', 06:10:26 INFO - 'tscrollx', 06:10:26 INFO - 'cart']}, 06:10:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tp5o']}, 06:10:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'tests': ['tp5o']}, 06:10:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s', 06:10:26 INFO - '--xperf_path', 06:10:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:26 INFO - 'tests': ['tp5n']}, 06:10:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--xperf_path', 06:10:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:26 INFO - 'tests': ['tp5n']}}, 06:10:26 INFO - 'talos.zip': {'path': '', 06:10:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:26 INFO - Running post-action listener: _resource_record_post_action 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.615045Z] Finished populate-webroot step (success) 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.615134Z] Running create-virtualenv step. 06:10:26 INFO - Running pre-action listener: _resource_record_pre_action 06:10:26 INFO - Running main action method: create_virtualenv 06:10:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:10:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:26 INFO - Using real prefix '/usr' 06:10:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:29 INFO - Installing pip.................done. 06:10:29 INFO - Return code: 0 06:10:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:10:29 INFO - Using env: {'DISPLAY': ':0', 06:10:29 INFO - 'HOME': '/home/cltbld', 06:10:29 INFO - 'LANG': 'en_US.UTF-8', 06:10:29 INFO - 'LANGUAGE': 'en_US:en', 06:10:29 INFO - 'LOGNAME': 'cltbld', 06:10:29 INFO - 'MAIL': '/var/mail/cltbld', 06:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:29 INFO - 'MOZ_NO_REMOTE': '1', 06:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:29 INFO - 'NO_EM_RESTART': '1', 06:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:29 INFO - 'PWD': '/builds/slave/test', 06:10:29 INFO - 'SHELL': '/bin/bash', 06:10:29 INFO - 'SHLVL': '1', 06:10:29 INFO - 'TERM': 'linux', 06:10:29 INFO - 'TMOUT': '86400', 06:10:29 INFO - 'USER': 'cltbld', 06:10:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:29 INFO - '_': '/tools/buildbot/bin/python'} 06:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:10:29 INFO - Cleaning up... 06:10:29 INFO - Return code: 0 06:10:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:10:29 INFO - Using env: {'DISPLAY': ':0', 06:10:29 INFO - 'HOME': '/home/cltbld', 06:10:29 INFO - 'LANG': 'en_US.UTF-8', 06:10:29 INFO - 'LANGUAGE': 'en_US:en', 06:10:29 INFO - 'LOGNAME': 'cltbld', 06:10:29 INFO - 'MAIL': '/var/mail/cltbld', 06:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:29 INFO - 'MOZ_NO_REMOTE': '1', 06:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:29 INFO - 'NO_EM_RESTART': '1', 06:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:29 INFO - 'PWD': '/builds/slave/test', 06:10:29 INFO - 'SHELL': '/bin/bash', 06:10:29 INFO - 'SHLVL': '1', 06:10:29 INFO - 'TERM': 'linux', 06:10:29 INFO - 'TMOUT': '86400', 06:10:29 INFO - 'USER': 'cltbld', 06:10:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:29 INFO - '_': '/tools/buildbot/bin/python'} 06:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:29 INFO - Downloading/unpacking psutil>=3.1.1 06:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:31 INFO - Installing collected packages: psutil 06:10:31 INFO - Running setup.py install for psutil 06:10:31 INFO - building 'psutil._psutil_linux' extension 06:10:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:10:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:10:31 INFO - building 'psutil._psutil_posix' extension 06:10:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:10:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:32 INFO - Successfully installed psutil 06:10:32 INFO - Cleaning up... 06:10:32 INFO - Return code: 0 06:10:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:10:32 INFO - Using env: {'DISPLAY': ':0', 06:10:32 INFO - 'HOME': '/home/cltbld', 06:10:32 INFO - 'LANG': 'en_US.UTF-8', 06:10:32 INFO - 'LANGUAGE': 'en_US:en', 06:10:32 INFO - 'LOGNAME': 'cltbld', 06:10:32 INFO - 'MAIL': '/var/mail/cltbld', 06:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:32 INFO - 'MOZ_NO_REMOTE': '1', 06:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:32 INFO - 'NO_EM_RESTART': '1', 06:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:32 INFO - 'PWD': '/builds/slave/test', 06:10:32 INFO - 'SHELL': '/bin/bash', 06:10:32 INFO - 'SHLVL': '1', 06:10:32 INFO - 'TERM': 'linux', 06:10:32 INFO - 'TMOUT': '86400', 06:10:32 INFO - 'USER': 'cltbld', 06:10:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:32 INFO - '_': '/tools/buildbot/bin/python'} 06:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:10:34 INFO - Installing collected packages: mozsystemmonitor 06:10:34 INFO - Running setup.py install for mozsystemmonitor 06:10:34 INFO - Successfully installed mozsystemmonitor 06:10:34 INFO - Cleaning up... 06:10:34 INFO - Return code: 0 06:10:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:10:34 INFO - Using env: {'DISPLAY': ':0', 06:10:34 INFO - 'HOME': '/home/cltbld', 06:10:34 INFO - 'LANG': 'en_US.UTF-8', 06:10:34 INFO - 'LANGUAGE': 'en_US:en', 06:10:34 INFO - 'LOGNAME': 'cltbld', 06:10:34 INFO - 'MAIL': '/var/mail/cltbld', 06:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:34 INFO - 'MOZ_NO_REMOTE': '1', 06:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:34 INFO - 'NO_EM_RESTART': '1', 06:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:34 INFO - 'PWD': '/builds/slave/test', 06:10:34 INFO - 'SHELL': '/bin/bash', 06:10:34 INFO - 'SHLVL': '1', 06:10:34 INFO - 'TERM': 'linux', 06:10:34 INFO - 'TMOUT': '86400', 06:10:34 INFO - 'USER': 'cltbld', 06:10:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:34 INFO - '_': '/tools/buildbot/bin/python'} 06:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:10:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:37 INFO - Downloading functools32-3.2.3-2.tar.gz 06:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:10:38 INFO - warning: no files found matching '*.txt' 06:10:38 INFO - no previously-included directories found matching 'build' 06:10:38 INFO - no previously-included directories found matching 'dist' 06:10:38 INFO - no previously-included directories found matching '.git*' 06:10:38 INFO - Installing collected packages: jsonschema, functools32 06:10:38 INFO - Running setup.py install for functools32 06:10:38 INFO - warning: no files found matching '*.txt' 06:10:38 INFO - no previously-included directories found matching 'build' 06:10:38 INFO - no previously-included directories found matching 'dist' 06:10:38 INFO - no previously-included directories found matching '.git*' 06:10:38 INFO - Successfully installed jsonschema functools32 06:10:38 INFO - Cleaning up... 06:10:38 INFO - Return code: 0 06:10:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:10:38 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')]} 06:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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')]} 06:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:10:38 INFO - Using env: {'DISPLAY': ':0', 06:10:38 INFO - 'HOME': '/home/cltbld', 06:10:38 INFO - 'LANG': 'en_US.UTF-8', 06:10:38 INFO - 'LANGUAGE': 'en_US:en', 06:10:38 INFO - 'LOGNAME': 'cltbld', 06:10:38 INFO - 'MAIL': '/var/mail/cltbld', 06:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:38 INFO - 'MOZ_NO_REMOTE': '1', 06:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:38 INFO - 'NO_EM_RESTART': '1', 06:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:38 INFO - 'PWD': '/builds/slave/test', 06:10:38 INFO - 'SHELL': '/bin/bash', 06:10:38 INFO - 'SHLVL': '1', 06:10:38 INFO - 'TERM': 'linux', 06:10:38 INFO - 'TMOUT': '86400', 06:10:38 INFO - 'USER': 'cltbld', 06:10:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:38 INFO - '_': '/tools/buildbot/bin/python'} 06:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:10:38 INFO - Cleaning up... 06:10:38 INFO - Return code: 0 06:10:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:10:38 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')]} 06:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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')]} 06:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:10:38 INFO - Using env: {'DISPLAY': ':0', 06:10:38 INFO - 'HOME': '/home/cltbld', 06:10:38 INFO - 'LANG': 'en_US.UTF-8', 06:10:38 INFO - 'LANGUAGE': 'en_US:en', 06:10:38 INFO - 'LOGNAME': 'cltbld', 06:10:38 INFO - 'MAIL': '/var/mail/cltbld', 06:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:38 INFO - 'MOZ_NO_REMOTE': '1', 06:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:38 INFO - 'NO_EM_RESTART': '1', 06:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:38 INFO - 'PWD': '/builds/slave/test', 06:10:38 INFO - 'SHELL': '/bin/bash', 06:10:38 INFO - 'SHLVL': '1', 06:10:38 INFO - 'TERM': 'linux', 06:10:38 INFO - 'TMOUT': '86400', 06:10:38 INFO - 'USER': 'cltbld', 06:10:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:38 INFO - '_': '/tools/buildbot/bin/python'} 06:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 06:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:40 INFO - Downloading blobuploader-1.2.4.tar.gz 06:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:10:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:41 INFO - Downloading docopt-0.6.1.tar.gz 06:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:10:41 INFO - Installing collected packages: blobuploader, requests, docopt 06:10:41 INFO - Running setup.py install for blobuploader 06:10:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:10:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:10:41 INFO - Running setup.py install for requests 06:10:41 INFO - Running setup.py install for docopt 06:10:41 INFO - Successfully installed blobuploader requests docopt 06:10:41 INFO - Cleaning up... 06:10:41 INFO - Return code: 0 06:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:41 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')]} 06:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:41 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')]} 06:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:41 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 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:10:41 INFO - Using env: {'DISPLAY': ':0', 06:10:41 INFO - 'HOME': '/home/cltbld', 06:10:41 INFO - 'LANG': 'en_US.UTF-8', 06:10:41 INFO - 'LANGUAGE': 'en_US:en', 06:10:41 INFO - 'LOGNAME': 'cltbld', 06:10:41 INFO - 'MAIL': '/var/mail/cltbld', 06:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:41 INFO - 'MOZ_NO_REMOTE': '1', 06:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:41 INFO - 'NO_EM_RESTART': '1', 06:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:41 INFO - 'PWD': '/builds/slave/test', 06:10:41 INFO - 'SHELL': '/bin/bash', 06:10:41 INFO - 'SHLVL': '1', 06:10:41 INFO - 'TERM': 'linux', 06:10:41 INFO - 'TMOUT': '86400', 06:10:41 INFO - 'USER': 'cltbld', 06:10:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:41 INFO - '_': '/tools/buildbot/bin/python'} 06:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:42 INFO - Running setup.py (path:/tmp/pip-6r80zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:42 INFO - Running setup.py (path:/tmp/pip-8tuwCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:42 INFO - Running setup.py (path:/tmp/pip-Pjwh5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:42 INFO - Running setup.py (path:/tmp/pip-Lo0C5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:42 INFO - Running setup.py (path:/tmp/pip-AhqDjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:42 INFO - Running setup.py (path:/tmp/pip-k3eCtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:42 INFO - Running setup.py (path:/tmp/pip-Tp7MI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:42 INFO - Running setup.py (path:/tmp/pip-DMFlNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:42 INFO - Running setup.py (path:/tmp/pip-tcBrnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:42 INFO - Running setup.py (path:/tmp/pip-jAKsYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:42 INFO - Running setup.py (path:/tmp/pip-KAJC4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:42 INFO - Running setup.py (path:/tmp/pip-DSy5sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:43 INFO - Running setup.py (path:/tmp/pip-uEQRl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:43 INFO - Running setup.py (path:/tmp/pip-PksCpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:43 INFO - Running setup.py (path:/tmp/pip-2_EUU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:43 INFO - Running setup.py (path:/tmp/pip-77IAmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:43 INFO - Running setup.py (path:/tmp/pip-4nnOnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:10:43 INFO - Running setup.py install for manifestparser 06:10:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Running setup.py install for mozcrash 06:10:43 INFO - Running setup.py install for mozdebug 06:10:43 INFO - Running setup.py install for mozdevice 06:10:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Running setup.py install for mozfile 06:10:43 INFO - Running setup.py install for mozhttpd 06:10:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Running setup.py install for mozinfo 06:10:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Running setup.py install for mozInstall 06:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Running setup.py install for mozleak 06:10:44 INFO - Running setup.py install for mozlog 06:10:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Running setup.py install for moznetwork 06:10:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Running setup.py install for mozprocess 06:10:44 INFO - Running setup.py install for mozprofile 06:10:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Running setup.py install for mozrunner 06:10:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:10:44 INFO - Running setup.py install for mozscreenshot 06:10:44 INFO - Running setup.py install for moztest 06:10:45 INFO - Running setup.py install for mozversion 06:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:10:45 INFO - Cleaning up... 06:10:45 INFO - Return code: 0 06:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:45 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')]} 06:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:45 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')]} 06:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:45 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 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:10:45 INFO - Using env: {'DISPLAY': ':0', 06:10:45 INFO - 'HOME': '/home/cltbld', 06:10:45 INFO - 'LANG': 'en_US.UTF-8', 06:10:45 INFO - 'LANGUAGE': 'en_US:en', 06:10:45 INFO - 'LOGNAME': 'cltbld', 06:10:45 INFO - 'MAIL': '/var/mail/cltbld', 06:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:45 INFO - 'MOZ_NO_REMOTE': '1', 06:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:45 INFO - 'NO_EM_RESTART': '1', 06:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:45 INFO - 'PWD': '/builds/slave/test', 06:10:45 INFO - 'SHELL': '/bin/bash', 06:10:45 INFO - 'SHLVL': '1', 06:10:45 INFO - 'TERM': 'linux', 06:10:45 INFO - 'TMOUT': '86400', 06:10:45 INFO - 'USER': 'cltbld', 06:10:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:45 INFO - '_': '/tools/buildbot/bin/python'} 06:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:45 INFO - Running setup.py (path:/tmp/pip-1cDmiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:45 INFO - Running setup.py (path:/tmp/pip-wz6QYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:45 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)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:45 INFO - Running setup.py (path:/tmp/pip-UmiL7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:45 INFO - Running setup.py (path:/tmp/pip-F3CoKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:45 INFO - Running setup.py (path:/tmp/pip-MiQmt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:45 INFO - Running setup.py (path:/tmp/pip-6r_x_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:45 INFO - Running setup.py (path:/tmp/pip-4B9Vbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:45 INFO - Running setup.py (path:/tmp/pip-1OY75Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:45 INFO - Running setup.py (path:/tmp/pip-jpXFtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:46 INFO - Running setup.py (path:/tmp/pip-0mtC9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:46 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)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:46 INFO - Running setup.py (path:/tmp/pip-RjDJRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:46 INFO - Running setup.py (path:/tmp/pip-4MVeNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:46 INFO - Running setup.py (path:/tmp/pip-BsOmtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:46 INFO - Running setup.py (path:/tmp/pip-_j_5lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:46 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)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:46 INFO - Running setup.py (path:/tmp/pip-_MyOo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:46 INFO - Running setup.py (path:/tmp/pip-rf89Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:46 INFO - Running setup.py (path:/tmp/pip-jeKGg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:10:46 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)) 06:10:46 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)) 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:10:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:48 INFO - Downloading blessings-1.6.tar.gz 06:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:48 INFO - Installing collected packages: blessings 06:10:48 INFO - Running setup.py install for blessings 06:10:48 INFO - Successfully installed blessings 06:10:48 INFO - Cleaning up... 06:10:48 INFO - Return code: 0 06:10:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:49 INFO - Reading from file tmpfile_stdout 06:10:49 INFO - Current package versions: 06:10:49 INFO - argparse == 1.2.1 06:10:49 INFO - blessings == 1.6 06:10:49 INFO - blobuploader == 1.2.4 06:10:49 INFO - docopt == 0.6.1 06:10:49 INFO - functools32 == 3.2.3-2 06:10:49 INFO - jsonschema == 2.5.1 06:10:49 INFO - manifestparser == 1.1 06:10:49 INFO - mozInstall == 1.12 06:10:49 INFO - mozcrash == 0.17 06:10:49 INFO - mozdebug == 0.1 06:10:49 INFO - mozdevice == 0.48 06:10:49 INFO - mozfile == 1.2 06:10:49 INFO - mozhttpd == 0.7 06:10:49 INFO - mozinfo == 0.9 06:10:49 INFO - mozleak == 0.1 06:10:49 INFO - mozlog == 3.3 06:10:49 INFO - moznetwork == 0.27 06:10:49 INFO - mozprocess == 0.23 06:10:49 INFO - mozprofile == 0.28 06:10:49 INFO - mozrunner == 6.12 06:10:49 INFO - mozscreenshot == 0.1 06:10:49 INFO - mozsystemmonitor == 0.3 06:10:49 INFO - moztest == 0.7 06:10:49 INFO - mozversion == 1.4 06:10:49 INFO - psutil == 3.1.1 06:10:49 INFO - requests == 1.2.3 06:10:49 INFO - wsgiref == 0.1.2 06:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:49 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')]} 06:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:49 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')]} 06:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:49 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 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:10:49 INFO - Using env: {'DISPLAY': ':0', 06:10:49 INFO - 'HOME': '/home/cltbld', 06:10:49 INFO - 'LANG': 'en_US.UTF-8', 06:10:49 INFO - 'LANGUAGE': 'en_US:en', 06:10:49 INFO - 'LOGNAME': 'cltbld', 06:10:49 INFO - 'MAIL': '/var/mail/cltbld', 06:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:49 INFO - 'MOZ_NO_REMOTE': '1', 06:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:49 INFO - 'NO_EM_RESTART': '1', 06:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:49 INFO - 'PWD': '/builds/slave/test', 06:10:49 INFO - 'SHELL': '/bin/bash', 06:10:49 INFO - 'SHLVL': '1', 06:10:49 INFO - 'TERM': 'linux', 06:10:49 INFO - 'TMOUT': '86400', 06:10:49 INFO - 'USER': 'cltbld', 06:10:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:49 INFO - '_': '/tools/buildbot/bin/python'} 06:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:10:49 INFO - Cleaning up... 06:10:49 INFO - Return code: 0 06:10:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10:49 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')]} 06:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:49 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')]} 06:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:49 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 0x14e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, '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': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:10:49 INFO - Using env: {'DISPLAY': ':0', 06:10:49 INFO - 'HOME': '/home/cltbld', 06:10:49 INFO - 'LANG': 'en_US.UTF-8', 06:10:49 INFO - 'LANGUAGE': 'en_US:en', 06:10:49 INFO - 'LOGNAME': 'cltbld', 06:10:49 INFO - 'MAIL': '/var/mail/cltbld', 06:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:49 INFO - 'MOZ_NO_REMOTE': '1', 06:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:49 INFO - 'NO_EM_RESTART': '1', 06:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:49 INFO - 'PWD': '/builds/slave/test', 06:10:49 INFO - 'SHELL': '/bin/bash', 06:10:49 INFO - 'SHLVL': '1', 06:10:49 INFO - 'TERM': 'linux', 06:10:49 INFO - 'TMOUT': '86400', 06:10:49 INFO - 'USER': 'cltbld', 06:10:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:49 INFO - '_': '/tools/buildbot/bin/python'} 06:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:10:49 INFO - Cleaning up... 06:10:49 INFO - Return code: 0 06:10:49 INFO - Running post-action listener: _resource_record_post_action 06:10:49 INFO - Running post-action listener: _start_resource_monitoring 06:10:49 INFO - Starting resource monitoring. 06:10:49 INFO - [mozharness: 2016-10-18 13:10:49.651483Z] Finished create-virtualenv step (success) 06:10:49 INFO - [mozharness: 2016-10-18 13:10:49.651969Z] Running install step. 06:10:49 INFO - Running pre-action listener: _resource_record_pre_action 06:10:49 INFO - Running main action method: install 06:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:49 INFO - Reading from file tmpfile_stdout 06:10:49 INFO - Detecting whether we're running mozinstall >=1.0... 06:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:10:49 INFO - Reading from file tmpfile_stdout 06:10:49 INFO - Output received: 06:10:49 INFO - Usage: mozinstall [options] installer 06:10:49 INFO - Options: 06:10:49 INFO - -h, --help show this help message and exit 06:10:49 INFO - -d DEST, --destination=DEST 06:10:49 INFO - Directory to install application into. [default: 06:10:49 INFO - "/builds/slave/test"] 06:10:49 INFO - --app=APP Application being installed. [default: firefox] 06:10:49 INFO - mkdir: /builds/slave/test/build/application 06:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:11:04 INFO - Reading from file tmpfile_stdout 06:11:04 INFO - Output received: 06:11:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:11:04 INFO - Running post-action listener: _resource_record_post_action 06:11:04 INFO - [mozharness: 2016-10-18 13:11:04.142161Z] Finished install step (success) 06:11:04 INFO - [mozharness: 2016-10-18 13:11:04.142542Z] Running run-tests step. 06:11:04 INFO - Running pre-action listener: _resource_record_pre_action 06:11:04 INFO - Running main action method: run_tests 06:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:11:04 INFO - Python 2.7.3 06:11:04 INFO - Return code: 0 06:11:04 INFO - grabbing minidump binary from tooltool 06:11: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')]} 06:11:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179f3b0>, '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 0x17a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:11:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:11:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:11:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:11:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:11:04 INFO - Return code: 0 06:11:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:11:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:11:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:11:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:11:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:11:04 INFO - Using env: {'DISPLAY': ':0', 06:11:04 INFO - 'HOME': '/home/cltbld', 06:11:04 INFO - 'LANG': 'en_US.UTF-8', 06:11:04 INFO - 'LANGUAGE': 'en_US:en', 06:11:04 INFO - 'LOGNAME': 'cltbld', 06:11:04 INFO - 'MAIL': '/var/mail/cltbld', 06:11:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:11:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:04 INFO - 'MOZ_NO_REMOTE': '1', 06:11:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:04 INFO - 'NO_EM_RESTART': '1', 06:11:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:04 INFO - 'PWD': '/builds/slave/test', 06:11:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:11:04 INFO - 'SHELL': '/bin/bash', 06:11:04 INFO - 'SHLVL': '1', 06:11:04 INFO - 'TERM': 'linux', 06:11:04 INFO - 'TMOUT': '86400', 06:11:04 INFO - 'USER': 'cltbld', 06:11:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238', 06:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:04 INFO - '_': '/tools/buildbot/bin/python'} 06:11:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:11:04 INFO - mozversion application_buildid: 20161018030521 06:11:04 INFO - mozversion application_changeset: 62da552138459e86a7c25b1f2836e410454c5e5c 06:11:04 INFO - mozversion application_display_name: Firefox 06:11:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:11:04 INFO - mozversion application_name: Firefox 06:11:04 INFO - mozversion application_remotingname: firefox 06:11:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:11:04 INFO - mozversion application_vendor: Mozilla 06:11:04 INFO - mozversion application_version: 50.0 06:11:04 INFO - mozversion platform_buildid: 20161018030521 06:11:04 INFO - mozversion platform_changeset: 62da552138459e86a7c25b1f2836e410454c5e5c 06:11:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:11:04 INFO - mozversion platform_version: 50.0 06:11:04 INFO - using testdate: 1476796264 06:11:04 INFO - actual date: 1476796264 06:11:04 INFO - starting webserver on 'localhost:50783' 06:11:04 INFO - SUITE-START | Running 2 tests 06:11:04 INFO - TEST-START | dromaeo_css 06:11:04 INFO - operating with platform_type : linux_ 06:11:04 INFO - Initialising browser for dromaeo_css test... 06:11:04 INFO - TEST-INFO | started process 24572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLeAS6p/profile http://localhost:50783/getInfo.html) 06:11:08 INFO - PROCESS | 24572 | __metrics Screen width/height:1600/1200 06:11:08 INFO - PROCESS | 24572 | colorDepth:24 06:11:08 INFO - PROCESS | 24572 | Browser inner width/height: 1024/697 06:11:08 INFO - PROCESS | 24572 | __metrics 06:11:09 INFO - PROCESS | 24572 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:11:09 INFO - PROCESS | 24572 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:10 INFO - TEST-INFO | 24572: exit 0 06:11:10 INFO - Browser initialized. 06:11:10 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:10 INFO - TEST-INFO | started process 24659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLeAS6p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:22 INFO - PROCESS | 24659 | RSS: Main: 144044032 06:11:22 INFO - PROCESS | 24659 | 06:12:12 INFO - PROCESS | 24659 | 1476796332825 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:14:21 INFO - PROCESS | 24659 | Cycle 1(1): loaded http://localhost:50783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50783/tests/dromaeo/cssquery-ext.html) 06:14:22 INFO - PROCESS | 24659 | RSS: Main: 258117632 06:14:22 INFO - PROCESS | 24659 | 06:17:25 INFO - PROCESS | 24659 | Cycle 1(1): loaded http://localhost:50783/tests/dromaeo/cssquery-ext.html (next: http://localhost:50783/tests/dromaeo/cssquery-jquery.html) 06:17:25 INFO - PROCESS | 24659 | RSS: Main: 233041920 06:17:25 INFO - PROCESS | 24659 | 06:20:27 INFO - PROCESS | 24659 | Cycle 1(1): loaded http://localhost:50783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50783/tests/dromaeo/cssquery-mootools.html) 06:20:28 INFO - PROCESS | 24659 | RSS: Main: 227524608 06:20:28 INFO - PROCESS | 24659 | 06:23:30 INFO - PROCESS | 24659 | Cycle 1(1): loaded http://localhost:50783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50783/tests/dromaeo/cssquery-prototype.html) 06:23:30 INFO - PROCESS | 24659 | RSS: Main: 225624064 06:23:30 INFO - PROCESS | 24659 | 06:26:33 INFO - PROCESS | 24659 | Cycle 1(1): loaded http://localhost:50783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50783/tests/dromaeo/cssquery-yui.html) 06:26:34 INFO - PROCESS | 24659 | RSS: Main: 176578560 06:26:34 INFO - PROCESS | 24659 | 06:29:36 INFO - PROCESS | 24659 | Cycle 1(1): loaded http://localhost:50783/tests/dromaeo/cssquery-yui.html (next: http://localhost:50783/tests/dromaeo/cssquery-dojo.html) 06:29:37 INFO - PROCESS | 24659 | RSS: Main: 262385664 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | __start_tp_report 06:29:37 INFO - PROCESS | 24659 | _x_x_mozilla_page_load 06:29:37 INFO - PROCESS | 24659 | _x_x_mozilla_page_load_details 06:29:37 INFO - PROCESS | 24659 | |i|pagename|runs| 06:29:37 INFO - PROCESS | 24659 | |0;dojo.html;3241.546183534305;3246.561714168587;3270.2314955985325;3290.374828782533;3305.5702758641373;5701.315842098944;5759.222504961829;5776.249087618614;5777.480026797587;5801.9999999999945;5688.2605261315975;5768.048272035119;5769.798057068004;5770.163326317682;5784.884302313952;5139.126348520751;5205.817796377128;5219.817306394277;5252.973735131338;5263.526282634562;5081.415637201713;5129.128048231791;5268.499492548221;5282.7622756976025;5283.55089817366;5110.795568177268;5117.232415137741;5134.204198349262;5149.74251287436;5174.715390653512;5193.402758682743;5249.950009997997;5259.947400525984;5264.052470555299;5290;5002.324686167357;5073.873153171164;5147.510986456318;5217.34783152106;5231;5521.834344969617;5528.723563821793;5561.165825126223;5573.41479144688;5615.887682246333;5978.701064946736;6037;6094.939050609526;6095.451409373133;6100;5961;6090;6112.052631842072;6124.7243874025335;6129.325774164839;5710;5738.971305143447;5756.194132821408;5756.971215143897;5762.193292938992;6312.589681670676;6317.7157027932935;6324.367563243639;6324.873502529924;6325.936740632535;5877.412258774174;5942.61373010753;6003.969980150158;6071.210742603434;6079.544034197453;6117.602355846856;6126.23422072241;6126.877462450726;6129.785457508966;6130.877382452326;6068.575199735976;6074.141129774273;6078.3921607838865;6081;6109.175261339662;5881.3530511643685;5932.3177834548715;5944.613600115978;6057.303410107806;6114.082887566811;4599.9280949146805;4627.838025669085;4642.071585682809;4642.9535704643195;4654.743989080565;4189.308764053897;4189.895252618709;4192.7065105442325;4200.5169405518145;4216.578342165821;5847.649141051551;5857.121431785266;5862.384449632812;5863.853403664857;5868.119782032729;5840.649561026267;5978.760849565969;6080.665563394055;6142.539309551801;6154.815355539341;5874.765009399576;5876.823695289063;5883.911741323884;5889.469947704727;5923.585349025613;5277.947220527745;5318.494742999409;5324.1747529133045;5336.493033161843;5339.439358867341;6094.360092190256;6202.596831205957;6261.092141639437;6263.96868015657;6396.872062558816;6131;6133.304060594526;6143.907841382294;6144.293406258337;6149.2313460817395;6296.779612713533;6330.430261276507;6340.778072767615;6354.110424540476;6364.427201551883;5873.676947767914;5953.940460595339;5964.045752679551;5984.281886173687;6006.519478441802;6124.014786914997;6126.823043872828;6137.60418695462;6144.494598823317;6146.877062458815;5960.046392577166;6005.549583781147;6010.609310394811;6015.157877897011;6035.818925432244;5873.295204575478;5892.6759028253855;5936.821895343147;5974.731137098928;6000.519958403404;5926;5965.70171491415;5968.791092311922;5974.701264936823;6006.549508786771;6044.969775151096;6058.12157237207;6060.363661815446;6061.605995610271;6074.119252708421;5734.283214598176;5760.107183386582;5797.101449275369;5824.737886795019;5895.852603684943 06:29:37 INFO - PROCESS | 24659 | |1;ext.html;577.887311974165;633.1578999930093;638.8243233110894;653.0335104046012;659.7427003468645;36469.45295820561;48100.278495822546;49110.75444622781;49163.50836491634;49188.508114918885;50667.23999140006;50711.49288507114;50711.49288507123;50898.491015089836;51088;8655.394122411433;9275.536223188847;9427.670031548898;9433.622655093788;11123.888761112366;10967.122630189606;11385.601503947364;11390.316581005125;11395.48720307584;11396.316221026724;11339.546418143264;11426.485808138612;11460.942695286554;11468.369239691814;11471.254368466023;11317.207795454322;11323.433828308634;11335;11345.659630211107;11348.943255283712;11199.440027998568;11278.830817537744;11283.605073822377;11287.887121128766;11311.038561722264;47312;47791.283130753065;47807.521924781;47959.28061079087;47970.28044579334;3896.279188350164;4030.3349947258666;4258.5954334338185;4447.866564003085;4583.129205450954;36608.81695591532;36777.264454710756;37085.258294834224;38056.80971595152;38371.808140959394;4467.620252278561;4622.86131416058;4678;4875.24433712775;4939;391775;395907;396051;397843;398169;38532.22935541273;69820.3017969824;70477;70502.64748676223;70524;38478.2304353917;40189.59810401859;40399.39400908989;40645.79677101596;40746.1850762989;17264;17582.120893955253;17584.648307034044;17588;17604;13741.24423156716;13900.304984750925;13917.860821391656;13958.511452099128;14639.707205855822;9290.62837486493;9417.764555886157;9430.905690943002;9483.810323793485;9504.621829834636;3574.91062723434;3606.4590311452966;3614.584322802911;3652.543432070991;3660.524131862841;1019.9439030853374;1135.5861951869974;1147.5139694096165;1196.1387800783423;1226.0804396702474;35051.29897402089;36058.27883442317;37123.443148352795;37210.813945930095;37269.627303726615;1220.0666490135054;1221.7251118498266;1240.5161986825146;1252.2423933520272;1264.1467009768369;17696.646067078844;17817.821821781876;18843.81156188448;18885.52786180329;19083;607560;609296;609558;611203;612534;67347.66326168436;67658.32341676619;67660.6616966912;67992;68008;1370.6025252676611;1381.2127087559995;1466.3474753734486;1481.9703605928037;1492.8656420922168;34541;36977;37011.6298837019;37136.14319284079;37454.25091498209;57551.1367329482;57815;57926.13110803257;58561.4143858556;58621.70689146527;453715;455327;456697;458139;595764;50983;51315;51396;54726.452735472136;54926;50600.49399505958;51120;54585.72707136439;55566.72216638891;55625.721871392;44979.7751011256;46321.06026586089;48222.758886205345;48533.27200091931;49570;46931;47057.76471117623;48127.518724812304;48157.5184248153;49291.50708492869;46175.3073703888;47123.29315060208;48216.758916205195;48299.517004829504;48302.75848620875;39121.804390977864;41646.37530436985;41946.58053419427;42117.36823947582;42713.1457370857;30385.544216837206;30680;31161.37677246397;31197.75208991615;31237.219069523442 06:29:37 INFO - PROCESS | 24659 | |2;jquery.html;419.5489848412957;426.7418261572892;436.7575995322597;439.34367434770917;440.19005030743426;19592.41222763316;21225.68161477579;21625.783742162574;22021.66967495489;22199.1120355186;20177.29379471719;21342.146314147416;21445.892770536164;21743.23898663543;22114.115435382566;5754.597178197528;6029.216201893748;6040.184575082373;6042.939570604303;6043.093535969618;5693.516051135658;5955.987482128027;5988.790392336269;5993.46058854703;5993.940060599403;5794.246747922764;5955.52355811534;5958.433948774859;5960.0761881908375;5961.821145365646;5936.792212272571;5943.643381397108;5945.078512830518;5946.5540084493405;5948.702564871739;5310.097283461821;5340.172273297645;5371.167469042305;5377.220303056074;5409.134538473825;24743.50512989748;24870.50258994828;24939;25050.624240636404;25153;2549.7067837198774;2578.48430313938;2607.478504299148;2663.081236973241;2980.8807647694066;14998.62503437412;15300.617484562976;15613.297401616954;15715.735636530144;16275.348986040544;2043.2746375036945;2186.759456459788;2402.447437089462;2477.5044991001873;2509.4855554611445;94117;99734;104609.47695261551;104721;106353.46823265834;18862.622747545247;19015.809841901402;19129.80870191308;19595.31416400419;19988.90005549963;35452;35504.289914201574;35554.28891422157;35633.46549801755;35700;10365.533550990223;10551;10644.627438039632;10941.4529273536;11117.555297787998;8852.8672069919;8955.194032537103;9073.59549719325;9082;9183.724488265363;9293.67472138472;9584;9614.90385096154;9652.90347096534;9666.420014799134;3597.7587732232337;3641.1443310821937;3653.908652283714;3740.326741186558;3753.6434038766274;796.6295672512309;939.5677988125539;1014.9695509134738;1065.9093977011885;1094.3980810554162;20660.896695516425;21162.788372116083;21454.892725536272;21695.132194712034;21705.34883953484;1019.4453458475883;1045.163868904873;1051.0015485289007;1062.1661995333625;1063.4470075560664;11031.2278140531;11806.940965295118;11928.522859085539;11957.701057473632;12092.75814483723;519718;520863;522711;541272;542507;99042;99184;99306;101916;102395.4880225609;910.9772255693529;964.5563041001218;985.5121714751244;995.865558149655;1047.874255089379;18537.90731046336;18944.147513361655;19100.426987190407;19398.224071037;19512.902435487733;41398.79300603478;45709.08581828278;46229.76885115553;47195;47484.2877356833;54035.729821350644;60318;60471.69764151151;60639;65263.347366527625;9014.828072350814;9051.909480905106;9140.862887056832;9158.313126515672;9333.346665733334;10398.064174224357;13978.790318145439;14214.289285535475;14389.568312950629;14686.485972990895;12114.818277726017;12412.317322547347;12557.24656520575;12571.74856502883;12742.47090349164;11795.35125568102;11897.345645989208;12105.51577936908;12486.18839775448;12505.687357816127;11931.880681193077;12082.758344832879;12142.150049496451;12595.93702031484;13027.609171724864;9035.50304733246;9170.633174672937;9192.632294708137;9295.442273463614;9383.624655013722;9580.377275477073;12468.5012599495;12615.558455454015;12920.35398230066;13268.867311326763 06:29:37 INFO - PROCESS | 24659 | |3;mootools.html;1528.8318284988652;1554.6268895465087;1734.9653006939861;1782.1445706061081;1844.050314088244;8630.65477380904;9358.064193580638;9359.20446762026;9360.157585817284;9362.81274374512;8012.439129260954;8557;8835.028146903835;8903.42127761695;9106.63573457061;2452.337868775434;2478.4175718706088;2483.664705264793;2487.676602041732;2492.6510288559525;2427.1141033522727;2475.7029156501244;2477.2320580619976;2482.255323402981;2487.788537974265;2436.2082323245018;2437.768412000857;2441.316431399202;2444.083468699238;2448.8775561221955;2452.803775697949;2459.409741662006;2470.3206618179966;2475.504899020203;2495.1516484395393;2369.5379401016808;2388.940276493084;2391.366287933699;2391.641253811925;2419.5765740995257;9283;9309;9346.859797103049;9367.531623418801;9375.10936461035;5366.731663416853;5462.972685136589;5479.232907392929;5491.478309560585;5494.80768173116;3461.86855078539;3557.8932632021083;3606.4296346616925;3607.7474576779637;3637.7635453695425;1180.752042071166;1197.5329621447643;1207.541134368943;1214.4959841665698;1243.390738538119;12667.11330206886;12681.365931703378;12686.682832929251;12711.872881271254;12719.491220351174;4744.722533184091;4776.665633405628;4822.276658501253;4867.732274724854;4922.975385123052;10679.09227715653;10689.251752377415;10694.144468442506;10704;10736.516856741466;5461.808836690697;5486.067368547357;5494.752736126804;5498.725063746797;5503.11950087984;4462.152191083684;4796.5203479651755;4960.851174464772;5023.748812559357;5080.54275115234;4169.207850508394;4215.936760948588;4261.764088414325;4271.572842715704;4302.849400270976;1301.0827366706449;1305.3734207580226;1310.5387492945297;1312.6062181345558;1323.7617228898891;1059.0627294843964;1067.8771941226858;1070.6573896353093;1072.6621114348955;1076.784643071389;6367.936320636827;6438.291787903327;6604.966975165094;6695.46436285096;6719.496037797185;492.62560454055176;496.62504808869073;499.78259457135533;501.5636396335212;504.30154236382873;4273.423087883159;4480.551944805494;4488.326750987313;4506.211413002711;4560.1335746208115;11293.378864162385;11649.825252621047;11717.648470545897;11754.235974661791;11758.529658813552;11311.943440282746;11480.540778368939;11635.360055197045;11640.417979101012;11678.941605291919;8534.786630334167;8534.78663033429;8627.309815214769;8691.435056721293;8775.517346546001;6087.482563981934;6180.042093475518;6258.092576576462;6343.9682801585695;6516.869662606816;10438.843417348899;10505.107065899178;10522.579096836347;10546.736331591772;10618.575256989634;10180.79638407213;10340.53467593975;10620.20348473852;10772.245942784244;10855.891441085803;7426.74006409773;8040.316573091352;8193.344532437271;8198.057223419382;8369.707060252862;9184.49485278316;9232.261419086322;9263.02738212478;9265.073492650681;9272.907270927204;8169.5098294102545;8198.180181981754;8240.711575094843;8313.085560588452;8445.87331190045;7932.56370899583;7989.560574168477;7995.840083198187;8090.919090809017;8235.094139644514;7307.3423391894985;7399.778006659809;7563.773086807405;7566.546007239584;7615.847683046419;5618.157276408571;5821;5841.94158058414;5934.643921364732;6150.415710507495;5543.473370029841;5698.971505142447;5842.474177324061;5862.296524417097;6057.818265451867 06:29:37 INFO - PROCESS | 24659 | |4;prototype.html;332.97958309398405;338.4362661177798;339.6298035141695;341.1794633905455;341.3684683335829;5402.6758394496355;5416.539594134499;5442.537384322332;5466.781328746845;5505.421930697279;5402.243685883969;5417.756200970956;5425.186222066692;5426.077566813641;5431.995080910025;4282.079352939118;4289.463817022872;4292.356146578007;4297.140571885635;4298.312270036795;3910.569837317893;4072.9592704072875;4250.511191213003;4267.615914567688;4296.742195468282;4232.407462955173;4234.66122710184;4242.109157077018;4249.6387807036435;4258.9148217035645;4234.237837189305;4260.104253607131;4266.530681625019;4266.954596123938;4278.475699337406;3722.1253005543676;3786.2995345860827;3798.601146879593;3812.694984401241;3813.427985802124;5258.0009798138235;5266.92099618506;5288.2596436498925;5289.127293996486;5299.602529810241;4887.951120488785;4895.265710143507;4900.191468407708;4910.607151427913;4913.189323761575;5445.264889239941;5606.495415412633;5647.802326918538;5683.460071293221;5684.687342196177;4173.436586060873;4177.540470548237;4181.874543763692;4187.560306167839;4187.8324867005285;5587.497125258747;5741.894545400059;5888.468998060493;5898.557608179403;5910.729193223435;3943.408488726714;4130.772807495617;4186.911403035233;4339.262325404688;4339.370791235253;4362.738235705804;4367.344898265285;4370.606645401929;4377.649788016951;4378.8905277367685;4906.386701662293;4915.16442204826;4918.975405123023;4932.21084626458;5018.046571151543;5588.730592603291;5677.602567820213;5719.856028794258;5735.741891614887;5737;1493.4772829509584;1501.8285737125059;1511.8034655494716;1512.8638422542024;1519.9620009499629;952.5903861339552;969.8690676758688;976.9853452198223;983.2576404814463;984.6356847966155;4928.457869634337;4936.506349365107;4940.2342636891335;4943.972971081911;4945.950540494621;5145.61407894402;5153.922691159561;5169.363624551505;5169.7932082717025;5177.8187763428095;4625.7687115644085;4882.877928051827;4955.909699866023;4963.851084467472;4979.651424400329;2760.3513174403997;2764.7926405519665;2776.403073339242;2776.6667999840147;2791.246363481889;5301.655392399559;5335.359756829205;5338.665333666583;5366.543843773323;5438.537724293479;5031.6729412588065;5173.534381905646;5237.73811309433;5241.3572567066285;5253.264542963988;5315.760790764425;5325.760340784674;5839.591228614041;6004.939950600526;6114.816555503342;5849.853753656193;5858.94141058584;5877.382874798084;5920.970395147997;5923.555733319932;5654.858628534155;5762.481376676119;5815.94184058154;5816.389279125631;5838.3869693683255;6052.364501727431;6057.121717351048;6058.182145410489;6088.238970128734;6102.572819902742;4282.229198744256;4285.871423857289;4288.914221715486;4295.570442955679;4300.333448315516;5670.5180059695385;5867.178594996619;5914.497267732291;5919.526437884872;5926.703664816656;5715.371309156073;5767.971160144172;5769.365369809234;5773.393793651774;5780.797672081625;5761.534810521879;5761.827145185651;5766.509846662912;5768.942310577008;5770.307563092456;5448.700321482356;5661.348944871393;5692.174634678031;5694.629849059798;5723.599348045597;5734.426557344233;5751.41835995088;5800.738966746591;5804.477597016289;5807.332156802022;5416.783328666809;5661.801836935688;5670.886582268414;5675.460831221028;5676.262085928803 06:29:37 INFO - PROCESS | 24659 | |5;yui.html;855.5209082913573;856.8414843253998;888.5690440136533;910.9089091090896;924.1528184671397;16437.178141092943;17967.550811229725;18010.4596862094;18026.729599056023;18049.54876128096;16263.349466021346;16439.2602332895;16445.177741112926;16458.917705411484;16467.58831029225;733.625850816085;860.9053004169537;873.4191762477944;887.104024934814;894.3247847874845;898.2544488074882;900.5317235037809;900.5452246615483;900.8153328567661;900.9504477253748;939.7556635274843;940.4592359393376;940.9576569054409;941.3316545252878;942.4345392764355;946.6213514594149;948.170350942925;948.7106432538073;949.2453499467905;949.4018768176039;690.7962151165418;692.1728534401392;693.8057343943703;694.3750624437996;694.8679750847323;16289.83710162907;16424.83575164257;16439.26023328941;16464.588385290343;16498.505044848673;15736.909119847225;15864.206789660471;16020.35918563256;16818.32726690931;16823.663526729397;12994.545190918272;13076.803847942288;13142;13185.670358241025;13233.272170030645;4169.012400420484;4188.853390131361;4198.685098617616;4248.9787551062045;4269.914601707979;87670;89655;90683;91994;93707.53146234225;12967;12981.740365192643;13144.27706476153;13188.604341869759;13464.798028029587;24356;24629.261122166365;24634.630480542804;24689.25932222036;24730.752692473205;8138.511689298661;8541.53021583819;8593.570321483901;8907.10928907104;9203.447793132433;4595.724256544618;4620.306953956933;4622.422197225347;4688.367070445446;4823.662343635911;3633.927321453556;3795.7532760370486;3805.3150432921784;3807.295650304647;4100.774457404871;655.4098539188506;664.2792570061538;669.100060418736;678.0541145102554;694.4028135803205;733.2557454184008;749.0262658543871;774.0169984120135;791.2522666080614;811.6266517402062;10713;10779.622713205;10971.725706857233;11010.779784404267;11501.424928753697;804.1145343949337;811.3874025111004;824.4517395931638;841.2218697704722;845;4930.087933732271;5087.652819050317;5190;5273.973630131824;5306.8407947761625;107574.46212768886;133402;134086;136511.31744341413;136647.31676341555;83773.58113209395;102469;103682.48158759158;106092.46953765182;106173;91328;91684.99999999866;92196.53901730449;94705.5264723672;95130;10412.931755706859;10447.634332798316;10620.256582039492;10626.73433164177;10813.783724325313;47175.29237061378;48246.758766205945;48449;51604;52165.7391713039;73325.6333718328;75347.62326188335;75935;78045;79291.60354198192;13583.932080339535;13714.65713357174;13742.725145497234;14161.787573186617;14681.265936702908;16234.79167701237;16306.510804675878;16626.66746665084;16707.331706731595;16839.15804209809;14533;14538.41846326135;14768.556943291718;15702;15745.606359841096;14120.50578229757;14560;15541.611459713145;15683.686326273182;15696.979696319702;12982.350882456029;13000.674983125498;13860.376283067488;13973.930130349283;14233.074850134708;12051.276923384625;12826.166299190523;13040.54358097462;13243.271620060605;13304.068715189844;12264.816027759412;12710.893847824564;12816.87183128194;13075.150115242479;13170.60488185356 06:29:37 INFO - PROCESS | 24659 | __end_tp_report 06:29:37 INFO - PROCESS | 24659 | __start_cc_report 06:29:37 INFO - PROCESS | 24659 | _x_x_mozilla_cycle_collect,948 06:29:37 INFO - PROCESS | 24659 | __end_cc_report 06:29:37 INFO - PROCESS | 24659 | __startTimestamp1476797377036__endTimestamp 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | ------- Summary: start ------- 06:29:37 INFO - PROCESS | 24659 | Number of tests: 6 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | [#0] dojo.html Cycles:165 Average:5673.46 Median:5889.47 stddev:645.90 (11.0%) stddev-sans-first:619.06 06:29:37 INFO - PROCESS | 24659 | Values: 3241.5 3246.6 3270.2 3290.4 3305.6 5701.3 5759.2 5776.2 5777.5 5802.0 5688.3 5768.0 5769.8 5770.2 5784.9 5139.1 5205.8 5219.8 5253.0 5263.5 5081.4 5129.1 5268.5 5282.8 5283.6 5110.8 5117.2 5134.2 5149.7 5174.7 5193.4 5250.0 5259.9 5264.1 5290.0 5002.3 5073.9 5147.5 5217.3 5231.0 5521.8 5528.7 5561.2 5573.4 5615.9 5978.7 6037.0 6094.9 6095.5 6100.0 5961.0 6090.0 6112.1 6124.7 6129.3 5710.0 5739.0 5756.2 5757.0 5762.2 6312.6 6317.7 6324.4 6324.9 6325.9 5877.4 5942.6 6004.0 6071.2 6079.5 6117.6 6126.2 6126.9 6129.8 6130.9 6068.6 6074.1 6078.4 6081.0 6109.2 5881.4 5932.3 5944.6 6057.3 6114.1 4599.9 4627.8 4642.1 4643.0 4654.7 4189.3 4189.9 4192.7 4200.5 4216.6 5847.6 5857.1 5862.4 5863.9 5868.1 5840.6 5978.8 6080.7 6142.5 6154.8 5874.8 5876.8 5883.9 5889.5 5923.6 5277.9 5318.5 5324.2 5336.5 5339.4 6094.4 6202.6 6261.1 6264.0 6396.9 6131.0 6133.3 6143.9 6144.3 6149.2 6296.8 6330.4 6340.8 6354.1 6364.4 5873.7 5953.9 5964.0 5984.3 6006.5 6124.0 6126.8 6137.6 6144.5 6146.9 5960.0 6005.5 6010.6 6015.2 6035.8 5873.3 5892.7 5936.8 5974.7 6000.5 5926.0 5965.7 5968.8 5974.7 6006.5 6045.0 6058.1 6060.4 6061.6 6074.1 5734.3 5760.1 5797.1 5824.7 5895.9 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | [#1] ext.html Cycles:180 Average:67456.18 Median:41196.28 stddev:134134.94 (325.6%) stddev-sans-first:134417.24 06:29:37 INFO - PROCESS | 24659 | Values: 577.9 633.2 638.8 653.0 659.7 36469.5 48100.3 49110.8 49163.5 49188.5 50667.2 50711.5 50711.5 50898.5 51088.0 8655.4 9275.5 9427.7 9433.6 11123.9 10967.1 11385.6 11390.3 11395.5 11396.3 11339.5 11426.5 11460.9 11468.4 11471.3 11317.2 11323.4 11335.0 11345.7 11348.9 11199.4 11278.8 11283.6 11287.9 11311.0 47312.0 47791.3 47807.5 47959.3 47970.3 3896.3 4030.3 4258.6 4447.9 4583.1 36608.8 36777.3 37085.3 38056.8 38371.8 4467.6 4622.9 4678.0 4875.2 4939.0 391775.0 395907.0 396051.0 397843.0 398169.0 38532.2 69820.3 70477.0 70502.6 70524.0 38478.2 40189.6 40399.4 40645.8 40746.2 17264.0 17582.1 17584.6 17588.0 17604.0 13741.2 13900.3 13917.9 13958.5 14639.7 9290.6 9417.8 9430.9 9483.8 9504.6 3574.9 3606.5 3614.6 3652.5 3660.5 1019.9 1135.6 1147.5 1196.1 1226.1 35051.3 36058.3 37123.4 37210.8 37269.6 1220.1 1221.7 1240.5 1252.2 1264.1 17696.6 17817.8 18843.8 18885.5 19083.0 607560.0 609296.0 609558.0 611203.0 612534.0 67347.7 67658.3 67660.7 67992.0 68008.0 1370.6 1381.2 1466.3 1482.0 1492.9 34541.0 36977.0 37011.6 37136.1 37454.3 57551.1 57815.0 57926.1 58561.4 58621.7 453715.0 455327.0 456697.0 458139.0 595764.0 50983.0 51315.0 51396.0 54726.5 54926.0 50600.5 51120.0 54585.7 55566.7 55625.7 44979.8 46321.1 48222.8 48533.3 49570.0 46931.0 47057.8 48127.5 48157.5 49291.5 46175.3 47123.3 48216.8 48299.5 48302.8 39121.8 41646.4 41946.6 42117.4 42713.1 30385.5 30680.0 31161.4 31197.8 31237.2 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | [#2] jquery.html Cycles:180 Average:32760.64 Median:2635.28 stddev:87447.76 (3318.3%) stddev-sans-first:87659.36 06:29:37 INFO - PROCESS | 24659 | Values: 419.5 426.7 436.8 439.3 440.2 19592.4 21225.7 21625.8 22021.7 22199.1 20177.3 21342.1 21445.9 21743.2 22114.1 5754.6 6029.2 6040.2 6042.9 6043.1 5693.5 5956.0 5988.8 5993.5 5993.9 5794.2 5955.5 5958.4 5960.1 5961.8 5936.8 5943.6 5945.1 5946.6 5948.7 5310.1 5340.2 5371.2 5377.2 5409.1 24743.5 24870.5 24939.0 25050.6 25153.0 2549.7 2578.5 2607.5 2663.1 2980.9 14998.6 15300.6 15613.3 15715.7 16275.3 2043.3 2186.8 2402.4 2477.5 2509.5 94117.0 99734.0 104609.5 104721.0 106353.5 18862.6 19015.8 19129.8 19595.3 19988.9 35452.0 35504.3 35554.3 35633.5 35700.0 10365.5 10551.0 10644.6 10941.5 11117.6 8852.9 8955.2 9073.6 9082.0 9183.7 9293.7 9584.0 9614.9 9652.9 9666.4 3597.8 3641.1 3653.9 3740.3 3753.6 796.6 939.6 1015.0 1065.9 1094.4 20660.9 21162.8 21454.9 21695.1 21705.3 1019.4 1045.2 1051.0 1062.2 1063.4 11031.2 11806.9 11928.5 11957.7 12092.8 519718.0 520863.0 522711.0 541272.0 542507.0 99042.0 99184.0 99306.0 101916.0 102395.5 911.0 964.6 985.5 995.9 1047.9 18537.9 18944.1 19100.4 19398.2 19512.9 41398.8 45709.1 46229.8 47195.0 47484.3 54035.7 60318.0 60471.7 60639.0 65263.3 9014.8 9051.9 9140.9 9158.3 9333.3 10398.1 13978.8 14214.3 14389.6 14686.5 12114.8 12412.3 12557.2 12571.7 12742.5 11795.4 11897.3 12105.5 12486.2 12505.7 11931.9 12082.8 12142.2 12595.9 13027.6 9035.5 9170.6 9192.6 9295.4 9383.6 9580.4 12468.5 12615.6 12920.4 13268.9 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | [#3] mootools.html Cycles:180 Average:6113.71 Median:4652.43 stddev:3461.19 (74.4%) stddev-sans-first:3453.75 06:29:37 INFO - PROCESS | 24659 | Values: 1528.8 1554.6 1735.0 1782.1 1844.1 8630.7 9358.1 9359.2 9360.2 9362.8 8012.4 8557.0 8835.0 8903.4 9106.6 2452.3 2478.4 2483.7 2487.7 2492.7 2427.1 2475.7 2477.2 2482.3 2487.8 2436.2 2437.8 2441.3 2444.1 2448.9 2452.8 2459.4 2470.3 2475.5 2495.2 2369.5 2388.9 2391.4 2391.6 2419.6 9283.0 9309.0 9346.9 9367.5 9375.1 5366.7 5463.0 5479.2 5491.5 5494.8 3461.9 3557.9 3606.4 3607.7 3637.8 1180.8 1197.5 1207.5 1214.5 1243.4 12667.1 12681.4 12686.7 12711.9 12719.5 4744.7 4776.7 4822.3 4867.7 4923.0 10679.1 10689.3 10694.1 10704.0 10736.5 5461.8 5486.1 5494.8 5498.7 5503.1 4462.2 4796.5 4960.9 5023.7 5080.5 4169.2 4215.9 4261.8 4271.6 4302.8 1301.1 1305.4 1310.5 1312.6 1323.8 1059.1 1067.9 1070.7 1072.7 1076.8 6367.9 6438.3 6605.0 6695.5 6719.5 492.6 496.6 499.8 501.6 504.3 4273.4 4480.6 4488.3 4506.2 4560.1 11293.4 11649.8 11717.6 11754.2 11758.5 11311.9 11480.5 11635.4 11640.4 11678.9 8534.8 8534.8 8627.3 8691.4 8775.5 6087.5 6180.0 6258.1 6344.0 6516.9 10438.8 10505.1 10522.6 10546.7 10618.6 10180.8 10340.5 10620.2 10772.2 10855.9 7426.7 8040.3 8193.3 8198.1 8369.7 9184.5 9232.3 9263.0 9265.1 9272.9 8169.5 8198.2 8240.7 8313.1 8445.9 7932.6 7989.6 7995.8 8090.9 8235.1 7307.3 7399.8 7563.8 7566.5 7615.8 5618.2 5821.0 5841.9 5934.6 6150.4 5543.5 5699.0 5842.5 5862.3 6057.8 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | [#4] prototype.html Cycles:180 Average:4718.92 Median:5262.46 stddev:1368.78 (26.0%) stddev-sans-first:1332.44 06:29:37 INFO - PROCESS | 24659 | Values: 333.0 338.4 339.6 341.2 341.4 5402.7 5416.5 5442.5 5466.8 5505.4 5402.2 5417.8 5425.2 5426.1 5432.0 4282.1 4289.5 4292.4 4297.1 4298.3 3910.6 4073.0 4250.5 4267.6 4296.7 4232.4 4234.7 4242.1 4249.6 4258.9 4234.2 4260.1 4266.5 4267.0 4278.5 3722.1 3786.3 3798.6 3812.7 3813.4 5258.0 5266.9 5288.3 5289.1 5299.6 4888.0 4895.3 4900.2 4910.6 4913.2 5445.3 5606.5 5647.8 5683.5 5684.7 4173.4 4177.5 4181.9 4187.6 4187.8 5587.5 5741.9 5888.5 5898.6 5910.7 3943.4 4130.8 4186.9 4339.3 4339.4 4362.7 4367.3 4370.6 4377.6 4378.9 4906.4 4915.2 4919.0 4932.2 5018.0 5588.7 5677.6 5719.9 5735.7 5737.0 1493.5 1501.8 1511.8 1512.9 1520.0 952.6 969.9 977.0 983.3 984.6 4928.5 4936.5 4940.2 4944.0 4946.0 5145.6 5153.9 5169.4 5169.8 5177.8 4625.8 4882.9 4955.9 4963.9 4979.7 2760.4 2764.8 2776.4 2776.7 2791.2 5301.7 5335.4 5338.7 5366.5 5438.5 5031.7 5173.5 5237.7 5241.4 5253.3 5315.8 5325.8 5839.6 6004.9 6114.8 5849.9 5858.9 5877.4 5921.0 5923.6 5654.9 5762.5 5815.9 5816.4 5838.4 6052.4 6057.1 6058.2 6088.2 6102.6 4282.2 4285.9 4288.9 4295.6 4300.3 5670.5 5867.2 5914.5 5919.5 5926.7 5715.4 5768.0 5769.4 5773.4 5780.8 5761.5 5761.8 5766.5 5768.9 5770.3 5448.7 5661.3 5692.2 5694.6 5723.6 5734.4 5751.4 5800.7 5804.5 5807.3 5416.8 5661.8 5670.9 5675.5 5676.3 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - PROCESS | 24659 | [#5] yui.html Cycles:180 Average:22584.70 Median:3800.53 stddev:32503.11 (855.2%) stddev-sans-first:32553.34 06:29:37 INFO - PROCESS | 24659 | Values: 855.5 856.8 888.6 910.9 924.2 16437.2 17967.6 18010.5 18026.7 18049.5 16263.3 16439.3 16445.2 16458.9 16467.6 733.6 860.9 873.4 887.1 894.3 898.3 900.5 900.5 900.8 901.0 939.8 940.5 941.0 941.3 942.4 946.6 948.2 948.7 949.2 949.4 690.8 692.2 693.8 694.4 694.9 16289.8 16424.8 16439.3 16464.6 16498.5 15736.9 15864.2 16020.4 16818.3 16823.7 12994.5 13076.8 13142.0 13185.7 13233.3 4169.0 4188.9 4198.7 4249.0 4269.9 87670.0 89655.0 90683.0 91994.0 93707.5 12967.0 12981.7 13144.3 13188.6 13464.8 24356.0 24629.3 24634.6 24689.3 24730.8 8138.5 8541.5 8593.6 8907.1 9203.4 4595.7 4620.3 4622.4 4688.4 4823.7 3633.9 3795.8 3805.3 3807.3 4100.8 655.4 664.3 669.1 678.1 694.4 733.3 749.0 774.0 791.3 811.6 10713.0 10779.6 10971.7 11010.8 11501.4 804.1 811.4 824.5 841.2 845.0 4930.1 5087.7 5190.0 5274.0 5306.8 107574.5 133402.0 134086.0 136511.3 136647.3 83773.6 102469.0 103682.5 106092.5 106173.0 91328.0 91685.0 92196.5 94705.5 95130.0 10412.9 10447.6 10620.3 10626.7 10813.8 47175.3 48246.8 48449.0 51604.0 52165.7 73325.6 75347.6 75935.0 78045.0 79291.6 13583.9 13714.7 13742.7 14161.8 14681.3 16234.8 16306.5 16626.7 16707.3 16839.2 14533.0 14538.4 14768.6 15702.0 15745.6 14120.5 14560.0 15541.6 15683.7 15697.0 12982.4 13000.7 13860.4 13973.9 14233.1 12051.3 12826.2 13040.5 13243.3 13304.1 12264.8 12710.9 12816.9 13075.2 13170.6 06:29:37 INFO - PROCESS | 24659 | -------- Summary: end -------- 06:29:37 INFO - PROCESS | 24659 | 06:29:37 INFO - TEST-INFO | 24659: exit 0 06:29:37 INFO - TEST-OK | dromaeo_css | took 1113354ms 06:29:37 INFO - TEST-START | kraken 06:29:37 INFO - operating with platform_type : linux_ 06:29:37 INFO - Initialising browser for kraken test... 06:29:37 INFO - TEST-INFO | started process 24849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfOldw/profile http://localhost:50783/getInfo.html) 06:29:41 INFO - PROCESS | 24849 | __metrics Screen width/height:1600/1200 06:29:41 INFO - PROCESS | 24849 | colorDepth:24 06:29:42 INFO - PROCESS | 24849 | Browser inner width/height: 1024/697 06:29:42 INFO - PROCESS | 24849 | __metrics 06:29:42 INFO - PROCESS | 24849 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:29:42 INFO - PROCESS | 24849 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:29:43 INFO - TEST-INFO | 24849: exit 0 06:29:43 INFO - Browser initialized. 06:29:43 INFO - Running cycle 1/1 for kraken test... 06:29:43 INFO - TEST-INFO | started process 24935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfOldw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:55 INFO - PROCESS | 24935 | RSS: Main: 144130048 06:29:55 INFO - PROCESS | 24935 | 06:29:58 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50783/tests/kraken/driver.html?testName=audio-beat-detection) 06:29:58 INFO - PROCESS | 24935 | RSS: Main: 199221248 06:29:58 INFO - PROCESS | 24935 | 06:30:01 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50783/tests/kraken/driver.html?testName=audio-dft) 06:30:02 INFO - PROCESS | 24935 | RSS: Main: 183431168 06:30:02 INFO - PROCESS | 24935 | 06:30:04 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50783/tests/kraken/driver.html?testName=audio-fft) 06:30:05 INFO - PROCESS | 24935 | RSS: Main: 274771968 06:30:05 INFO - PROCESS | 24935 | 06:30:07 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50783/tests/kraken/driver.html?testName=audio-oscillator) 06:30:08 INFO - PROCESS | 24935 | RSS: Main: 179859456 06:30:08 INFO - PROCESS | 24935 | 06:30:10 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:10 INFO - PROCESS | 24935 | RSS: Main: 179908608 06:30:10 INFO - PROCESS | 24935 | 06:30:13 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50783/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:14 INFO - PROCESS | 24935 | RSS: Main: 216010752 06:30:14 INFO - PROCESS | 24935 | 06:30:17 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50783/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:18 INFO - PROCESS | 24935 | RSS: Main: 214159360 06:30:18 INFO - PROCESS | 24935 | 06:30:21 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50783/tests/kraken/driver.html?testName=json-parse-financial) 06:30:21 INFO - PROCESS | 24935 | RSS: Main: 213344256 06:30:21 INFO - PROCESS | 24935 | 06:30:23 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:23 INFO - PROCESS | 24935 | RSS: Main: 176021504 06:30:23 INFO - PROCESS | 24935 | 06:30:25 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:30:26 INFO - PROCESS | 24935 | RSS: Main: 183287808 06:30:26 INFO - PROCESS | 24935 | 06:30:28 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:30:28 INFO - PROCESS | 24935 | RSS: Main: 189423616 06:30:28 INFO - PROCESS | 24935 | 06:30:31 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:30:31 INFO - PROCESS | 24935 | RSS: Main: 197701632 06:30:31 INFO - PROCESS | 24935 | 06:30:34 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:30:35 INFO - PROCESS | 24935 | RSS: Main: 194064384 06:30:35 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | Cycle 1(1): loaded http://localhost:50783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50783/tests/kraken/driver.html?testName=ai-astar) 06:30:36 INFO - PROCESS | 24935 | RSS: Main: 244559872 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | __start_tp_report 06:30:36 INFO - PROCESS | 24935 | _x_x_mozilla_page_load 06:30:36 INFO - PROCESS | 24935 | _x_x_mozilla_page_load_details 06:30:36 INFO - PROCESS | 24935 | |i|pagename|runs| 06:30:36 INFO - PROCESS | 24935 | |0;ai-astar;115;111;121;110;112;113;111;113;115;110 06:30:36 INFO - PROCESS | 24935 | |1;audio-beat-detection;150;115;140;172;120;149;153;122;179;119 06:30:36 INFO - PROCESS | 24935 | |2;audio-dft;161;161;163;162;162;160;162;162;161;160 06:30:36 INFO - PROCESS | 24935 | |3;audio-fft;75;75;75;192;76;74;76;76;172;75 06:30:36 INFO - PROCESS | 24935 | |4;audio-oscillator;82;83;160;82;83;83;142;83;83;146 06:30:36 INFO - PROCESS | 24935 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 06:30:36 INFO - PROCESS | 24935 | |6;imaging-darkroom;146;145;146;146;147;146;146;145;147;146 06:30:36 INFO - PROCESS | 24935 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;94;95 06:30:36 INFO - PROCESS | 24935 | |8;json-parse-financial;50;51;50;50;49;49;52;51;50;51 06:30:36 INFO - PROCESS | 24935 | |9;json-stringify-tinderbox;60;64;61;60;61;61;61;60;60;68 06:30:36 INFO - PROCESS | 24935 | |10;stanford-crypto-aes;74;74;73;75;79;72;74;74;77;71 06:30:36 INFO - PROCESS | 24935 | |11;stanford-crypto-ccm;121;118;119;120;125;128;121;117;154;127 06:30:36 INFO - PROCESS | 24935 | |12;stanford-crypto-pbkdf2;154;151;154;153;151;152;153;151;152;151 06:30:36 INFO - PROCESS | 24935 | |13;stanford-crypto-sha256-iterative;61;66;62;63;65;62;63;62;61;62 06:30:36 INFO - PROCESS | 24935 | __end_tp_report 06:30:36 INFO - PROCESS | 24935 | __start_cc_report 06:30:36 INFO - PROCESS | 24935 | _x_x_mozilla_cycle_collect,1666 06:30:36 INFO - PROCESS | 24935 | __end_cc_report 06:30:36 INFO - PROCESS | 24935 | __startTimestamp1476797436930__endTimestamp 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | ------- Summary: start ------- 06:30:36 INFO - PROCESS | 24935 | Number of tests: 14 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:3.31 (2.9%) stddev-sans-first:3.44 06:30:36 INFO - PROCESS | 24935 | Values: 115.0 111.0 121.0 110.0 112.0 113.0 111.0 113.0 115.0 110.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:149.50 stddev:22.73 (15.2%) stddev-sans-first:23.92 06:30:36 INFO - PROCESS | 24935 | Values: 150.0 115.0 140.0 172.0 120.0 149.0 153.0 122.0 179.0 119.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 06:30:36 INFO - PROCESS | 24935 | Values: 161.0 161.0 163.0 162.0 162.0 160.0 162.0 162.0 161.0 160.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#3] audio-fft Cycles:10 Average:96.60 Median:75.00 stddev:45.26 (60.3%) stddev-sans-first:47.33 06:30:36 INFO - PROCESS | 24935 | Values: 75.0 75.0 75.0 192.0 76.0 74.0 76.0 76.0 172.0 75.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:83.00 stddev:32.49 (39.1%) stddev-sans-first:33.59 06:30:36 INFO - PROCESS | 24935 | Values: 82.0 83.0 160.0 82.0 83.0 83.0 142.0 83.0 83.0 146.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:30:36 INFO - PROCESS | 24935 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:30:36 INFO - PROCESS | 24935 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 146.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:30:36 INFO - PROCESS | 24935 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:0.95 (1.9%) stddev-sans-first:1.00 06:30:36 INFO - PROCESS | 24935 | Values: 50.0 51.0 50.0 50.0 49.0 49.0 52.0 51.0 50.0 51.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:2.55 (4.2%) stddev-sans-first:2.64 06:30:36 INFO - PROCESS | 24935 | Values: 60.0 64.0 61.0 60.0 61.0 61.0 61.0 60.0 60.0 68.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.00 stddev:2.31 (3.1%) stddev-sans-first:2.45 06:30:36 INFO - PROCESS | 24935 | Values: 74.0 74.0 73.0 75.0 79.0 72.0 74.0 74.0 77.0 71.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:123.00 stddev:10.85 (8.8%) stddev-sans-first:11.41 06:30:36 INFO - PROCESS | 24935 | Values: 121.0 118.0 119.0 120.0 125.0 128.0 121.0 117.0 154.0 127.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:152.50 stddev:1.23 (0.8%) stddev-sans-first:1.12 06:30:36 INFO - PROCESS | 24935 | Values: 154.0 151.0 154.0 153.0 151.0 152.0 153.0 151.0 152.0 151.0 06:30:36 INFO - PROCESS | 24935 | 06:30:36 INFO - PROCESS | 24935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.64 (2.6%) stddev-sans-first:1.62 06:30:36 INFO - PROCESS | 24935 | Values: 61.0 66.0 62.0 63.0 65.0 62.0 63.0 62.0 61.0 62.0 06:30:36 INFO - PROCESS | 24935 | -------- Summary: end -------- 06:30:36 INFO - PROCESS | 24935 | 06:30:37 INFO - TEST-INFO | 24935: exit 0 06:30:37 INFO - TEST-OK | kraken | took 60168ms 06:30:37 INFO - SUITE-END | took 1173s 06:30:38 INFO - Completed test suite (00:19:33) 06:30:38 INFO - javascript benchmark 06:30:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.546183534305, 3246.561714168587, 3270.2314955985325, 3290.374828782533, 3305.5702758641373, 5701.315842098944, 5759.222504961829, 5776.249087618614, 5777.480026797587, 5801.9999999999945, 5688.2605261315975, 5768.048272035119, 5769.798057068004, 5770.163326317682, 5784.884302313952, 5139.126348520751, 5205.817796377128, 5219.817306394277, 5252.973735131338, 5263.526282634562, 5081.415637201713, 5129.128048231791, 5268.499492548221, 5282.7622756976025, 5283.55089817366, 5110.795568177268, 5117.232415137741, 5134.204198349262, 5149.74251287436, 5174.715390653512, 5193.402758682743, 5249.950009997997, 5259.947400525984, 5264.052470555299, 5290.0, 5002.324686167357, 5073.873153171164, 5147.510986456318, 5217.34783152106, 5231.0, 5521.834344969617, 5528.723563821793, 5561.165825126223, 5573.41479144688, 5615.887682246333, 5978.701064946736, 6037.0, 6094.939050609526, 6095.451409373133, 6100.0, 5961.0, 6090.0, 6112.052631842072, 6124.7243874025335, 6129.325774164839, 5710.0, 5738.971305143447, 5756.194132821408, 5756.971215143897, 5762.193292938992, 6312.589681670676, 6317.7157027932935, 6324.367563243639, 6324.873502529924, 6325.936740632535, 5877.412258774174, 5942.61373010753, 6003.969980150158, 6071.210742603434, 6079.544034197453, 6117.602355846856, 6126.23422072241, 6126.877462450726, 6129.785457508966, 6130.877382452326, 6068.575199735976, 6074.141129774273, 6078.3921607838865, 6081.0, 6109.175261339662, 5881.3530511643685, 5932.3177834548715, 5944.613600115978, 6057.303410107806, 6114.082887566811, 4599.9280949146805, 4627.838025669085, 4642.071585682809, 4642.9535704643195, 4654.743989080565, 4189.308764053897, 4189.895252618709, 4192.7065105442325, 4200.5169405518145, 4216.578342165821, 5847.649141051551, 5857.121431785266, 5862.384449632812, 5863.853403664857, 5868.119782032729, 5840.649561026267, 5978.760849565969, 6080.665563394055, 6142.539309551801, 6154.815355539341, 5874.765009399576, 5876.823695289063, 5883.911741323884, 5889.469947704727, 5923.585349025613, 5277.947220527745, 5318.494742999409, 5324.1747529133045, 5336.493033161843, 5339.439358867341, 6094.360092190256, 6202.596831205957, 6261.092141639437, 6263.96868015657, 6396.872062558816, 6131.0, 6133.304060594526, 6143.907841382294, 6144.293406258337, 6149.2313460817395, 6296.779612713533, 6330.430261276507, 6340.778072767615, 6354.110424540476, 6364.427201551883, 5873.676947767914, 5953.940460595339, 5964.045752679551, 5984.281886173687, 6006.519478441802, 6124.014786914997, 6126.823043872828, 6137.60418695462, 6144.494598823317, 6146.877062458815, 5960.046392577166, 6005.549583781147, 6010.609310394811, 6015.157877897011, 6035.818925432244, 5873.295204575478, 5892.6759028253855, 5936.821895343147, 5974.731137098928, 6000.519958403404, 5926.0, 5965.70171491415, 5968.791092311922, 5974.701264936823, 6006.549508786771, 6044.969775151096, 6058.12157237207, 6060.363661815446, 6061.605995610271, 6074.119252708421, 5734.283214598176, 5760.107183386582, 5797.101449275369, 5824.737886795019, 5895.852603684943], "value": 5629.415229847427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.887311974165, 633.1578999930093, 638.8243233110894, 653.0335104046012, 659.7427003468645, 36469.45295820561, 48100.278495822546, 49110.75444622781, 49163.50836491634, 49188.508114918885, 50667.23999140006, 50711.49288507114, 50711.49288507123, 50898.491015089836, 51088.0, 8655.394122411433, 9275.536223188847, 9427.670031548898, 9433.622655093788, 11123.888761112366, 10967.122630189606, 11385.601503947364, 11390.316581005125, 11395.48720307584, 11396.316221026724, 11339.546418143264, 11426.485808138612, 11460.942695286554, 11468.369239691814, 11471.254368466023, 11317.207795454322, 11323.433828308634, 11335.0, 11345.659630211107, 11348.943255283712, 11199.440027998568, 11278.830817537744, 11283.605073822377, 11287.887121128766, 11311.038561722264, 47312.0, 47791.283130753065, 47807.521924781, 47959.28061079087, 47970.28044579334, 3896.279188350164, 4030.3349947258666, 4258.5954334338185, 4447.866564003085, 4583.129205450954, 36608.81695591532, 36777.264454710756, 37085.258294834224, 38056.80971595152, 38371.808140959394, 4467.620252278561, 4622.86131416058, 4678.0, 4875.24433712775, 4939.0, 391775.0, 395907.0, 396051.0, 397843.0, 398169.0, 38532.22935541273, 69820.3017969824, 70477.0, 70502.64748676223, 70524.0, 38478.2304353917, 40189.59810401859, 40399.39400908989, 40645.79677101596, 40746.1850762989, 17264.0, 17582.120893955253, 17584.648307034044, 17588.0, 17604.0, 13741.24423156716, 13900.304984750925, 13917.860821391656, 13958.511452099128, 14639.707205855822, 9290.62837486493, 9417.764555886157, 9430.905690943002, 9483.810323793485, 9504.621829834636, 3574.91062723434, 3606.4590311452966, 3614.584322802911, 3652.543432070991, 3660.524131862841, 1019.9439030853374, 1135.5861951869974, 1147.5139694096165, 1196.1387800783423, 1226.0804396702474, 35051.29897402089, 36058.27883442317, 37123.443148352795, 37210.813945930095, 37269.627303726615, 1220.0666490135054, 1221.7251118498266, 1240.5161986825146, 1252.2423933520272, 1264.1467009768369, 17696.646067078844, 17817.821821781876, 18843.81156188448, 18885.52786180329, 19083.0, 607560.0, 609296.0, 609558.0, 611203.0, 612534.0, 67347.66326168436, 67658.32341676619, 67660.6616966912, 67992.0, 68008.0, 1370.6025252676611, 1381.2127087559995, 1466.3474753734486, 1481.9703605928037, 1492.8656420922168, 34541.0, 36977.0, 37011.6298837019, 37136.14319284079, 37454.25091498209, 57551.1367329482, 57815.0, 57926.13110803257, 58561.4143858556, 58621.70689146527, 453715.0, 455327.0, 456697.0, 458139.0, 595764.0, 50983.0, 51315.0, 51396.0, 54726.452735472136, 54926.0, 50600.49399505958, 51120.0, 54585.72707136439, 55566.72216638891, 55625.721871392, 44979.7751011256, 46321.06026586089, 48222.758886205345, 48533.27200091931, 49570.0, 46931.0, 47057.76471117623, 48127.518724812304, 48157.5184248153, 49291.50708492869, 46175.3073703888, 47123.29315060208, 48216.758916205195, 48299.517004829504, 48302.75848620875, 39121.804390977864, 41646.37530436985, 41946.58053419427, 42117.36823947582, 42713.1457370857, 30385.544216837206, 30680.0, 31161.37677246397, 31197.75208991615, 31237.219069523442], "value": 21850.212030965336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.5489848412957, 426.7418261572892, 436.7575995322597, 439.34367434770917, 440.19005030743426, 19592.41222763316, 21225.68161477579, 21625.783742162574, 22021.66967495489, 22199.1120355186, 20177.29379471719, 21342.146314147416, 21445.892770536164, 21743.23898663543, 22114.115435382566, 5754.597178197528, 6029.216201893748, 6040.184575082373, 6042.939570604303, 6043.093535969618, 5693.516051135658, 5955.987482128027, 5988.790392336269, 5993.46058854703, 5993.940060599403, 5794.246747922764, 5955.52355811534, 5958.433948774859, 5960.0761881908375, 5961.821145365646, 5936.792212272571, 5943.643381397108, 5945.078512830518, 5946.5540084493405, 5948.702564871739, 5310.097283461821, 5340.172273297645, 5371.167469042305, 5377.220303056074, 5409.134538473825, 24743.50512989748, 24870.50258994828, 24939.0, 25050.624240636404, 25153.0, 2549.7067837198774, 2578.48430313938, 2607.478504299148, 2663.081236973241, 2980.8807647694066, 14998.62503437412, 15300.617484562976, 15613.297401616954, 15715.735636530144, 16275.348986040544, 2043.2746375036945, 2186.759456459788, 2402.447437089462, 2477.5044991001873, 2509.4855554611445, 94117.0, 99734.0, 104609.47695261551, 104721.0, 106353.46823265834, 18862.622747545247, 19015.809841901402, 19129.80870191308, 19595.31416400419, 19988.90005549963, 35452.0, 35504.289914201574, 35554.28891422157, 35633.46549801755, 35700.0, 10365.533550990223, 10551.0, 10644.627438039632, 10941.4529273536, 11117.555297787998, 8852.8672069919, 8955.194032537103, 9073.59549719325, 9082.0, 9183.724488265363, 9293.67472138472, 9584.0, 9614.90385096154, 9652.90347096534, 9666.420014799134, 3597.7587732232337, 3641.1443310821937, 3653.908652283714, 3740.326741186558, 3753.6434038766274, 796.6295672512309, 939.5677988125539, 1014.9695509134738, 1065.9093977011885, 1094.3980810554162, 20660.896695516425, 21162.788372116083, 21454.892725536272, 21695.132194712034, 21705.34883953484, 1019.4453458475883, 1045.163868904873, 1051.0015485289007, 1062.1661995333625, 1063.4470075560664, 11031.2278140531, 11806.940965295118, 11928.522859085539, 11957.701057473632, 12092.75814483723, 519718.0, 520863.0, 522711.0, 541272.0, 542507.0, 99042.0, 99184.0, 99306.0, 101916.0, 102395.4880225609, 910.9772255693529, 964.5563041001218, 985.5121714751244, 995.865558149655, 1047.874255089379, 18537.90731046336, 18944.147513361655, 19100.426987190407, 19398.224071037, 19512.902435487733, 41398.79300603478, 45709.08581828278, 46229.76885115553, 47195.0, 47484.2877356833, 54035.729821350644, 60318.0, 60471.69764151151, 60639.0, 65263.347366527625, 9014.828072350814, 9051.909480905106, 9140.862887056832, 9158.313126515672, 9333.346665733334, 10398.064174224357, 13978.790318145439, 14214.289285535475, 14389.568312950629, 14686.485972990895, 12114.818277726017, 12412.317322547347, 12557.24656520575, 12571.74856502883, 12742.47090349164, 11795.35125568102, 11897.345645989208, 12105.51577936908, 12486.18839775448, 12505.687357816127, 11931.880681193077, 12082.758344832879, 12142.150049496451, 12595.93702031484, 13027.609171724864, 9035.50304733246, 9170.633174672937, 9192.632294708137, 9295.442273463614, 9383.624655013722, 9580.377275477073, 12468.5012599495, 12615.558455454015, 12920.35398230066, 13268.867311326763], "value": 10761.365401385674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.8318284988652, 1554.6268895465087, 1734.9653006939861, 1782.1445706061081, 1844.050314088244, 8630.65477380904, 9358.064193580638, 9359.20446762026, 9360.157585817284, 9362.81274374512, 8012.439129260954, 8557.0, 8835.028146903835, 8903.42127761695, 9106.63573457061, 2452.337868775434, 2478.4175718706088, 2483.664705264793, 2487.676602041732, 2492.6510288559525, 2427.1141033522727, 2475.7029156501244, 2477.2320580619976, 2482.255323402981, 2487.788537974265, 2436.2082323245018, 2437.768412000857, 2441.316431399202, 2444.083468699238, 2448.8775561221955, 2452.803775697949, 2459.409741662006, 2470.3206618179966, 2475.504899020203, 2495.1516484395393, 2369.5379401016808, 2388.940276493084, 2391.366287933699, 2391.641253811925, 2419.5765740995257, 9283.0, 9309.0, 9346.859797103049, 9367.531623418801, 9375.10936461035, 5366.731663416853, 5462.972685136589, 5479.232907392929, 5491.478309560585, 5494.80768173116, 3461.86855078539, 3557.8932632021083, 3606.4296346616925, 3607.7474576779637, 3637.7635453695425, 1180.752042071166, 1197.5329621447643, 1207.541134368943, 1214.4959841665698, 1243.390738538119, 12667.11330206886, 12681.365931703378, 12686.682832929251, 12711.872881271254, 12719.491220351174, 4744.722533184091, 4776.665633405628, 4822.276658501253, 4867.732274724854, 4922.975385123052, 10679.09227715653, 10689.251752377415, 10694.144468442506, 10704.0, 10736.516856741466, 5461.808836690697, 5486.067368547357, 5494.752736126804, 5498.725063746797, 5503.11950087984, 4462.152191083684, 4796.5203479651755, 4960.851174464772, 5023.748812559357, 5080.54275115234, 4169.207850508394, 4215.936760948588, 4261.764088414325, 4271.572842715704, 4302.849400270976, 1301.0827366706449, 1305.3734207580226, 1310.5387492945297, 1312.6062181345558, 1323.7617228898891, 1059.0627294843964, 1067.8771941226858, 1070.6573896353093, 1072.6621114348955, 1076.784643071389, 6367.936320636827, 6438.291787903327, 6604.966975165094, 6695.46436285096, 6719.496037797185, 492.62560454055176, 496.62504808869073, 499.78259457135533, 501.5636396335212, 504.30154236382873, 4273.423087883159, 4480.551944805494, 4488.326750987313, 4506.211413002711, 4560.1335746208115, 11293.378864162385, 11649.825252621047, 11717.648470545897, 11754.235974661791, 11758.529658813552, 11311.943440282746, 11480.540778368939, 11635.360055197045, 11640.417979101012, 11678.941605291919, 8534.786630334167, 8534.78663033429, 8627.309815214769, 8691.435056721293, 8775.517346546001, 6087.482563981934, 6180.042093475518, 6258.092576576462, 6343.9682801585695, 6516.869662606816, 10438.843417348899, 10505.107065899178, 10522.579096836347, 10546.736331591772, 10618.575256989634, 10180.79638407213, 10340.53467593975, 10620.20348473852, 10772.245942784244, 10855.891441085803, 7426.74006409773, 8040.316573091352, 8193.344532437271, 8198.057223419382, 8369.707060252862, 9184.49485278316, 9232.261419086322, 9263.02738212478, 9265.073492650681, 9272.907270927204, 8169.5098294102545, 8198.180181981754, 8240.711575094843, 8313.085560588452, 8445.87331190045, 7932.56370899583, 7989.560574168477, 7995.840083198187, 8090.919090809017, 8235.094139644514, 7307.3423391894985, 7399.778006659809, 7563.773086807405, 7566.546007239584, 7615.847683046419, 5618.157276408571, 5821.0, 5841.94158058414, 5934.643921364732, 6150.415710507495, 5543.473370029841, 5698.971505142447, 5842.474177324061, 5862.296524417097, 6057.818265451867], "value": 4827.3267555291495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.97958309398405, 338.4362661177798, 339.6298035141695, 341.1794633905455, 341.3684683335829, 5402.6758394496355, 5416.539594134499, 5442.537384322332, 5466.781328746845, 5505.421930697279, 5402.243685883969, 5417.756200970956, 5425.186222066692, 5426.077566813641, 5431.995080910025, 4282.079352939118, 4289.463817022872, 4292.356146578007, 4297.140571885635, 4298.312270036795, 3910.569837317893, 4072.9592704072875, 4250.511191213003, 4267.615914567688, 4296.742195468282, 4232.407462955173, 4234.66122710184, 4242.109157077018, 4249.6387807036435, 4258.9148217035645, 4234.237837189305, 4260.104253607131, 4266.530681625019, 4266.954596123938, 4278.475699337406, 3722.1253005543676, 3786.2995345860827, 3798.601146879593, 3812.694984401241, 3813.427985802124, 5258.0009798138235, 5266.92099618506, 5288.2596436498925, 5289.127293996486, 5299.602529810241, 4887.951120488785, 4895.265710143507, 4900.191468407708, 4910.607151427913, 4913.189323761575, 5445.264889239941, 5606.495415412633, 5647.802326918538, 5683.460071293221, 5684.687342196177, 4173.436586060873, 4177.540470548237, 4181.874543763692, 4187.560306167839, 4187.8324867005285, 5587.497125258747, 5741.894545400059, 5888.468998060493, 5898.557608179403, 5910.729193223435, 3943.408488726714, 4130.772807495617, 4186.911403035233, 4339.262325404688, 4339.370791235253, 4362.738235705804, 4367.344898265285, 4370.606645401929, 4377.649788016951, 4378.8905277367685, 4906.386701662293, 4915.16442204826, 4918.975405123023, 4932.21084626458, 5018.046571151543, 5588.730592603291, 5677.602567820213, 5719.856028794258, 5735.741891614887, 5737.0, 1493.4772829509584, 1501.8285737125059, 1511.8034655494716, 1512.8638422542024, 1519.9620009499629, 952.5903861339552, 969.8690676758688, 976.9853452198223, 983.2576404814463, 984.6356847966155, 4928.457869634337, 4936.506349365107, 4940.2342636891335, 4943.972971081911, 4945.950540494621, 5145.61407894402, 5153.922691159561, 5169.363624551505, 5169.7932082717025, 5177.8187763428095, 4625.7687115644085, 4882.877928051827, 4955.909699866023, 4963.851084467472, 4979.651424400329, 2760.3513174403997, 2764.7926405519665, 2776.403073339242, 2776.6667999840147, 2791.246363481889, 5301.655392399559, 5335.359756829205, 5338.665333666583, 5366.543843773323, 5438.537724293479, 5031.6729412588065, 5173.534381905646, 5237.73811309433, 5241.3572567066285, 5253.264542963988, 5315.760790764425, 5325.760340784674, 5839.591228614041, 6004.939950600526, 6114.816555503342, 5849.853753656193, 5858.94141058584, 5877.382874798084, 5920.970395147997, 5923.555733319932, 5654.858628534155, 5762.481376676119, 5815.94184058154, 5816.389279125631, 5838.3869693683255, 6052.364501727431, 6057.121717351048, 6058.182145410489, 6088.238970128734, 6102.572819902742, 4282.229198744256, 4285.871423857289, 4288.914221715486, 4295.570442955679, 4300.333448315516, 5670.5180059695385, 5867.178594996619, 5914.497267732291, 5919.526437884872, 5926.703664816656, 5715.371309156073, 5767.971160144172, 5769.365369809234, 5773.393793651774, 5780.797672081625, 5761.534810521879, 5761.827145185651, 5766.509846662912, 5768.942310577008, 5770.307563092456, 5448.700321482356, 5661.348944871393, 5692.174634678031, 5694.629849059798, 5723.599348045597, 5734.426557344233, 5751.41835995088, 5800.738966746591, 5804.477597016289, 5807.332156802022, 5416.783328666809, 5661.801836935688, 5670.886582268414, 5675.460831221028, 5676.262085928803], "value": 4285.887194293719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.5209082913573, 856.8414843253998, 888.5690440136533, 910.9089091090896, 924.1528184671397, 16437.178141092943, 17967.550811229725, 18010.4596862094, 18026.729599056023, 18049.54876128096, 16263.349466021346, 16439.2602332895, 16445.177741112926, 16458.917705411484, 16467.58831029225, 733.625850816085, 860.9053004169537, 873.4191762477944, 887.104024934814, 894.3247847874845, 898.2544488074882, 900.5317235037809, 900.5452246615483, 900.8153328567661, 900.9504477253748, 939.7556635274843, 940.4592359393376, 940.9576569054409, 941.3316545252878, 942.4345392764355, 946.6213514594149, 948.170350942925, 948.7106432538073, 949.2453499467905, 949.4018768176039, 690.7962151165418, 692.1728534401392, 693.8057343943703, 694.3750624437996, 694.8679750847323, 16289.83710162907, 16424.83575164257, 16439.26023328941, 16464.588385290343, 16498.505044848673, 15736.909119847225, 15864.206789660471, 16020.35918563256, 16818.32726690931, 16823.663526729397, 12994.545190918272, 13076.803847942288, 13142.0, 13185.670358241025, 13233.272170030645, 4169.012400420484, 4188.853390131361, 4198.685098617616, 4248.9787551062045, 4269.914601707979, 87670.0, 89655.0, 90683.0, 91994.0, 93707.53146234225, 12967.0, 12981.740365192643, 13144.27706476153, 13188.604341869759, 13464.798028029587, 24356.0, 24629.261122166365, 24634.630480542804, 24689.25932222036, 24730.752692473205, 8138.511689298661, 8541.53021583819, 8593.570321483901, 8907.10928907104, 9203.447793132433, 4595.724256544618, 4620.306953956933, 4622.422197225347, 4688.367070445446, 4823.662343635911, 3633.927321453556, 3795.7532760370486, 3805.3150432921784, 3807.295650304647, 4100.774457404871, 655.4098539188506, 664.2792570061538, 669.100060418736, 678.0541145102554, 694.4028135803205, 733.2557454184008, 749.0262658543871, 774.0169984120135, 791.2522666080614, 811.6266517402062, 10713.0, 10779.622713205, 10971.725706857233, 11010.779784404267, 11501.424928753697, 804.1145343949337, 811.3874025111004, 824.4517395931638, 841.2218697704722, 845.0, 4930.087933732271, 5087.652819050317, 5190.0, 5273.973630131824, 5306.8407947761625, 107574.46212768886, 133402.0, 134086.0, 136511.31744341413, 136647.31676341555, 83773.58113209395, 102469.0, 103682.48158759158, 106092.46953765182, 106173.0, 91328.0, 91684.99999999866, 92196.53901730449, 94705.5264723672, 95130.0, 10412.931755706859, 10447.634332798316, 10620.256582039492, 10626.73433164177, 10813.783724325313, 47175.29237061378, 48246.758766205945, 48449.0, 51604.0, 52165.7391713039, 73325.6333718328, 75347.62326188335, 75935.0, 78045.0, 79291.60354198192, 13583.932080339535, 13714.65713357174, 13742.725145497234, 14161.787573186617, 14681.265936702908, 16234.79167701237, 16306.510804675878, 16626.66746665084, 16707.331706731595, 16839.15804209809, 14533.0, 14538.41846326135, 14768.556943291718, 15702.0, 15745.606359841096, 14120.50578229757, 14560.0, 15541.611459713145, 15683.686326273182, 15696.979696319702, 12982.350882456029, 13000.674983125498, 13860.376283067488, 13973.930130349283, 14233.074850134708, 12051.276923384625, 12826.166299190523, 13040.54358097462, 13243.271620060605, 13304.068715189844, 12264.816027759412, 12710.893847824564, 12816.87183128194, 13075.150115242479, 13170.60488185356], "value": 8286.881386461198, "unit": "score"}], "name": "dromaeo_css", "value": 7810.198134613213, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 121.0, 110.0, 112.0, 113.0, 111.0, 113.0, 115.0, 110.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 140.0, 172.0, 120.0, 149.0, 153.0, 122.0, 179.0, 119.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 162.0, 160.0, 162.0, 162.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 192.0, 76.0, 74.0, 76.0, 76.0, 172.0, 75.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 160.0, 82.0, 83.0, 83.0, 142.0, 83.0, 83.0, 146.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 49.0, 49.0, 52.0, 51.0, 50.0, 51.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 68.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 75.0, 79.0, 72.0, 74.0, 74.0, 77.0, 71.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 119.0, 120.0, 125.0, 128.0, 121.0, 117.0, 154.0, 127.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 154.0, 153.0, 151.0, 152.0, 153.0, 151.0, 152.0, 151.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 62.0, 63.0, 65.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1499.4, "alertThreshold": 2.0}]} 06:30:38 INFO - Return code: 0 06:30:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:30:38 INFO - # TBPL SUCCESS # 06:30:38 INFO - Running post-action listener: _resource_record_post_action 06:30:38 INFO - [mozharness: 2016-10-18 13:30:38.238032Z] Finished run-tests step (success) 06:30:38 INFO - Running post-run listener: _resource_record_post_run 06:30:38 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290750464; Read time: 0; Write time: 156912 06:30:38 INFO - TinderboxPrint: CPU usage
13.0% 06:30:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:30:38 INFO - TinderboxPrint: I/O write bytes / time
290,750,464 / 156,912 06:30:38 INFO - TinderboxPrint: CPU idle
8,253.8 (87.0%) 06:30:38 INFO - TinderboxPrint: CPU user
1,183.5 (12.5%) 06:30:38 INFO - TinderboxPrint: Swap in / out
0 / 0 06:30:38 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71385088; Read time: 0; Write time: 49200 06:30:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 219365376; Read time: 0; Write time: 107712 06:30:38 INFO - Running post-run listener: _upload_blobber_files 06:30:38 INFO - Blob upload gear active. 06:30:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:30:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:30:38 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:30:38 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:30:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:30:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:42 INFO - (blobuploader) - INFO - Done attempting. 06:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:43 INFO - (blobuploader) - INFO - Done attempting. 06:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:44 INFO - (blobuploader) - INFO - Done attempting. 06:30:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:30:44 INFO - Return code: 0 06:30:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:30:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:30:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2084b51c7a77edb7f2eabf7b6c8fa0911dffc594a7075b88b46fa9f08b78a2f5b6359476273e59e71ca6090ce145ea4542f451ebf9584d471a2e778fbab863a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec5cc15ad2af0087f71bbb418c4b5897166585fd2b0bbf49a94465623e12ca78e9a1e3e3c7df677637961eb9f3d91bbbb42afe1f04c6c8c69f9f71ebb1c3c905", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d81b601dfc4f4b14ad792a208aa1d29adc9150b5e9a452389dcbc10aeaf6b1a42107cbacc485fa9bba765ad3c2f94723d78eb881e0125a131191c44349db56f5"} 06:30:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:30:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:30:44 INFO - Contents: 06:30:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2084b51c7a77edb7f2eabf7b6c8fa0911dffc594a7075b88b46fa9f08b78a2f5b6359476273e59e71ca6090ce145ea4542f451ebf9584d471a2e778fbab863a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec5cc15ad2af0087f71bbb418c4b5897166585fd2b0bbf49a94465623e12ca78e9a1e3e3c7df677637961eb9f3d91bbbb42afe1f04c6c8c69f9f71ebb1c3c905", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d81b601dfc4f4b14ad792a208aa1d29adc9150b5e9a452389dcbc10aeaf6b1a42107cbacc485fa9bba765ad3c2f94723d78eb881e0125a131191c44349db56f5"} 06:30:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:30:44 INFO - Copying logs to upload dir... 06:30:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:30:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.399919 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-18 06:30:43.706864) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:43.710169) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2084b51c7a77edb7f2eabf7b6c8fa0911dffc594a7075b88b46fa9f08b78a2f5b6359476273e59e71ca6090ce145ea4542f451ebf9584d471a2e778fbab863a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec5cc15ad2af0087f71bbb418c4b5897166585fd2b0bbf49a94465623e12ca78e9a1e3e3c7df677637961eb9f3d91bbbb42afe1f04c6c8c69f9f71ebb1c3c905", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d81b601dfc4f4b14ad792a208aa1d29adc9150b5e9a452389dcbc10aeaf6b1a42107cbacc485fa9bba765ad3c2f94723d78eb881e0125a131191c44349db56f5"} build_url:https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2084b51c7a77edb7f2eabf7b6c8fa0911dffc594a7075b88b46fa9f08b78a2f5b6359476273e59e71ca6090ce145ea4542f451ebf9584d471a2e778fbab863a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec5cc15ad2af0087f71bbb418c4b5897166585fd2b0bbf49a94465623e12ca78e9a1e3e3c7df677637961eb9f3d91bbbb42afe1f04c6c8c69f9f71ebb1c3c905", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d81b601dfc4f4b14ad792a208aa1d29adc9150b5e9a452389dcbc10aeaf6b1a42107cbacc485fa9bba765ad3c2f94723d78eb881e0125a131191c44349db56f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:43.738509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:43.738918) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476792407.866097-575333238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:43.820551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 06:30:43.824061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 06:30:43.824420) ========= ========= Total master_lag: 0.20 =========