builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1475259188.04 results: success (0) buildid: 20160930081719 builduid: 71153249fdcf4368bf4f9eae87a7ad6b revision: 01908230207066c3d650d963774b4d803a9516d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.036689) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.037521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.037976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.086027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.086427) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 11:13:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.6M=0s 2016-09-30 11:13:09 (69.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.225772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.226434) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015391 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.280875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:08.281243) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01908230207066c3d650d963774b4d803a9516d3 --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 01908230207066c3d650d963774b4d803a9516d3 --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=a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 11:13:09,874 truncating revision to first 12 chars 2016-09-30 11:13:09,874 Setting DEBUG logging. 2016-09-30 11:13:09,874 attempt 1/10 2016-09-30 11:13:09,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/019082302070?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 11:13:10,495 unpacking tar archive at: mozilla-beta-019082302070/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943612 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:09.238524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:09.238906) ========= script_repo_revision: 01908230207066c3d650d963774b4d803a9516d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:09.239391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:09.239735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 11:13:09.249388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-09-30 11:13:09.249727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:10 INFO - MultiFileLogger online at 20160930 11:13:10 in /builds/slave/test 11:13:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:13:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:13:10 INFO - {'append_to_log': False, 11:13:10 INFO - 'base_work_dir': '/builds/slave/test', 11:13:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:13:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:13:10 INFO - 'branch': 'Mozilla-Beta', 11:13:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:10 INFO - 'config_files': ('talos/linux_config.py',), 11:13:10 INFO - 'default_actions': ('clobber', 11:13:10 INFO - 'read-buildbot-config', 11:13:10 INFO - 'download-and-extract', 11:13:10 INFO - 'populate-webroot', 11:13:10 INFO - 'create-virtualenv', 11:13:10 INFO - 'install', 11:13:10 INFO - 'run-tests'), 11:13:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:10 INFO - 'download_minidump_stackwalk': True, 11:13:10 INFO - 'download_symbols': 'ondemand', 11:13:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:13:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:13:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:13:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:13:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:10 INFO - 'installer_path': 'installer.exe', 11:13:10 INFO - 'log_level': 'info', 11:13:10 INFO - 'log_name': 'talos', 11:13:10 INFO - 'log_to_console': True, 11:13:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:10 INFO - 'opt_config_files': (), 11:13:10 INFO - 'pip_index': False, 11:13:10 INFO - 'sps_profile': False, 11:13:10 INFO - 'sps_profile_interval': 0, 11:13:10 INFO - 'suite': 'dromaeojs-e10s', 11:13:10 INFO - 'system_bits': '32', 11:13:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:10 INFO - 'title': 'talos-linux64-ix-064', 11:13:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:10 INFO - 'use_talos_json': True, 11:13:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:13:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:10 INFO - 'work_dir': 'build'} 11:13:10 INFO - [mozharness: 2016-09-30 18:13:10.935784Z] Running clobber step. 11:13:10 INFO - Running pre-action listener: _resource_record_pre_action 11:13:10 INFO - Running main action method: clobber 11:13:10 INFO - rmtree: /builds/slave/test/build 11:13:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:13:11 INFO - Running post-action listener: _resource_record_post_action 11:13:11 INFO - [mozharness: 2016-09-30 18:13:11.392936Z] Finished clobber step (success) 11:13:11 INFO - [mozharness: 2016-09-30 18:13:11.393037Z] Running read-buildbot-config step. 11:13:11 INFO - Running pre-action listener: _resource_record_pre_action 11:13:11 INFO - Running main action method: read_buildbot_config 11:13:11 INFO - Using buildbot properties: 11:13:11 INFO - { 11:13:11 INFO - "project": "", 11:13:11 INFO - "product": "firefox", 11:13:11 INFO - "script_repo_revision": "production", 11:13:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:13:11 INFO - "repository": "", 11:13:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:13:11 INFO - "buildid": "20160930081719", 11:13:11 INFO - "pgo_build": "True", 11:13:11 INFO - "basedir": "/builds/slave/test", 11:13:11 INFO - "buildnumber": 135, 11:13:11 INFO - "slavename": "talos-linux64-ix-064", 11:13:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:13:11 INFO - "platform": "ubuntu64_hw", 11:13:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:13:11 INFO - "branch": "mozilla-beta", 11:13:11 INFO - "repo_path": "releases/mozilla-beta", 11:13:11 INFO - "revision": "01908230207066c3d650d963774b4d803a9516d3", 11:13:11 INFO - "stage_platform": "linux64-pgo", 11:13:11 INFO - "builduid": "71153249fdcf4368bf4f9eae87a7ad6b", 11:13:11 INFO - "slavebuilddir": "test" 11:13:11 INFO - } 11:13:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 11:13:11 INFO - Running post-action listener: _resource_record_post_action 11:13:11 INFO - [mozharness: 2016-09-30 18:13:11.395526Z] Finished read-buildbot-config step (success) 11:13:11 INFO - [mozharness: 2016-09-30 18:13:11.395632Z] Running download-and-extract step. 11:13:11 INFO - Running pre-action listener: _resource_record_pre_action 11:13:11 INFO - Running main action method: download_and_extract 11:13:11 INFO - mkdir: /builds/slave/test/build/tests 11:13:11 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')]} 11:13:11 INFO - https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:13:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:13:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:13:11 INFO - retry: Failed, sleeping 30 seconds before retrying 11:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:13:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:13:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:13:41 INFO - retry: Failed, sleeping 60 seconds before retrying 11:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:14:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:14:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:14:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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! 11:14:41 INFO - Caught exception: HTTP Error 404: Not Found 11:14:41 INFO - Caught exception: HTTP Error 404: Not Found 11:14:41 INFO - Caught exception: HTTP Error 404: Not Found 11:14:41 INFO - trying https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:14:41 INFO - Downloading https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:14:42 INFO - Downloaded 1327 bytes. 11:14:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:14:42 INFO - Using the following test package requirements: 11:14:42 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 11:14:42 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:42 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 11:14:42 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'jsshell-linux-x86_64.zip'], 11:14:42 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:42 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 11:14:42 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 11:14:42 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 11:14:42 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:42 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:14:42 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:42 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:42 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')]} 11:14:42 INFO - https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:14:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:14:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:14:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:14:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:14:42 INFO - retry: Failed, sleeping 30 seconds before retrying 11:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:15:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:15:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:15:12 INFO - retry: Failed, sleeping 60 seconds before retrying 11:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:16:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:16:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:16:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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! 11:16:12 INFO - Caught exception: HTTP Error 404: Not Found 11:16:12 INFO - Caught exception: HTTP Error 404: Not Found 11:16:12 INFO - Caught exception: HTTP Error 404: Not Found 11:16:12 INFO - trying https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:16:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:16:13 INFO - Downloaded 21773994 bytes. 11:16:13 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'] 11:16:13 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 11:16:14 INFO - Return code: 0 11:16:14 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 11:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:14 INFO - https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:16:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:16:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:16:14 INFO - retry: Failed, sleeping 30 seconds before retrying 11:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:16:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:16:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:16:44 INFO - retry: Failed, sleeping 60 seconds before retrying 11:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:17:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:17:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:17:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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! 11:17:44 INFO - Caught exception: HTTP Error 404: Not Found 11:17:44 INFO - Caught exception: HTTP Error 404: Not Found 11:17:44 INFO - Caught exception: HTTP Error 404: Not Found 11:17:44 INFO - trying https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:17:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:17:45 INFO - Downloaded 21773994 bytes. 11:17:45 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'] 11:17:45 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 11:17:47 INFO - Return code: 0 11:17: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')]} 11:17:47 INFO - https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:17:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:17:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:17:47 INFO - retry: Failed, sleeping 30 seconds before retrying 11:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:18:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:18:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:18:17 INFO - retry: Failed, sleeping 60 seconds before retrying 11:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:19:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:19:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:19:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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! 11:19:17 INFO - Caught exception: HTTP Error 404: Not Found 11:19:17 INFO - Caught exception: HTTP Error 404: Not Found 11:19:17 INFO - Caught exception: HTTP Error 404: Not Found 11:19:17 INFO - trying https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:19:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:19:17 INFO - Downloaded 14413740 bytes. 11:19:17 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'] 11:19:17 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 11:19:18 INFO - Return code: 0 11:19: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')]} 11:19:18 INFO - https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:19:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:19:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:19:18 INFO - retry: Failed, sleeping 30 seconds before retrying 11:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:19:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:19:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:19:48 INFO - retry: Failed, sleeping 60 seconds before retrying 11:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:20:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:20:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:20:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYb56i9iRyysrPrVKo6zJg/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! 11:20:48 INFO - Caught exception: HTTP Error 404: Not Found 11:20:48 INFO - Caught exception: HTTP Error 404: Not Found 11:20:48 INFO - Caught exception: HTTP Error 404: Not Found 11:20:48 INFO - trying https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:20:48 INFO - Downloading https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/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 11:20:49 INFO - Downloaded 56810683 bytes. 11:20:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:20:49 INFO - mkdir: /builds/slave/test/properties 11:20:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:49 INFO - Contents: 11:20:49 INFO - build_url:https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:20:50 INFO - Running post-action listener: _resource_record_post_action 11:20:50 INFO - Running post-action listener: set_extra_try_arguments 11:20:50 INFO - [mozharness: 2016-09-30 18:20:50.095125Z] Finished download-and-extract step (success) 11:20:50 INFO - [mozharness: 2016-09-30 18:20:50.095358Z] Running populate-webroot step. 11:20:50 INFO - Running pre-action listener: _resource_record_pre_action 11:20:50 INFO - Running main action method: populate_webroot 11:20:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:50 INFO - '--tppagecycles', 11:20:50 INFO - '7'], 11:20:50 INFO - 'tests': ['tsvgm']}}, 11:20:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['damp', 'tps']}, 11:20:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'tests': ['damp', 'tps']}, 11:20:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['dromaeo_dom']}, 11:20:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['basic_compositor_video']}, 11:20:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:20:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['a11yr', 11:20:50 INFO - 'ts_paint', 11:20:50 INFO - 'tpaint', 11:20:50 INFO - 'sessionrestore', 11:20:50 INFO - 'sessionrestore_no_auto_restore', 11:20:50 INFO - 'tabpaint']}, 11:20:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:50 INFO - 'ts_paint', 11:20:50 INFO - 'tpaint', 11:20:50 INFO - 'sessionrestore', 11:20:50 INFO - 'sessionrestore_no_auto_restore', 11:20:50 INFO - 'tabpaint']}, 11:20:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:50 INFO - 'ts_paint', 11:20:50 INFO - 'tpaint', 11:20:50 INFO - 'sessionrestore', 11:20:50 INFO - 'sessionrestore_no_auto_restore', 11:20:50 INFO - 'tabpaint']}, 11:20:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:50 INFO - 'ts_paint', 11:20:50 INFO - 'tpaint', 11:20:50 INFO - 'sessionrestore', 11:20:50 INFO - 'sessionrestore_no_auto_restore', 11:20:50 INFO - 'tabpaint']}, 11:20:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['a11yr', 11:20:50 INFO - 'ts_paint', 11:20:50 INFO - 'tpaint', 11:20:50 INFO - 'sessionrestore', 11:20:50 INFO - 'sessionrestore_no_auto_restore', 11:20:50 INFO - 'tabpaint']}, 11:20:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['a11yr', 11:20:50 INFO - 'ts_paint', 11:20:50 INFO - 'tpaint', 11:20:50 INFO - 'sessionrestore', 11:20:50 INFO - 'sessionrestore_no_auto_restore', 11:20:50 INFO - 'tabpaint']}, 11:20:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['tsvgx', 11:20:50 INFO - 'tsvgr_opacity', 11:20:50 INFO - 'tart', 11:20:50 INFO - 'tscrollx', 11:20:50 INFO - 'cart']}, 11:20:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:50 INFO - 'tsvgr_opacity', 11:20:50 INFO - 'tart', 11:20:50 INFO - 'tscrollx', 11:20:50 INFO - 'cart']}, 11:20:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'talos_options': ['--disable-e10s'], 11:20:50 INFO - 'tests': ['tp5o']}, 11:20:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'tests': ['tp5o']}, 11:20:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'talos_options': ['--disable-e10s', 11:20:50 INFO - '--xperf_path', 11:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:50 INFO - 'tests': ['tp5n']}, 11:20:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:50 INFO - 'talos_options': ['--xperf_path', 11:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:50 INFO - 'tests': ['tp5n']}}, 11:20:50 INFO - 'talos.zip': {'path': '', 11:20:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:50 INFO - Running post-action listener: _resource_record_post_action 11:20:50 INFO - [mozharness: 2016-09-30 18:20:50.111336Z] Finished populate-webroot step (success) 11:20:50 INFO - [mozharness: 2016-09-30 18:20:50.111425Z] Running create-virtualenv step. 11:20:50 INFO - Running pre-action listener: _resource_record_pre_action 11:20:50 INFO - Running main action method: create_virtualenv 11:20:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:50 INFO - Using real prefix '/usr' 11:20:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:52 INFO - Installing pip.................done. 11:20:52 INFO - Return code: 0 11:20:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:52 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')]} 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:52 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')]} 11:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:52 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:52 INFO - Using env: {'DISPLAY': ':0', 11:20:52 INFO - 'HOME': '/home/cltbld', 11:20:52 INFO - 'LANG': 'en_US.UTF-8', 11:20:52 INFO - 'LANGUAGE': 'en_US:en', 11:20:52 INFO - 'LOGNAME': 'cltbld', 11:20:52 INFO - 'MAIL': '/var/mail/cltbld', 11:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:52 INFO - 'MOZ_NO_REMOTE': '1', 11:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:52 INFO - 'NO_EM_RESTART': '1', 11:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:52 INFO - 'PWD': '/builds/slave/test', 11:20:52 INFO - 'SHELL': '/bin/bash', 11:20:52 INFO - 'SHLVL': '1', 11:20:52 INFO - 'TERM': 'linux', 11:20:52 INFO - 'TMOUT': '86400', 11:20:52 INFO - 'USER': 'cltbld', 11:20:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:52 INFO - '_': '/tools/buildbot/bin/python'} 11:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:20:52 INFO - Cleaning up... 11:20:52 INFO - Return code: 0 11:20:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:52 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')]} 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:52 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')]} 11:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:52 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:52 INFO - Using env: {'DISPLAY': ':0', 11:20:52 INFO - 'HOME': '/home/cltbld', 11:20:52 INFO - 'LANG': 'en_US.UTF-8', 11:20:52 INFO - 'LANGUAGE': 'en_US:en', 11:20:52 INFO - 'LOGNAME': 'cltbld', 11:20:52 INFO - 'MAIL': '/var/mail/cltbld', 11:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:52 INFO - 'MOZ_NO_REMOTE': '1', 11:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:52 INFO - 'NO_EM_RESTART': '1', 11:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:52 INFO - 'PWD': '/builds/slave/test', 11:20:52 INFO - 'SHELL': '/bin/bash', 11:20:52 INFO - 'SHLVL': '1', 11:20:52 INFO - 'TERM': 'linux', 11:20:52 INFO - 'TMOUT': '86400', 11:20:52 INFO - 'USER': 'cltbld', 11:20:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:52 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Downloading/unpacking psutil>=3.1.1 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:55 INFO - Installing collected packages: psutil 11:20:55 INFO - Running setup.py install for psutil 11:20:55 INFO - building 'psutil._psutil_linux' extension 11:20:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:55 INFO - building 'psutil._psutil_posix' extension 11:20:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:55 INFO - Successfully installed psutil 11:20:55 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:55 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')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 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')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:57 INFO - Installing collected packages: mozsystemmonitor 11:20:57 INFO - Running setup.py install for mozsystemmonitor 11:20:57 INFO - Successfully installed mozsystemmonitor 11:20:57 INFO - Cleaning up... 11:20:57 INFO - Return code: 0 11:20:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:57 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')]} 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:57 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')]} 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:57 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:57 INFO - Using env: {'DISPLAY': ':0', 11:20:57 INFO - 'HOME': '/home/cltbld', 11:20:57 INFO - 'LANG': 'en_US.UTF-8', 11:20:57 INFO - 'LANGUAGE': 'en_US:en', 11:20:57 INFO - 'LOGNAME': 'cltbld', 11:20:57 INFO - 'MAIL': '/var/mail/cltbld', 11:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:57 INFO - 'MOZ_NO_REMOTE': '1', 11:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:57 INFO - 'NO_EM_RESTART': '1', 11:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:57 INFO - 'PWD': '/builds/slave/test', 11:20:57 INFO - 'SHELL': '/bin/bash', 11:20:57 INFO - 'SHLVL': '1', 11:20:57 INFO - 'TERM': 'linux', 11:20:57 INFO - 'TMOUT': '86400', 11:20:57 INFO - 'USER': 'cltbld', 11:20:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:57 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:00 INFO - warning: no files found matching '*.txt' 11:21:00 INFO - no previously-included directories found matching 'build' 11:21:00 INFO - no previously-included directories found matching 'dist' 11:21:00 INFO - no previously-included directories found matching '.git*' 11:21:00 INFO - Installing collected packages: jsonschema, functools32 11:21:00 INFO - Running setup.py install for functools32 11:21:00 INFO - warning: no files found matching '*.txt' 11:21:00 INFO - no previously-included directories found matching 'build' 11:21:00 INFO - no previously-included directories found matching 'dist' 11:21:00 INFO - no previously-included directories found matching '.git*' 11:21:00 INFO - Successfully installed jsonschema functools32 11:21:00 INFO - Cleaning up... 11:21:00 INFO - Return code: 0 11:21:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:00 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:00 INFO - Cleaning up... 11:21:00 INFO - Return code: 0 11:21:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:00 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Downloading docopt-0.6.1.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:03 INFO - Running setup.py install for blobuploader 11:21:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:03 INFO - Running setup.py install for requests 11:21:04 INFO - Running setup.py install for docopt 11:21:04 INFO - Successfully installed blobuploader requests docopt 11:21:04 INFO - Cleaning up... 11:21:04 INFO - Return code: 0 11:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:04 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:04 INFO - Using env: {'DISPLAY': ':0', 11:21:04 INFO - 'HOME': '/home/cltbld', 11:21:04 INFO - 'LANG': 'en_US.UTF-8', 11:21:04 INFO - 'LANGUAGE': 'en_US:en', 11:21:04 INFO - 'LOGNAME': 'cltbld', 11:21:04 INFO - 'MAIL': '/var/mail/cltbld', 11:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:04 INFO - 'MOZ_NO_REMOTE': '1', 11:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:04 INFO - 'NO_EM_RESTART': '1', 11:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:04 INFO - 'PWD': '/builds/slave/test', 11:21:04 INFO - 'SHELL': '/bin/bash', 11:21:04 INFO - 'SHLVL': '1', 11:21:04 INFO - 'TERM': 'linux', 11:21:04 INFO - 'TMOUT': '86400', 11:21:04 INFO - 'USER': 'cltbld', 11:21:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:04 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:04 INFO - Running setup.py (path:/tmp/pip-JAJ9Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:04 INFO - Running setup.py (path:/tmp/pip-b7Q7vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:04 INFO - Running setup.py (path:/tmp/pip-QWJUjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:04 INFO - Running setup.py (path:/tmp/pip-8AyxOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:04 INFO - Running setup.py (path:/tmp/pip-OHWb7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:04 INFO - Running setup.py (path:/tmp/pip-Kjz78n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:04 INFO - Running setup.py (path:/tmp/pip-OylBiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:05 INFO - Running setup.py (path:/tmp/pip-XWolki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:05 INFO - Running setup.py (path:/tmp/pip-4hf2WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:05 INFO - Running setup.py (path:/tmp/pip-hq1Qb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:05 INFO - Running setup.py (path:/tmp/pip-yt_BoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:05 INFO - Running setup.py (path:/tmp/pip-PwHKQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:05 INFO - Running setup.py (path:/tmp/pip-9qba9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:05 INFO - Running setup.py (path:/tmp/pip-q79st_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:05 INFO - Running setup.py (path:/tmp/pip-t1595f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:05 INFO - Running setup.py (path:/tmp/pip-j0Pud8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:05 INFO - Running setup.py (path:/tmp/pip-agNtBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:05 INFO - Running setup.py install for manifestparser 11:21:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Running setup.py install for mozcrash 11:21:05 INFO - Running setup.py install for mozdebug 11:21:06 INFO - Running setup.py install for mozdevice 11:21:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozfile 11:21:06 INFO - Running setup.py install for mozhttpd 11:21:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozinfo 11:21:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozInstall 11:21:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozleak 11:21:06 INFO - Running setup.py install for mozlog 11:21:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for moznetwork 11:21:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozprocess 11:21:06 INFO - Running setup.py install for mozprofile 11:21:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Running setup.py install for mozrunner 11:21:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Running setup.py install for mozscreenshot 11:21:07 INFO - Running setup.py install for moztest 11:21:07 INFO - Running setup.py install for mozversion 11:21:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:07 INFO - Cleaning up... 11:21:07 INFO - Return code: 0 11:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:07 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:07 INFO - Using env: {'DISPLAY': ':0', 11:21:07 INFO - 'HOME': '/home/cltbld', 11:21:07 INFO - 'LANG': 'en_US.UTF-8', 11:21:07 INFO - 'LANGUAGE': 'en_US:en', 11:21:07 INFO - 'LOGNAME': 'cltbld', 11:21:07 INFO - 'MAIL': '/var/mail/cltbld', 11:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:07 INFO - 'MOZ_NO_REMOTE': '1', 11:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:07 INFO - 'NO_EM_RESTART': '1', 11:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:07 INFO - 'PWD': '/builds/slave/test', 11:21:07 INFO - 'SHELL': '/bin/bash', 11:21:07 INFO - 'SHLVL': '1', 11:21:07 INFO - 'TERM': 'linux', 11:21:07 INFO - 'TMOUT': '86400', 11:21:07 INFO - 'USER': 'cltbld', 11:21:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:07 INFO - '_': '/tools/buildbot/bin/python'} 11:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:07 INFO - Running setup.py (path:/tmp/pip-gTGWOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:07 INFO - Running setup.py (path:/tmp/pip-I8d_Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:07 INFO - Running setup.py (path:/tmp/pip-1oFZFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:07 INFO - Running setup.py (path:/tmp/pip-ociGvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:08 INFO - Running setup.py (path:/tmp/pip-Hl8hGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 INFO - Running setup.py (path:/tmp/pip-i5Y7Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 INFO - Running setup.py (path:/tmp/pip-60NtOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:08 INFO - Running setup.py (path:/tmp/pip-aORaHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:08 INFO - Running setup.py (path:/tmp/pip-pVOrhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:08 INFO - Running setup.py (path:/tmp/pip-kNrUOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:08 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)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:08 INFO - Running setup.py (path:/tmp/pip-XXvZRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:08 INFO - Running setup.py (path:/tmp/pip-m4l4wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:08 INFO - Running setup.py (path:/tmp/pip-mZsGP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:08 INFO - Running setup.py (path:/tmp/pip-bmDQ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:08 INFO - Running setup.py (path:/tmp/pip-Bd5NTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:08 INFO - Running setup.py (path:/tmp/pip-Fib4I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:08 INFO - Running setup.py (path:/tmp/pip-LehB2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:10 INFO - Downloading blessings-1.6.tar.gz 11:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:10 INFO - Installing collected packages: blessings 11:21:10 INFO - Running setup.py install for blessings 11:21:11 INFO - Successfully installed blessings 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:11 INFO - Reading from file tmpfile_stdout 11:21:11 INFO - Current package versions: 11:21:11 INFO - argparse == 1.2.1 11:21:11 INFO - blessings == 1.6 11:21:11 INFO - blobuploader == 1.2.4 11:21:11 INFO - docopt == 0.6.1 11:21:11 INFO - functools32 == 3.2.3-2 11:21:11 INFO - jsonschema == 2.5.1 11:21:11 INFO - manifestparser == 1.1 11:21:11 INFO - mozInstall == 1.12 11:21:11 INFO - mozcrash == 0.17 11:21:11 INFO - mozdebug == 0.1 11:21:11 INFO - mozdevice == 0.48 11:21:11 INFO - mozfile == 1.2 11:21:11 INFO - mozhttpd == 0.7 11:21:11 INFO - mozinfo == 0.9 11:21:11 INFO - mozleak == 0.1 11:21:11 INFO - mozlog == 3.3 11:21:11 INFO - moznetwork == 0.27 11:21:11 INFO - mozprocess == 0.23 11:21:11 INFO - mozprofile == 0.28 11:21:11 INFO - mozrunner == 6.12 11:21:11 INFO - mozscreenshot == 0.1 11:21:11 INFO - mozsystemmonitor == 0.3 11:21:11 INFO - moztest == 0.7 11:21:11 INFO - mozversion == 1.4 11:21:11 INFO - psutil == 3.1.1 11:21:11 INFO - requests == 1.2.3 11:21:11 INFO - wsgiref == 0.1.2 11:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:11 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')]} 11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:11 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')]} 11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:11 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:11 INFO - Using env: {'DISPLAY': ':0', 11:21:11 INFO - 'HOME': '/home/cltbld', 11:21:11 INFO - 'LANG': 'en_US.UTF-8', 11:21:11 INFO - 'LANGUAGE': 'en_US:en', 11:21:11 INFO - 'LOGNAME': 'cltbld', 11:21:11 INFO - 'MAIL': '/var/mail/cltbld', 11:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:11 INFO - 'MOZ_NO_REMOTE': '1', 11:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:11 INFO - 'NO_EM_RESTART': '1', 11:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:11 INFO - 'PWD': '/builds/slave/test', 11:21:11 INFO - 'SHELL': '/bin/bash', 11:21:11 INFO - 'SHLVL': '1', 11:21:11 INFO - 'TERM': 'linux', 11:21:11 INFO - 'TMOUT': '86400', 11:21:11 INFO - 'USER': 'cltbld', 11:21:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:11 INFO - '_': '/tools/buildbot/bin/python'} 11:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:11 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')]} 11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:11 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')]} 11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:11 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 0x146c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:11 INFO - Using env: {'DISPLAY': ':0', 11:21:11 INFO - 'HOME': '/home/cltbld', 11:21:11 INFO - 'LANG': 'en_US.UTF-8', 11:21:11 INFO - 'LANGUAGE': 'en_US:en', 11:21:11 INFO - 'LOGNAME': 'cltbld', 11:21:11 INFO - 'MAIL': '/var/mail/cltbld', 11:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:11 INFO - 'MOZ_NO_REMOTE': '1', 11:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:11 INFO - 'NO_EM_RESTART': '1', 11:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:11 INFO - 'PWD': '/builds/slave/test', 11:21:11 INFO - 'SHELL': '/bin/bash', 11:21:11 INFO - 'SHLVL': '1', 11:21:11 INFO - 'TERM': 'linux', 11:21:11 INFO - 'TMOUT': '86400', 11:21:11 INFO - 'USER': 'cltbld', 11:21:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:11 INFO - '_': '/tools/buildbot/bin/python'} 11:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Running post-action listener: _resource_record_post_action 11:21:11 INFO - Running post-action listener: _start_resource_monitoring 11:21:11 INFO - Starting resource monitoring. 11:21:11 INFO - [mozharness: 2016-09-30 18:21:11.799818Z] Finished create-virtualenv step (success) 11:21:11 INFO - [mozharness: 2016-09-30 18:21:11.800246Z] Running install step. 11:21:11 INFO - Running pre-action listener: _resource_record_pre_action 11:21:11 INFO - Running main action method: install 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:12 INFO - Reading from file tmpfile_stdout 11:21:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:12 INFO - Reading from file tmpfile_stdout 11:21:12 INFO - Output received: 11:21:12 INFO - Usage: mozinstall [options] installer 11:21:12 INFO - Options: 11:21:12 INFO - -h, --help show this help message and exit 11:21:12 INFO - -d DEST, --destination=DEST 11:21:12 INFO - Directory to install application into. [default: 11:21:12 INFO - "/builds/slave/test"] 11:21:12 INFO - --app=APP Application being installed. [default: firefox] 11:21:12 INFO - mkdir: /builds/slave/test/build/application 11:21:12 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'] 11:21:12 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 11:21:25 INFO - Reading from file tmpfile_stdout 11:21:25 INFO - Output received: 11:21:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:25 INFO - Running post-action listener: _resource_record_post_action 11:21:25 INFO - [mozharness: 2016-09-30 18:21:25.580668Z] Finished install step (success) 11:21:25 INFO - [mozharness: 2016-09-30 18:21:25.580945Z] Running run-tests step. 11:21:25 INFO - Running pre-action listener: _resource_record_pre_action 11:21:25 INFO - Running main action method: run_tests 11:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:25 INFO - Python 2.7.3 11:21:25 INFO - Return code: 0 11:21:25 INFO - grabbing minidump binary from tooltool 11:21:25 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')]} 11:21:25 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 0x172a570>, '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 0x172b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:25 INFO - Return code: 0 11:21:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:25 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:25 INFO - Using env: {'DISPLAY': ':0', 11:21:25 INFO - 'HOME': '/home/cltbld', 11:21:25 INFO - 'LANG': 'en_US.UTF-8', 11:21:25 INFO - 'LANGUAGE': 'en_US:en', 11:21:25 INFO - 'LOGNAME': 'cltbld', 11:21:25 INFO - 'MAIL': '/var/mail/cltbld', 11:21:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:25 INFO - 'MOZ_NO_REMOTE': '1', 11:21:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:25 INFO - 'NO_EM_RESTART': '1', 11:21:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:25 INFO - 'PWD': '/builds/slave/test', 11:21:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:25 INFO - 'SHELL': '/bin/bash', 11:21:25 INFO - 'SHLVL': '1', 11:21:25 INFO - 'TERM': 'linux', 11:21:25 INFO - 'TMOUT': '86400', 11:21:25 INFO - 'USER': 'cltbld', 11:21:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999', 11:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:25 INFO - '_': '/tools/buildbot/bin/python'} 11:21:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:25 INFO - mozversion application_buildid: 20160930081719 11:21:25 INFO - mozversion application_changeset: 01908230207066c3d650d963774b4d803a9516d3 11:21:25 INFO - mozversion application_display_name: Firefox 11:21:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:25 INFO - mozversion application_name: Firefox 11:21:25 INFO - mozversion application_remotingname: firefox 11:21:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:25 INFO - mozversion application_vendor: Mozilla 11:21:25 INFO - mozversion application_version: 50.0 11:21:25 INFO - mozversion platform_buildid: 20160930081719 11:21:25 INFO - mozversion platform_changeset: 01908230207066c3d650d963774b4d803a9516d3 11:21:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:25 INFO - mozversion platform_version: 50.0 11:21:25 INFO - using testdate: 1475259685 11:21:25 INFO - actual date: 1475259685 11:21:25 INFO - starting webserver on 'localhost:36262' 11:21:25 INFO - SUITE-START | Running 2 tests 11:21:25 INFO - TEST-START | dromaeo_css 11:21:25 INFO - operating with platform_type : linux_ 11:21:25 INFO - Initialising browser for dromaeo_css test... 11:21:25 INFO - TEST-INFO | started process 29169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwIszId/profile http://localhost:36262/getInfo.html) 11:21:30 INFO - PROCESS | 29169 | __metrics Screen width/height:1600/1200 11:21:30 INFO - PROCESS | 29169 | colorDepth:24 11:21:30 INFO - PROCESS | 29169 | Browser inner width/height: 1024/697 11:21:30 INFO - PROCESS | 29169 | __metrics 11:21:31 ERROR - PROCESS | 29169 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:21:32 INFO - TEST-INFO | 29169: exit 0 11:21:32 INFO - Browser initialized. 11:21:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:32 INFO - TEST-INFO | started process 29296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwIszId/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:44 INFO - PROCESS | 29296 | RSS: Main: 149917696 11:21:44 INFO - PROCESS | 29296 | 11:22:33 INFO - PROCESS | 29296 | 1475259753800 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:24:42 INFO - PROCESS | 29296 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36262/tests/dromaeo/cssquery-ext.html) 11:24:43 INFO - PROCESS | 29296 | RSS: Main: 157822976 11:24:43 INFO - PROCESS | 29296 | 11:27:45 INFO - PROCESS | 29296 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-ext.html (next: http://localhost:36262/tests/dromaeo/cssquery-jquery.html) 11:27:45 INFO - PROCESS | 29296 | RSS: Main: 155320320 11:27:45 INFO - PROCESS | 29296 | 11:30:47 INFO - PROCESS | 29296 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36262/tests/dromaeo/cssquery-mootools.html) 11:30:48 INFO - PROCESS | 29296 | RSS: Main: 154533888 11:30:48 INFO - PROCESS | 29296 | 11:33:50 INFO - PROCESS | 29296 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36262/tests/dromaeo/cssquery-prototype.html) 11:33:50 INFO - PROCESS | 29296 | RSS: Main: 155975680 11:33:50 INFO - PROCESS | 29296 | 11:36:53 INFO - PROCESS | 29296 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36262/tests/dromaeo/cssquery-yui.html) 11:36:53 INFO - PROCESS | 29296 | RSS: Main: 157229056 11:36:53 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-yui.html (next: http://localhost:36262/tests/dromaeo/cssquery-dojo.html) 11:39:56 INFO - PROCESS | 29296 | RSS: Main: 157093888 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | __start_tp_report 11:39:56 INFO - PROCESS | 29296 | _x_x_mozilla_page_load 11:39:56 INFO - PROCESS | 29296 | _x_x_mozilla_page_load_details 11:39:56 INFO - PROCESS | 29296 | |i|pagename|runs| 11:39:56 INFO - PROCESS | 29296 | |0;dojo.html;3241.5623890774746;3261.461858793299;3270.362279355526;3287.260366417555;3288.2930170013474;5686.658800471974;5734.598578099534;5748.827535173947;5761.827145185641;5763.625364351315;5672.971635141829;5702.087665973445;5734.713264336788;5738.598298119123;5783.21926539917;5148.485151484859;5195.714235717034;5197.896042079156;5226.477352264762;5238.973805130969;5260.447652996438;5262.236975638531;5263.842084737464;5265.7893684252585;5294.364676238857;5047.596192304607;5112.284280200774;5240.633155679085;5240.633155679104;5246.414186925285;5166.354205724285;5244.763985620656;5272.156454967187;5279.102552566073;5313.096773548467;5187.533122019036;5233.345831771028;5234.81678141267;5242.475752424765;5243.239730239132;5472.1244600864065;5537;5680.4319568042865;5733.426657334275;5800.651960882318;6023.397660233985;6113.476306051806;6117.431594453911;6122.784715471481;6123.893452428408;6149.200603921507;6151.323354431009;6155.107509411155;6156.815295541141;6158.107074474221;5614.101743721026;5675.971620141873;5752.309722833245;5754.856128596777;5789.536837053026;6181.474574661114;6308.3060863305;6312.368763123743;6313.621182729051;6317.1156038154695;6027.7287522061615;6041.305249896231;6074.757009719562;6074.878502429927;6076.969615151896;5929.288485381696;6066.545009124334;6091.177691011745;6132.356102609251;6160.815175544741;6048.092786082035;6138.235132557318;6148.44663980244;6153.600015999035;6155.446009859134;6141.6007959482495;6143.631382116998;6144.5084393248435;6148.661823599745;6162.044883043135;4536.432945881765;4641;4708.9058218835435;4720.976395118002;4736.5500277474275;4148.854790082332;4194.643455306333;4195.391668208093;4224.725392849455;4233.724807887477;5894.322152952465;5944.7027648617395;5950.553708471795;5963.582549221513;5987.161797348374;5936.168936348915;6139.508839292846;6238.937610623926;6255.843603909848;6263.311035786151;5921.526277897758;5926.970365148147;5976.432238937294;5985.22192115031;6017.69911504423;5304.787808487617;5339.092354299778;5343.973280133652;5348.03735327637;5381.4349493303425;6124.258880972529;6145.740123274718;6172.783952561639;6432.51756118293;6435.034744788226;6127.571070025056;6145.446909778141;6154.969225153845;6164.938350616437;6176.166217560752;6241.282252541016;6327.651979141007;6331.303556608861;6343.397377249154;6346.714397852015;5756.65460072397;5942.227510423617;5982.0727787193055;6044.969775151096;6048.969755151196;6174.536909731878;6186.597871138361;6186.81439556814;6189.535784816247;6216.720247588779;6019.789307374221;6031.336552979081;6034.547408944434;6043.45608895184;6045.168959076215;5841.474267315962;5921.230240068763;5947.9405205949115;6008.369121242206;6028.5177185825905;5947.375525569752;5993.760249589967;5998.370171132143;5999.580029398075;6014.609050411709;6003.8198854034445;6017.969910150421;6066.696665166813;6077.118817771487;6077.574569780073;5726.541876649775;5884.235049443545;5953.7916172935475;5960.195373624505;5984.521238301013 11:39:56 INFO - PROCESS | 29296 | |1;ext.html;582.5747204540685;625.1841347042109;640.5100098424706;645.1097485470053;674.3694645506449;41913;46049;46663;46778.76610616947;46791.76604116974;45817.77091114548;46313.305300420434;46329.53670463294;46374.768126159404;46523.30215046777;9029.954850225757;9147.771305717344;9150.862737058917;9172.403793753385;9173.58718857653;9059.365844390895;9075.455472671627;9108.544572771334;9116.179543841054;9159.313051521129;9167.404118732262;9186.448813071238;9214.907850921472;9232.076792320782;9265;9153.313501487382;9213.12475314844;9221.400608960395;9224.169824715775;9227.584758685842;8984.505852178128;9005.32460065491;9020.81958360829;9036.096390360977;9037.638494460214;43952.3407148893;44356.556434435886;44670.77664611656;44683.329750053774;44729;4056.269871423143;4124.566920473367;4338.891527711801;4392.231359512072;4619.792109355053;35629.10927226814;35914;36814.631853681654;36858.447123293176;37587.62412375869;4210.642095421893;4216.451861258048;4243.554426785174;4394.296912494017;4412.426384570017;270980;271580;272060;273673;274939.999999998;64177.67911160414;64429;64661.35338646647;64911.67544162343;65022;68888;69247.3075269251;69273;69291.65354173197;69346.30653693399;17107.572310692332;18931.148098335332;19441;19454.805451945584;19928.50178745543;15280;15359.155246461552;15370.077795332316;15452.227388630523;15481.690366192614;21090.261840835497;21308.467288317606;21577.78422215789;21604;21719.67420488662;7833.186560592252;7984.560849153236;8026.317762990095;8049.919500805034;8129.1464396238725;1053.836655318427;1105.0993440346253;1121.4448847820381;1158.4092113022418;1158.9942050289694;33660.495092573634;33779.32441351159;33888.32223355519;34199.31601368009;34412.65587344095;1227.1593958138703;1234.6542967968983;1271.7138643805256;1290.8386451693539;1340.162398500937;17958.461246162635;18044.18801153951;18083;18104.547386315448;18125.546861328574;653773;655342;656212;658011;659880;64863.67568162129;65022.349776502575;65050.67474662596;65167;65176.67411662911;1445.5880074178808;1455.7961885336063;1501.5570406730042;1501.6546194375355;1513.7956375889335;33078.5038224422;33315.33369332648;33558;33850.83074584611;33955.15112122217;55925;68125.3187468119;69165.30834691589;69420.30579694138;69422.65288673525;512099;513628;513725;515154;516631;47911.76044119757;48017;48408.5159148404;49377;49622;52993;53747;53944.73027634837;54144;55658;44511.67025738757;44949.32576011297;45881;46937;48128.27807582819;44685;44738;45257.547424525335;46182.8800731044;46801.76599116983;39326.21347572975;44978.77510612426;46910;46913.53086469228;47783;44918.3262251073;47489.28766068581;47755.76122119367;47905.76047119742;49643.50356496389;35566.822165889;35778.64221357753;36043;36071.45892811557;36392.09019774527 11:39:56 INFO - PROCESS | 29296 | |2;jquery.html;413.7414116177389;430.7544699521274;432.3329656359598;434.93693414454907;438.67318847458637;18852;19709.60580788385;20380.59238815223;20437.795622043774;20530.38408847733;19414.611707765835;19822.306219282327;20123.597528049468;20500.589988200227;20694;5770.9422905770825;5975.223220981266;5988;5994.43052909975;5995.700214989255;5854.853628659296;5870.501007414354;5875.324337701155;5931.4068593140555;5948.048312270038;5760.193572899798;5823.592348535604;5843.561732870052;5867.501262392701;5879.588428809985;5816.680082595455;5828.795992140276;5853.619514731528;5907.261592300963;5909.8818023639715;5204.609654275907;5295.7881684732565;5317.494837990384;5320.17537281722;5332.386775520826;24324;24564.877175614187;24655.38361540976;24826.131085412104;25176.49647007068;2609.960850587243;2998.925026874324;3224.4679627861374;3299.0432774495607;3300.504924261356;16832.57918552034;16855.747163792552;17038.74441883373;17264.13679316029;17701.557461063447;2204.2175027865196;2215.9224427144973;2221;2234.7765223477686;2270.477790108268;82140.58929705372;82884;84831.5758421204;88662.5566872168;99753.5012324941;18329.90835045843;18817.247310107716;18918;18923.621527569372;19024.239030438905;33745.49381759275;33994;34418.655813441546;34489;34534;9720.368176068532;10899.67300980956;11176.161787865942;11270.323780573028;11442.398064271008;9505.5722492488;9584.808303833885;9607.759806004906;9663.082007209305;9682.806343873082;9200.723978280663;9311.161995420445;9422.717318480456;9536.5681751153;9547.904520954702;3560.412531932254;3700.908232071545;3704.833282502294;3745.700343972476;3817.4464702617965;970.5535453691381;1030.8093002794508;1056.114135834371;1072.7210925159516;1084.6691759013577;20726.896365518074;20804;20845.1661933524;20910.790892091187;20993.37019889406;1042.4214560918763;1049.611643691839;1084.7938891610727;1119.7536541960756;1141.9429028548539;11353.318800871974;11675.88324116748;11686.298822070534;11719.12106592009;11778.823317650242;506034;514191;518687.4065629648;524298;524902;94544;94630.0536994635;94861;95885.52057239809;97175;1068.9679309620724;1080.1089101491302;1097.8956999085074;1100.1803656276124;1123.4270522033657;18186.27254909789;18561.814381856548;18858.52853678669;18945.810541894403;19228.807711922702;30812.53781193239;41850.79074604608;41872.58127418809;41958.790206048776;42333.788331058146;58973.41026589679;59782.701086494286;60090;60891.39108609034;61019.69490152521;9074.773130671787;9102.453852768855;9180.806495155586;9223.76940576491;9237.769055773659;13044.413001415149;13882.861171388156;13892.583222503341;13922.303884805517;13938.09402388882;11766.52933882635;12177.634670959886;12205.145639805129;12219.938900305442;12485.438155282853;11057.668269951915;11138.777224455627;11250.493727782106;11509.769804604028;12023.398830058288;11598.710032248924;11803.114766392726;12000.879991199976;12322.81515777282;12429.440675169459;8833.690820821497;8990.190882820578;9008.054154313964;9049.77375565616;9256.074392560959;8899.866502002606;11547.249428787101;11675.591354302558;12189.207701499374;12212.938935305621 11:39:56 INFO - PROCESS | 29296 | |3;mootools.html;1532.8007359043322;1574.5984773882658;1733.306677329069;1826.6255417639386;1876.2870109358441;8576.95711521443;9330.673426430076;9544.665936692218;10090.646827361044;10108.393496390221;9500.144986951173;9766.902330976689;9790.755231119225;9807.852882206773;9853.507324633776;2509.4604659998145;2532.7467253274617;2551.5407226699185;2555.6933168019864;2569.743025697434;2501;2531.0635065025967;2535.759102885223;2538.5557527432625;2544;2465.4452748131707;2480.3675062858947;2523.5836087045614;2533.518631460026;2534.5057713745828;2454.6563481112657;2462.852228866274;2470.3206618180056;2498.1131698247223;2501.987490062538;2457.1891275879098;2462.372095115752;2463.027104293812;2467.370820440794;2489.191012920808;9861.063198996155;10027.097561219525;10037.749056273651;10051.69844904654;10096.69709908704;5576.832695019115;5720.771169153229;5723.855228954184;5729.512991395694;5753.137029445575;3479.68682818545;3551.733619978512;3624.5469316335457;3642.581103173116;3677.687396571295;1215.3194211241732;1251.5869762978195;1268.7716211082002;2250.2574150530286;2353.1293421434007;13881.722365552734;13928;13979.860201397958;14013;14031.43874245029;4808.35087263222;4863.95136048635;5002.224655178453;5032.3961124665275;5126.923346097361;10935.507902144423;10983.39591322485;11001.17491188164;11019.83470247947;11036.503357348938;5871.882562348729;5872.7357268923;5892.734826932799;5896.351401345849;5896.64620122794;5238.161894097002;5350.17072353778;5404.91892621611;5457.426970168154;5485.670859748348;4226.450561426995;4306.913861722811;4327.459067616548;4358.389825424443;4385.561443855653;1281.3849352310942;1286.5239861251398;1289.6582405662507;1293.534327642048;1293.909426340166;980.9852852207223;1069.8555694981233;1078.4499905048324;1085.6688709943544;1086.4839201379282;6233.719482623293;6418.069379939882;6489.643069631215;6497.415232629086;6562.409383155539;492.5665414435274;496.82859413502285;512.9897402051938;521.3066621393538;525.6478159633054;4354.56454354562;4428.3800267962515;4439.023414848728;4506.7070640408265;4558.316252562142;12038;12549.121561490609;12554.874451255553;12558.120931534704;12582.182158159874;11302.43487825622;11693.766124677459;11770.705732356588;11959.461824217757;12551.435185416678;9141.31440141992;9232.446053236961;9277.860832087525;9292.7676808079;9383.202427793578;6680.966595166993;6884.105066341343;6995.7201711932985;6996.440284777307;7040.859182816417;11324.6036388726;11540.596079137189;11559.07527397823;11674.066074714172;11692.766144677229;11437.59968401102;11550.48022838991;11605.129615278718;11651.941740291244;11708.88291117078;8163.959180204061;8327.54198519063;8423;8505.36209784281;8644;9535.189508891544;9580;9598.280128990215;9604.423734575948;9619.855702164334;8364.121767214356;8424.157584241526;8428.4942903426;8483.10927352619;8505.91494085076;8303.294219991127;8317.168283171635;8333.624986875726;8339.624716887633;8360.540170290693;7710;7809.375249980101;7898.921010789819;7916.247956444128;7937.523748575104;5355.812546560852;5395.325584301962;5414.337060702844;5502.284702988586;5537.529310008534;5542.445755424425;5542.556595472433;5553.8333849984565;5579.860503487445;5585.804496842591 11:39:56 INFO - PROCESS | 29296 | |4;prototype.html;358.22444407856983;360.0799956112134;360.6988164882321;361.87515307219;363.0958912308353;5746.425357464257;5755.712214389279;5766.596338256319;5770.394108618598;5771;5608.635438696482;5659.971700141494;5675.148727690848;5675.318961724589;5714.599978001542;4477.835762701705;4489.3939318192115;4497.730136191823;4498.257787465081;4501.572350626701;4508.143452743984;4513.458384993805;4539.319102134673;4543.65922555808;4551.089782043588;4471.7987690554;4512.16524942885;4521.502634710179;4525.185466616008;4546.47715512717;4297.452916949896;4431;4438.911221775563;4451.154280686659;4451.243288640939;3993.4009898515164;4007.458993035932;4009.719319647626;4010;4026.71812973092;5470.835874923719;5589;5594.496495315441;5594.748236329334;5600.85997850057;5022.974885125587;5121.129408000649;5127.410347810012;5137.434882162959;5151.278820965068;5919.5560332974765;5943.821685349447;5951.4048595140575;5968.37332080134;5983.401659833982;4332.220200363933;4425.734455932622;4436.268015777393;4437.2013037653205;4442.888927776799;6008.3390827009;6165.475934545569;6172.7530898764;6193.318734939108;6198.566100372976;4399.62603178727;4428.756418397019;4443.756058077622;4480.507144214133;4485.887852803706;4482.484514280834;4486.394336764495;4500.3249512573375;4506.639468842484;4524.47968483622;4916.188828843272;5119.334486516804;5129.846104616868;5153.201253805666;5161.509656582619;5995.312882577184;6004.6697431640805;6010.579259451883;6019.42815432542;6044.697765111727;1552.433361822949;1570.4895908829676;1575.7872687187312;1576.8961726791063;1582.3037863340323;950.8811398575178;980.5930538826307;984.1585444444896;986.8322385194534;1003.2976916158718;5230.215467679803;5248.553872920845;5259.76331065103;5264.394594621667;5270.657407268515;5420.810271640553;5483.725813709299;5491.9725401373535;5576.33084029919;5589.245451863946;5007.795011192839;5243.659162154448;5277.973610131925;5298.178782288752;5301.310829592206;2915.9271018224713;2934.82391056533;2937.6915423880614;2940.2355387599378;2972.7919045667027;5639.379668236491;5649.6327738696855;5651.321841379061;5660.547156227574;5667.498113000058;5939.851503712442;6330;6347.9051912868645;6358.395952384516;6384.361563843579;6416.871662566722;6420.5184611154355;6437.356264373525;6437.517186211053;6444.967775161188;6050.910836049553;6230.470410015199;6234.750609975732;6267.561270711007;6278.309385967631;6175.104609831459;6175.166352542529;6180.969095154495;6183.690815459119;6188.039654620956;6229.719662615284;6414.743410263537;6430.90674585331;6431.260405053479;6435.710393032418;4457.50967393593;4534.433195850519;4535.297028960516;4547.067851090453;4559.133764584718;6153.384661533811;6248.4376406123665;6290.21372328459;6347.650879201688;6383.872322553616;6074.757009719562;6104.8779024420155;6116.785912493041;6120.602160859708;6125.479334256638;5903.911441328298;6064.666443345658;6078.179445774764;6083;6098.664573448503;6035.758569657164;6076.392360764065;6084.665343405978;6091.847703807441;6119.938800612115;6125.938740612537;6135.8466038347615;6140.416660417253;6147.538934579835;6164.260288765377;5805.970970145122;5978.581499295007;5989.861926234002;6001.3698561652145;6002.189704389852 11:39:56 INFO - PROCESS | 29296 | |5;yui.html;857.4812238595649;866.190112245051;873.5239294584455;934.5280633280192;938.1697197979786;16461.50615481536;17479.650406991852;17658.911705441456;17659.20533575989;17723.11384430778;15612.2974466149;15623.921880390582;15663.843361566382;16391.754123688126;16802.411915582958;892.0366004714924;910.9635614575409;912.5710915869564;912.9957047248007;913.3058875254787;880.6301353431542;891.9821603567925;892.9107089291084;895.292718752185;896.7713233125544;945.2060269373725;945.8108378324329;947.2232769129316;947.6446332625266;947.7156852944123;943.2501161576529;945.1021529546958;946.597695979213;949.981000379992;950.6957773512479;696.7317582730634;697.4490152779298;697.5117417807555;697.8150790040643;700.7232143303366;15976.600584985468;15992.600184995468;16017.519474415787;16026.5993350166;16061.678766424606;16035.19824008795;16203.594910127224;16408.179591020402;16589;16640.33438662452;13076.08467407282;13245.47018119274;13445;13470;13532.391042403115;4139.482564679415;4146.274401979642;4166.500019997589;4199.622034016953;4272.594103560157;92005.53997230038;93669.53165234199;94201;94617;97613;12336.691582710504;12337.136400451882;12623;12709.93645031769;12771.233725976284;23976.40058998504;24071.638925416133;24221.152259670827;24231.273061808173;24404.633930491058;8650.653973841101;9174.495402752913;9305;9426.293028022927;9487.098725621056;4634.073185362941;4865.464798872121;5050;5190.351206099238;5212.113940630102;3739.9439008414897;3881.4177873318663;3888.6111388861455;3896.201278737852;3896.5129358830145;631.4695655649185;645.270843946347;649.2922714241499;673.1148539670415;673.727140508095;732.7472022152349;763.8052296664315;784.3411534311092;815.8205194857122;884.9557522123868;9817.214622830299;10378.688639340831;10436.739081523023;10482.633107841342;10909.454527273605;739.5008369350667;780.2938340801584;800.1438460846838;827.9526399105137;839.1482645115213;4414.580614841585;4447.510773814878;4537.705049171794;4538.160440318552;4577.313402989578;76189;77847.61076194583;101963;135123.32438337745;136805.3159734215;89936;105582;107100;108199;110094;93509;94032.0596794037;95269.52365238268;95687.52156239175;98143;9990.950045249727;10314.553804735062;10379.702537182851;10402.063814256451;10616.469176541297;39836;48018.759906201645;52881.7355913218;53136.468635313155;53989.73005134949;81806.18193818224;84196;85482.14517854742;86455;87126.56436717777;14052.718945620825;14260.215688137252;14361.138331700131;14535.27323633793;14535.709285814013;14046.859531404556;14127.64680882986;14802.925985370004;14998.175100369148;15001;13280.734385312433;13466.20010651888;13653.590392288248;13843.861561384258;14650.267486625839;13916.304184790517;13933.721325573635;14583.708325833637;14863;15200.619984500476;13121.329606885982;13414.597562073153;14321.856781432052;14332.785008224677;14765.557033289018;11536.59621913229;11960.975122888578;11996.64010079699;12189.817152742893;12230.938845305716;11614.187006909435;11877.762444750884;12055.21641093326;12062.336571488653;12145.14983951115 11:39:56 INFO - PROCESS | 29296 | __end_tp_report 11:39:56 INFO - PROCESS | 29296 | __start_cc_report 11:39:56 INFO - PROCESS | 29296 | _x_x_mozilla_cycle_collect,355 11:39:56 INFO - PROCESS | 29296 | __end_cc_report 11:39:56 INFO - PROCESS | 29296 | __startTimestamp1475260796388__endTimestamp 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | ------- Summary: start ------- 11:39:56 INFO - PROCESS | 29296 | Number of tests: 6 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | [#0] dojo.html Cycles:165 Average:5705.44 Median:5963.58 stddev:652.02 (10.9%) stddev-sans-first:624.71 11:39:56 INFO - PROCESS | 29296 | Values: 3241.6 3261.5 3270.4 3287.3 3288.3 5686.7 5734.6 5748.8 5761.8 5763.6 5673.0 5702.1 5734.7 5738.6 5783.2 5148.5 5195.7 5197.9 5226.5 5239.0 5260.4 5262.2 5263.8 5265.8 5294.4 5047.6 5112.3 5240.6 5240.6 5246.4 5166.4 5244.8 5272.2 5279.1 5313.1 5187.5 5233.3 5234.8 5242.5 5243.2 5472.1 5537.0 5680.4 5733.4 5800.7 6023.4 6113.5 6117.4 6122.8 6123.9 6149.2 6151.3 6155.1 6156.8 6158.1 5614.1 5676.0 5752.3 5754.9 5789.5 6181.5 6308.3 6312.4 6313.6 6317.1 6027.7 6041.3 6074.8 6074.9 6077.0 5929.3 6066.5 6091.2 6132.4 6160.8 6048.1 6138.2 6148.4 6153.6 6155.4 6141.6 6143.6 6144.5 6148.7 6162.0 4536.4 4641.0 4708.9 4721.0 4736.6 4148.9 4194.6 4195.4 4224.7 4233.7 5894.3 5944.7 5950.6 5963.6 5987.2 5936.2 6139.5 6238.9 6255.8 6263.3 5921.5 5927.0 5976.4 5985.2 6017.7 5304.8 5339.1 5344.0 5348.0 5381.4 6124.3 6145.7 6172.8 6432.5 6435.0 6127.6 6145.4 6155.0 6164.9 6176.2 6241.3 6327.7 6331.3 6343.4 6346.7 5756.7 5942.2 5982.1 6045.0 6049.0 6174.5 6186.6 6186.8 6189.5 6216.7 6019.8 6031.3 6034.5 6043.5 6045.2 5841.5 5921.2 5947.9 6008.4 6028.5 5947.4 5993.8 5998.4 5999.6 6014.6 6003.8 6018.0 6066.7 6077.1 6077.6 5726.5 5884.2 5953.8 5960.2 5984.5 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | [#1] ext.html Cycles:180 Average:67030.45 Median:46449.04 stddev:135025.35 (290.7%) stddev-sans-first:135311.96 11:39:56 INFO - PROCESS | 29296 | Values: 582.6 625.2 640.5 645.1 674.4 41913.0 46049.0 46663.0 46778.8 46791.8 45817.8 46313.3 46329.5 46374.8 46523.3 9030.0 9147.8 9150.9 9172.4 9173.6 9059.4 9075.5 9108.5 9116.2 9159.3 9167.4 9186.4 9214.9 9232.1 9265.0 9153.3 9213.1 9221.4 9224.2 9227.6 8984.5 9005.3 9020.8 9036.1 9037.6 43952.3 44356.6 44670.8 44683.3 44729.0 4056.3 4124.6 4338.9 4392.2 4619.8 35629.1 35914.0 36814.6 36858.4 37587.6 4210.6 4216.5 4243.6 4394.3 4412.4 270980.0 271580.0 272060.0 273673.0 274940.0 64177.7 64429.0 64661.4 64911.7 65022.0 68888.0 69247.3 69273.0 69291.7 69346.3 17107.6 18931.1 19441.0 19454.8 19928.5 15280.0 15359.2 15370.1 15452.2 15481.7 21090.3 21308.5 21577.8 21604.0 21719.7 7833.2 7984.6 8026.3 8049.9 8129.1 1053.8 1105.1 1121.4 1158.4 1159.0 33660.5 33779.3 33888.3 34199.3 34412.7 1227.2 1234.7 1271.7 1290.8 1340.2 17958.5 18044.2 18083.0 18104.5 18125.5 653773.0 655342.0 656212.0 658011.0 659880.0 64863.7 65022.3 65050.7 65167.0 65176.7 1445.6 1455.8 1501.6 1501.7 1513.8 33078.5 33315.3 33558.0 33850.8 33955.2 55925.0 68125.3 69165.3 69420.3 69422.7 512099.0 513628.0 513725.0 515154.0 516631.0 47911.8 48017.0 48408.5 49377.0 49622.0 52993.0 53747.0 53944.7 54144.0 55658.0 44511.7 44949.3 45881.0 46937.0 48128.3 44685.0 44738.0 45257.5 46182.9 46801.8 39326.2 44978.8 46910.0 46913.5 47783.0 44918.3 47489.3 47755.8 47905.8 49643.5 35566.8 35778.6 36043.0 36071.5 36392.1 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | [#2] jquery.html Cycles:180 Average:31586.18 Median:3261.76 stddev:85168.01 (2611.1%) stddev-sans-first:85374.76 11:39:56 INFO - PROCESS | 29296 | Values: 413.7 430.8 432.3 434.9 438.7 18852.0 19709.6 20380.6 20437.8 20530.4 19414.6 19822.3 20123.6 20500.6 20694.0 5770.9 5975.2 5988.0 5994.4 5995.7 5854.9 5870.5 5875.3 5931.4 5948.0 5760.2 5823.6 5843.6 5867.5 5879.6 5816.7 5828.8 5853.6 5907.3 5909.9 5204.6 5295.8 5317.5 5320.2 5332.4 24324.0 24564.9 24655.4 24826.1 25176.5 2610.0 2998.9 3224.5 3299.0 3300.5 16832.6 16855.7 17038.7 17264.1 17701.6 2204.2 2215.9 2221.0 2234.8 2270.5 82140.6 82884.0 84831.6 88662.6 99753.5 18329.9 18817.2 18918.0 18923.6 19024.2 33745.5 33994.0 34418.7 34489.0 34534.0 9720.4 10899.7 11176.2 11270.3 11442.4 9505.6 9584.8 9607.8 9663.1 9682.8 9200.7 9311.2 9422.7 9536.6 9547.9 3560.4 3700.9 3704.8 3745.7 3817.4 970.6 1030.8 1056.1 1072.7 1084.7 20726.9 20804.0 20845.2 20910.8 20993.4 1042.4 1049.6 1084.8 1119.8 1141.9 11353.3 11675.9 11686.3 11719.1 11778.8 506034.0 514191.0 518687.4 524298.0 524902.0 94544.0 94630.1 94861.0 95885.5 97175.0 1069.0 1080.1 1097.9 1100.2 1123.4 18186.3 18561.8 18858.5 18945.8 19228.8 30812.5 41850.8 41872.6 41958.8 42333.8 58973.4 59782.7 60090.0 60891.4 61019.7 9074.8 9102.5 9180.8 9223.8 9237.8 13044.4 13882.9 13892.6 13922.3 13938.1 11766.5 12177.6 12205.1 12219.9 12485.4 11057.7 11138.8 11250.5 11509.8 12023.4 11598.7 11803.1 12000.9 12322.8 12429.4 8833.7 8990.2 9008.1 9049.8 9256.1 8899.9 11547.2 11675.6 12189.2 12212.9 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | [#3] mootools.html Cycles:180 Average:6417.87 Median:4406.97 stddev:3726.30 (84.6%) stddev-sans-first:3718.67 11:39:56 INFO - PROCESS | 29296 | Values: 1532.8 1574.6 1733.3 1826.6 1876.3 8577.0 9330.7 9544.7 10090.6 10108.4 9500.1 9766.9 9790.8 9807.9 9853.5 2509.5 2532.7 2551.5 2555.7 2569.7 2501.0 2531.1 2535.8 2538.6 2544.0 2465.4 2480.4 2523.6 2533.5 2534.5 2454.7 2462.9 2470.3 2498.1 2502.0 2457.2 2462.4 2463.0 2467.4 2489.2 9861.1 10027.1 10037.7 10051.7 10096.7 5576.8 5720.8 5723.9 5729.5 5753.1 3479.7 3551.7 3624.5 3642.6 3677.7 1215.3 1251.6 1268.8 2250.3 2353.1 13881.7 13928.0 13979.9 14013.0 14031.4 4808.4 4864.0 5002.2 5032.4 5126.9 10935.5 10983.4 11001.2 11019.8 11036.5 5871.9 5872.7 5892.7 5896.4 5896.6 5238.2 5350.2 5404.9 5457.4 5485.7 4226.5 4306.9 4327.5 4358.4 4385.6 1281.4 1286.5 1289.7 1293.5 1293.9 981.0 1069.9 1078.4 1085.7 1086.5 6233.7 6418.1 6489.6 6497.4 6562.4 492.6 496.8 513.0 521.3 525.6 4354.6 4428.4 4439.0 4506.7 4558.3 12038.0 12549.1 12554.9 12558.1 12582.2 11302.4 11693.8 11770.7 11959.5 12551.4 9141.3 9232.4 9277.9 9292.8 9383.2 6681.0 6884.1 6995.7 6996.4 7040.9 11324.6 11540.6 11559.1 11674.1 11692.8 11437.6 11550.5 11605.1 11651.9 11708.9 8164.0 8327.5 8423.0 8505.4 8644.0 9535.2 9580.0 9598.3 9604.4 9619.9 8364.1 8424.2 8428.5 8483.1 8505.9 8303.3 8317.2 8333.6 8339.6 8360.5 7710.0 7809.4 7898.9 7916.2 7937.5 5355.8 5395.3 5414.3 5502.3 5537.5 5542.4 5542.6 5553.8 5579.9 5585.8 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | [#4] prototype.html Cycles:180 Average:5021.65 Median:5604.75 stddev:1477.68 (26.4%) stddev-sans-first:1439.78 11:39:56 INFO - PROCESS | 29296 | Values: 358.2 360.1 360.7 361.9 363.1 5746.4 5755.7 5766.6 5770.4 5771.0 5608.6 5660.0 5675.1 5675.3 5714.6 4477.8 4489.4 4497.7 4498.3 4501.6 4508.1 4513.5 4539.3 4543.7 4551.1 4471.8 4512.2 4521.5 4525.2 4546.5 4297.5 4431.0 4438.9 4451.2 4451.2 3993.4 4007.5 4009.7 4010.0 4026.7 5470.8 5589.0 5594.5 5594.7 5600.9 5023.0 5121.1 5127.4 5137.4 5151.3 5919.6 5943.8 5951.4 5968.4 5983.4 4332.2 4425.7 4436.3 4437.2 4442.9 6008.3 6165.5 6172.8 6193.3 6198.6 4399.6 4428.8 4443.8 4480.5 4485.9 4482.5 4486.4 4500.3 4506.6 4524.5 4916.2 5119.3 5129.8 5153.2 5161.5 5995.3 6004.7 6010.6 6019.4 6044.7 1552.4 1570.5 1575.8 1576.9 1582.3 950.9 980.6 984.2 986.8 1003.3 5230.2 5248.6 5259.8 5264.4 5270.7 5420.8 5483.7 5492.0 5576.3 5589.2 5007.8 5243.7 5278.0 5298.2 5301.3 2915.9 2934.8 2937.7 2940.2 2972.8 5639.4 5649.6 5651.3 5660.5 5667.5 5939.9 6330.0 6347.9 6358.4 6384.4 6416.9 6420.5 6437.4 6437.5 6445.0 6050.9 6230.5 6234.8 6267.6 6278.3 6175.1 6175.2 6181.0 6183.7 6188.0 6229.7 6414.7 6430.9 6431.3 6435.7 4457.5 4534.4 4535.3 4547.1 4559.1 6153.4 6248.4 6290.2 6347.7 6383.9 6074.8 6104.9 6116.8 6120.6 6125.5 5903.9 6064.7 6078.2 6083.0 6098.7 6035.8 6076.4 6084.7 6091.8 6119.9 6125.9 6135.8 6140.4 6147.5 6164.3 5806.0 5978.6 5989.9 6001.4 6002.2 11:39:56 INFO - PROCESS | 29296 | 11:39:56 INFO - PROCESS | 29296 | [#5] yui.html Cycles:180 Average:22227.06 Median:21987.74 stddev:31880.23 (145.0%) stddev-sans-first:31929.29 11:39:56 INFO - PROCESS | 29296 | Values: 857.5 866.2 873.5 934.5 938.2 16461.5 17479.7 17658.9 17659.2 17723.1 15612.3 15623.9 15663.8 16391.8 16802.4 892.0 911.0 912.6 913.0 913.3 880.6 892.0 892.9 895.3 896.8 945.2 945.8 947.2 947.6 947.7 943.3 945.1 946.6 950.0 950.7 696.7 697.4 697.5 697.8 700.7 15976.6 15992.6 16017.5 16026.6 16061.7 16035.2 16203.6 16408.2 16589.0 16640.3 13076.1 13245.5 13445.0 13470.0 13532.4 4139.5 4146.3 4166.5 4199.6 4272.6 92005.5 93669.5 94201.0 94617.0 97613.0 12336.7 12337.1 12623.0 12709.9 12771.2 23976.4 24071.6 24221.2 24231.3 24404.6 8650.7 9174.5 9305.0 9426.3 9487.1 4634.1 4865.5 5050.0 5190.4 5212.1 3739.9 3881.4 3888.6 3896.2 3896.5 631.5 645.3 649.3 673.1 673.7 732.7 763.8 784.3 815.8 885.0 9817.2 10378.7 10436.7 10482.6 10909.5 739.5 780.3 800.1 828.0 839.1 4414.6 4447.5 4537.7 4538.2 4577.3 76189.0 77847.6 101963.0 135123.3 136805.3 89936.0 105582.0 107100.0 108199.0 110094.0 93509.0 94032.1 95269.5 95687.5 98143.0 9991.0 10314.6 10379.7 10402.1 10616.5 39836.0 48018.8 52881.7 53136.5 53989.7 81806.2 84196.0 85482.1 86455.0 87126.6 14052.7 14260.2 14361.1 14535.3 14535.7 14046.9 14127.6 14802.9 14998.2 15001.0 13280.7 13466.2 13653.6 13843.9 14650.3 13916.3 13933.7 14583.7 14863.0 15200.6 13121.3 13414.6 14321.9 14332.8 14765.6 11536.6 11961.0 11996.6 12189.8 12230.9 11614.2 11877.8 12055.2 12062.3 12145.1 11:39:56 INFO - PROCESS | 29296 | -------- Summary: end -------- 11:39:56 INFO - PROCESS | 29296 | 11:39:57 INFO - TEST-INFO | 29296: exit 0 11:39:57 INFO - TEST-OK | dromaeo_css | took 1111185ms 11:39:57 INFO - TEST-START | kraken 11:39:57 INFO - operating with platform_type : linux_ 11:39:57 INFO - Initialising browser for kraken test... 11:39:57 INFO - TEST-INFO | started process 29536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmVORTX/profile http://localhost:36262/getInfo.html) 11:40:01 INFO - PROCESS | 29536 | __metrics Screen width/height:1600/1200 11:40:01 INFO - PROCESS | 29536 | colorDepth:24 11:40:01 INFO - PROCESS | 29536 | Browser inner width/height: 1024/697 11:40:01 INFO - PROCESS | 29536 | __metrics 11:40:02 ERROR - PROCESS | 29536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:40:03 INFO - TEST-INFO | 29536: exit 0 11:40:03 INFO - Browser initialized. 11:40:03 INFO - Running cycle 1/1 for kraken test... 11:40:03 INFO - TEST-INFO | started process 29662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmVORTX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:15 INFO - PROCESS | 29662 | RSS: Main: 149856256 11:40:15 INFO - PROCESS | 29662 | 11:40:17 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:18 INFO - PROCESS | 29662 | RSS: Main: 156680192 11:40:18 INFO - PROCESS | 29662 | 11:40:21 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-dft) 11:40:21 INFO - PROCESS | 29662 | RSS: Main: 155168768 11:40:21 INFO - PROCESS | 29662 | 11:40:24 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-fft) 11:40:25 INFO - PROCESS | 29662 | RSS: Main: 155770880 11:40:25 INFO - PROCESS | 29662 | 11:40:27 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-oscillator) 11:40:27 INFO - PROCESS | 29662 | RSS: Main: 155852800 11:40:27 INFO - PROCESS | 29662 | 11:40:29 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:30 INFO - PROCESS | 29662 | RSS: Main: 156004352 11:40:30 INFO - PROCESS | 29662 | 11:40:33 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36262/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:34 INFO - PROCESS | 29662 | RSS: Main: 155738112 11:40:34 INFO - PROCESS | 29662 | 11:40:37 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36262/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:38 INFO - PROCESS | 29662 | RSS: Main: 156368896 11:40:38 INFO - PROCESS | 29662 | 11:40:41 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36262/tests/kraken/driver.html?testName=json-parse-financial) 11:40:41 INFO - PROCESS | 29662 | RSS: Main: 156618752 11:40:41 INFO - PROCESS | 29662 | 11:40:43 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:43 INFO - PROCESS | 29662 | RSS: Main: 155938816 11:40:43 INFO - PROCESS | 29662 | 11:40:45 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:46 INFO - PROCESS | 29662 | RSS: Main: 155840512 11:40:46 INFO - PROCESS | 29662 | 11:40:48 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:49 INFO - PROCESS | 29662 | RSS: Main: 156254208 11:40:49 INFO - PROCESS | 29662 | 11:40:51 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:52 INFO - PROCESS | 29662 | RSS: Main: 156954624 11:40:52 INFO - PROCESS | 29662 | 11:40:54 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:55 INFO - PROCESS | 29662 | RSS: Main: 156999680 11:40:55 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36262/tests/kraken/driver.html?testName=ai-astar) 11:40:57 INFO - PROCESS | 29662 | RSS: Main: 158867456 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | __start_tp_report 11:40:57 INFO - PROCESS | 29662 | _x_x_mozilla_page_load 11:40:57 INFO - PROCESS | 29662 | _x_x_mozilla_page_load_details 11:40:57 INFO - PROCESS | 29662 | |i|pagename|runs| 11:40:57 INFO - PROCESS | 29662 | |0;ai-astar;99;113;105;111;109;113;110;110;110;108 11:40:57 INFO - PROCESS | 29662 | |1;audio-beat-detection;145;117;149;169;127;144;147;122;175;115 11:40:57 INFO - PROCESS | 29662 | |2;audio-dft;162;162;162;161;162;163;163;161;162;161 11:40:57 INFO - PROCESS | 29662 | |3;audio-fft;74;76;75;172;76;75;76;76;180;77 11:40:57 INFO - PROCESS | 29662 | |4;audio-oscillator;83;84;152;84;83;82;148;84;84;136 11:40:57 INFO - PROCESS | 29662 | |5;imaging-gaussian-blur;117;118;118;117;117;118;117;117;117;118 11:40:57 INFO - PROCESS | 29662 | |6;imaging-darkroom;148;147;147;147;146;147;147;146;148;147 11:40:57 INFO - PROCESS | 29662 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;95 11:40:57 INFO - PROCESS | 29662 | |8;json-parse-financial;51;53;51;50;52;52;51;51;52;52 11:40:57 INFO - PROCESS | 29662 | |9;json-stringify-tinderbox;64;60;60;60;60;60;61;59;62;60 11:40:57 INFO - PROCESS | 29662 | |10;stanford-crypto-aes;81;73;77;75;73;73;77;81;78;74 11:40:57 INFO - PROCESS | 29662 | |11;stanford-crypto-ccm;122;138;130;127;131;121;127;120;150;118 11:40:57 INFO - PROCESS | 29662 | |12;stanford-crypto-pbkdf2;156;152;155;160;159;160;154;155;164;149 11:40:57 INFO - PROCESS | 29662 | |13;stanford-crypto-sha256-iterative;63;62;63;65;64;61;62;66;60;65 11:40:57 INFO - PROCESS | 29662 | __end_tp_report 11:40:57 INFO - PROCESS | 29662 | __start_cc_report 11:40:57 INFO - PROCESS | 29662 | _x_x_mozilla_cycle_collect,864 11:40:57 INFO - PROCESS | 29662 | __end_cc_report 11:40:57 INFO - PROCESS | 29662 | __startTimestamp1475260857388__endTimestamp 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | ------- Summary: start ------- 11:40:57 INFO - PROCESS | 29662 | Number of tests: 14 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:4.16 (3.8%) stddev-sans-first:2.47 11:40:57 INFO - PROCESS | 29662 | Values: 99.0 113.0 105.0 111.0 109.0 113.0 110.0 110.0 110.0 108.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.00 stddev:20.75 (14.2%) stddev-sans-first:21.96 11:40:57 INFO - PROCESS | 29662 | Values: 145.0 117.0 149.0 169.0 127.0 144.0 147.0 122.0 175.0 115.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:40:57 INFO - PROCESS | 29662 | Values: 162.0 162.0 162.0 161.0 162.0 163.0 163.0 161.0 162.0 161.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.37 (55.8%) stddev-sans-first:44.21 11:40:57 INFO - PROCESS | 29662 | Values: 74.0 76.0 75.0 172.0 76.0 75.0 76.0 76.0 180.0 77.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.50 stddev:30.17 (36.1%) stddev-sans-first:31.20 11:40:57 INFO - PROCESS | 29662 | Values: 83.0 84.0 152.0 84.0 83.0 82.0 148.0 84.0 84.0 136.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:40:57 INFO - PROCESS | 29662 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 11:40:57 INFO - PROCESS | 29662 | Values: 148.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 148.0 147.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:40:57 INFO - PROCESS | 29662 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 11:40:57 INFO - PROCESS | 29662 | Values: 51.0 53.0 51.0 50.0 52.0 52.0 51.0 51.0 52.0 52.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:0.83 11:40:57 INFO - PROCESS | 29662 | Values: 64.0 60.0 60.0 60.0 60.0 60.0 61.0 59.0 62.0 60.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:77.00 stddev:3.12 (4.1%) stddev-sans-first:2.78 11:40:57 INFO - PROCESS | 29662 | Values: 81.0 73.0 77.0 75.0 73.0 73.0 77.0 81.0 78.0 74.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:9.70 (7.5%) stddev-sans-first:10.01 11:40:57 INFO - PROCESS | 29662 | Values: 122.0 138.0 130.0 127.0 131.0 121.0 127.0 120.0 150.0 118.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:157.50 stddev:4.40 (2.8%) stddev-sans-first:4.67 11:40:57 INFO - PROCESS | 29662 | Values: 156.0 152.0 155.0 160.0 159.0 160.0 154.0 155.0 164.0 149.0 11:40:57 INFO - PROCESS | 29662 | 11:40:57 INFO - PROCESS | 29662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.91 (3.0%) stddev-sans-first:2.03 11:40:57 INFO - PROCESS | 29662 | Values: 63.0 62.0 63.0 65.0 64.0 61.0 62.0 66.0 60.0 65.0 11:40:57 INFO - PROCESS | 29662 | -------- Summary: end -------- 11:40:57 INFO - PROCESS | 29662 | 11:40:58 INFO - TEST-INFO | 29662: exit 0 11:40:58 INFO - TEST-OK | kraken | took 61342ms 11:40:58 INFO - SUITE-END | took 1172s 11:40:58 INFO - Completed test suite (00:19:32) 11:40:58 INFO - javascript benchmark 11:40:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7954.562699767657, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.5623890774746, 3261.461858793299, 3270.362279355526, 3287.260366417555, 3288.2930170013474, 5686.658800471974, 5734.598578099534, 5748.827535173947, 5761.827145185641, 5763.625364351315, 5672.971635141829, 5702.087665973445, 5734.713264336788, 5738.598298119123, 5783.21926539917, 5148.485151484859, 5195.714235717034, 5197.896042079156, 5226.477352264762, 5238.973805130969, 5260.447652996438, 5262.236975638531, 5263.842084737464, 5265.7893684252585, 5294.364676238857, 5047.596192304607, 5112.284280200774, 5240.633155679085, 5240.633155679104, 5246.414186925285, 5166.354205724285, 5244.763985620656, 5272.156454967187, 5279.102552566073, 5313.096773548467, 5187.533122019036, 5233.345831771028, 5234.81678141267, 5242.475752424765, 5243.239730239132, 5472.1244600864065, 5537.0, 5680.4319568042865, 5733.426657334275, 5800.651960882318, 6023.397660233985, 6113.476306051806, 6117.431594453911, 6122.784715471481, 6123.893452428408, 6149.200603921507, 6151.323354431009, 6155.107509411155, 6156.815295541141, 6158.107074474221, 5614.101743721026, 5675.971620141873, 5752.309722833245, 5754.856128596777, 5789.536837053026, 6181.474574661114, 6308.3060863305, 6312.368763123743, 6313.621182729051, 6317.1156038154695, 6027.7287522061615, 6041.305249896231, 6074.757009719562, 6074.878502429927, 6076.969615151896, 5929.288485381696, 6066.545009124334, 6091.177691011745, 6132.356102609251, 6160.815175544741, 6048.092786082035, 6138.235132557318, 6148.44663980244, 6153.600015999035, 6155.446009859134, 6141.6007959482495, 6143.631382116998, 6144.5084393248435, 6148.661823599745, 6162.044883043135, 4536.432945881765, 4641.0, 4708.9058218835435, 4720.976395118002, 4736.5500277474275, 4148.854790082332, 4194.643455306333, 4195.391668208093, 4224.725392849455, 4233.724807887477, 5894.322152952465, 5944.7027648617395, 5950.553708471795, 5963.582549221513, 5987.161797348374, 5936.168936348915, 6139.508839292846, 6238.937610623926, 6255.843603909848, 6263.311035786151, 5921.526277897758, 5926.970365148147, 5976.432238937294, 5985.22192115031, 6017.69911504423, 5304.787808487617, 5339.092354299778, 5343.973280133652, 5348.03735327637, 5381.4349493303425, 6124.258880972529, 6145.740123274718, 6172.783952561639, 6432.51756118293, 6435.034744788226, 6127.571070025056, 6145.446909778141, 6154.969225153845, 6164.938350616437, 6176.166217560752, 6241.282252541016, 6327.651979141007, 6331.303556608861, 6343.397377249154, 6346.714397852015, 5756.65460072397, 5942.227510423617, 5982.0727787193055, 6044.969775151096, 6048.969755151196, 6174.536909731878, 6186.597871138361, 6186.81439556814, 6189.535784816247, 6216.720247588779, 6019.789307374221, 6031.336552979081, 6034.547408944434, 6043.45608895184, 6045.168959076215, 5841.474267315962, 5921.230240068763, 5947.9405205949115, 6008.369121242206, 6028.5177185825905, 5947.375525569752, 5993.760249589967, 5998.370171132143, 5999.580029398075, 6014.609050411709, 6003.8198854034445, 6017.969910150421, 6066.696665166813, 6077.118817771487, 6077.574569780073, 5726.541876649775, 5884.235049443545, 5953.7916172935475, 5960.195373624505, 5984.521238301013], "value": 5660.722317017009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.5747204540685, 625.1841347042109, 640.5100098424706, 645.1097485470053, 674.3694645506449, 41913.0, 46049.0, 46663.0, 46778.76610616947, 46791.76604116974, 45817.77091114548, 46313.305300420434, 46329.53670463294, 46374.768126159404, 46523.30215046777, 9029.954850225757, 9147.771305717344, 9150.862737058917, 9172.403793753385, 9173.58718857653, 9059.365844390895, 9075.455472671627, 9108.544572771334, 9116.179543841054, 9159.313051521129, 9167.404118732262, 9186.448813071238, 9214.907850921472, 9232.076792320782, 9265.0, 9153.313501487382, 9213.12475314844, 9221.400608960395, 9224.169824715775, 9227.584758685842, 8984.505852178128, 9005.32460065491, 9020.81958360829, 9036.096390360977, 9037.638494460214, 43952.3407148893, 44356.556434435886, 44670.77664611656, 44683.329750053774, 44729.0, 4056.269871423143, 4124.566920473367, 4338.891527711801, 4392.231359512072, 4619.792109355053, 35629.10927226814, 35914.0, 36814.631853681654, 36858.447123293176, 37587.62412375869, 4210.642095421893, 4216.451861258048, 4243.554426785174, 4394.296912494017, 4412.426384570017, 270980.0, 271580.0, 272060.0, 273673.0, 274939.999999998, 64177.67911160414, 64429.0, 64661.35338646647, 64911.67544162343, 65022.0, 68888.0, 69247.3075269251, 69273.0, 69291.65354173197, 69346.30653693399, 17107.572310692332, 18931.148098335332, 19441.0, 19454.805451945584, 19928.50178745543, 15280.0, 15359.155246461552, 15370.077795332316, 15452.227388630523, 15481.690366192614, 21090.261840835497, 21308.467288317606, 21577.78422215789, 21604.0, 21719.67420488662, 7833.186560592252, 7984.560849153236, 8026.317762990095, 8049.919500805034, 8129.1464396238725, 1053.836655318427, 1105.0993440346253, 1121.4448847820381, 1158.4092113022418, 1158.9942050289694, 33660.495092573634, 33779.32441351159, 33888.32223355519, 34199.31601368009, 34412.65587344095, 1227.1593958138703, 1234.6542967968983, 1271.7138643805256, 1290.8386451693539, 1340.162398500937, 17958.461246162635, 18044.18801153951, 18083.0, 18104.547386315448, 18125.546861328574, 653773.0, 655342.0, 656212.0, 658011.0, 659880.0, 64863.67568162129, 65022.349776502575, 65050.67474662596, 65167.0, 65176.67411662911, 1445.5880074178808, 1455.7961885336063, 1501.5570406730042, 1501.6546194375355, 1513.7956375889335, 33078.5038224422, 33315.33369332648, 33558.0, 33850.83074584611, 33955.15112122217, 55925.0, 68125.3187468119, 69165.30834691589, 69420.30579694138, 69422.65288673525, 512099.0, 513628.0, 513725.0, 515154.0, 516631.0, 47911.76044119757, 48017.0, 48408.5159148404, 49377.0, 49622.0, 52993.0, 53747.0, 53944.73027634837, 54144.0, 55658.0, 44511.67025738757, 44949.32576011297, 45881.0, 46937.0, 48128.27807582819, 44685.0, 44738.0, 45257.547424525335, 46182.8800731044, 46801.76599116983, 39326.21347572975, 44978.77510612426, 46910.0, 46913.53086469228, 47783.0, 44918.3262251073, 47489.28766068581, 47755.76122119367, 47905.76047119742, 49643.50356496389, 35566.822165889, 35778.64221357753, 36043.0, 36071.45892811557, 36392.09019774527], "value": 22430.07836966074, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7414116177389, 430.7544699521274, 432.3329656359598, 434.93693414454907, 438.67318847458637, 18852.0, 19709.60580788385, 20380.59238815223, 20437.795622043774, 20530.38408847733, 19414.611707765835, 19822.306219282327, 20123.597528049468, 20500.589988200227, 20694.0, 5770.9422905770825, 5975.223220981266, 5988.0, 5994.43052909975, 5995.700214989255, 5854.853628659296, 5870.501007414354, 5875.324337701155, 5931.4068593140555, 5948.048312270038, 5760.193572899798, 5823.592348535604, 5843.561732870052, 5867.501262392701, 5879.588428809985, 5816.680082595455, 5828.795992140276, 5853.619514731528, 5907.261592300963, 5909.8818023639715, 5204.609654275907, 5295.7881684732565, 5317.494837990384, 5320.17537281722, 5332.386775520826, 24324.0, 24564.877175614187, 24655.38361540976, 24826.131085412104, 25176.49647007068, 2609.960850587243, 2998.925026874324, 3224.4679627861374, 3299.0432774495607, 3300.504924261356, 16832.57918552034, 16855.747163792552, 17038.74441883373, 17264.13679316029, 17701.557461063447, 2204.2175027865196, 2215.9224427144973, 2221.0, 2234.7765223477686, 2270.477790108268, 82140.58929705372, 82884.0, 84831.5758421204, 88662.5566872168, 99753.5012324941, 18329.90835045843, 18817.247310107716, 18918.0, 18923.621527569372, 19024.239030438905, 33745.49381759275, 33994.0, 34418.655813441546, 34489.0, 34534.0, 9720.368176068532, 10899.67300980956, 11176.161787865942, 11270.323780573028, 11442.398064271008, 9505.5722492488, 9584.808303833885, 9607.759806004906, 9663.082007209305, 9682.806343873082, 9200.723978280663, 9311.161995420445, 9422.717318480456, 9536.5681751153, 9547.904520954702, 3560.412531932254, 3700.908232071545, 3704.833282502294, 3745.700343972476, 3817.4464702617965, 970.5535453691381, 1030.8093002794508, 1056.114135834371, 1072.7210925159516, 1084.6691759013577, 20726.896365518074, 20804.0, 20845.1661933524, 20910.790892091187, 20993.37019889406, 1042.4214560918763, 1049.611643691839, 1084.7938891610727, 1119.7536541960756, 1141.9429028548539, 11353.318800871974, 11675.88324116748, 11686.298822070534, 11719.12106592009, 11778.823317650242, 506034.0, 514191.0, 518687.4065629648, 524298.0, 524902.0, 94544.0, 94630.0536994635, 94861.0, 95885.52057239809, 97175.0, 1068.9679309620724, 1080.1089101491302, 1097.8956999085074, 1100.1803656276124, 1123.4270522033657, 18186.27254909789, 18561.814381856548, 18858.52853678669, 18945.810541894403, 19228.807711922702, 30812.53781193239, 41850.79074604608, 41872.58127418809, 41958.790206048776, 42333.788331058146, 58973.41026589679, 59782.701086494286, 60090.0, 60891.39108609034, 61019.69490152521, 9074.773130671787, 9102.453852768855, 9180.806495155586, 9223.76940576491, 9237.769055773659, 13044.413001415149, 13882.861171388156, 13892.583222503341, 13922.303884805517, 13938.09402388882, 11766.52933882635, 12177.634670959886, 12205.145639805129, 12219.938900305442, 12485.438155282853, 11057.668269951915, 11138.777224455627, 11250.493727782106, 11509.769804604028, 12023.398830058288, 11598.710032248924, 11803.114766392726, 12000.879991199976, 12322.81515777282, 12429.440675169459, 8833.690820821497, 8990.190882820578, 9008.054154313964, 9049.77375565616, 9256.074392560959, 8899.866502002606, 11547.249428787101, 11675.591354302558, 12189.207701499374, 12212.938935305621], "value": 10644.612228254447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.8007359043322, 1574.5984773882658, 1733.306677329069, 1826.6255417639386, 1876.2870109358441, 8576.95711521443, 9330.673426430076, 9544.665936692218, 10090.646827361044, 10108.393496390221, 9500.144986951173, 9766.902330976689, 9790.755231119225, 9807.852882206773, 9853.507324633776, 2509.4604659998145, 2532.7467253274617, 2551.5407226699185, 2555.6933168019864, 2569.743025697434, 2501.0, 2531.0635065025967, 2535.759102885223, 2538.5557527432625, 2544.0, 2465.4452748131707, 2480.3675062858947, 2523.5836087045614, 2533.518631460026, 2534.5057713745828, 2454.6563481112657, 2462.852228866274, 2470.3206618180056, 2498.1131698247223, 2501.987490062538, 2457.1891275879098, 2462.372095115752, 2463.027104293812, 2467.370820440794, 2489.191012920808, 9861.063198996155, 10027.097561219525, 10037.749056273651, 10051.69844904654, 10096.69709908704, 5576.832695019115, 5720.771169153229, 5723.855228954184, 5729.512991395694, 5753.137029445575, 3479.68682818545, 3551.733619978512, 3624.5469316335457, 3642.581103173116, 3677.687396571295, 1215.3194211241732, 1251.5869762978195, 1268.7716211082002, 2250.2574150530286, 2353.1293421434007, 13881.722365552734, 13928.0, 13979.860201397958, 14013.0, 14031.43874245029, 4808.35087263222, 4863.95136048635, 5002.224655178453, 5032.3961124665275, 5126.923346097361, 10935.507902144423, 10983.39591322485, 11001.17491188164, 11019.83470247947, 11036.503357348938, 5871.882562348729, 5872.7357268923, 5892.734826932799, 5896.351401345849, 5896.64620122794, 5238.161894097002, 5350.17072353778, 5404.91892621611, 5457.426970168154, 5485.670859748348, 4226.450561426995, 4306.913861722811, 4327.459067616548, 4358.389825424443, 4385.561443855653, 1281.3849352310942, 1286.5239861251398, 1289.6582405662507, 1293.534327642048, 1293.909426340166, 980.9852852207223, 1069.8555694981233, 1078.4499905048324, 1085.6688709943544, 1086.4839201379282, 6233.719482623293, 6418.069379939882, 6489.643069631215, 6497.415232629086, 6562.409383155539, 492.5665414435274, 496.82859413502285, 512.9897402051938, 521.3066621393538, 525.6478159633054, 4354.56454354562, 4428.3800267962515, 4439.023414848728, 4506.7070640408265, 4558.316252562142, 12038.0, 12549.121561490609, 12554.874451255553, 12558.120931534704, 12582.182158159874, 11302.43487825622, 11693.766124677459, 11770.705732356588, 11959.461824217757, 12551.435185416678, 9141.31440141992, 9232.446053236961, 9277.860832087525, 9292.7676808079, 9383.202427793578, 6680.966595166993, 6884.105066341343, 6995.7201711932985, 6996.440284777307, 7040.859182816417, 11324.6036388726, 11540.596079137189, 11559.07527397823, 11674.066074714172, 11692.766144677229, 11437.59968401102, 11550.48022838991, 11605.129615278718, 11651.941740291244, 11708.88291117078, 8163.959180204061, 8327.54198519063, 8423.0, 8505.36209784281, 8644.0, 9535.189508891544, 9580.0, 9598.280128990215, 9604.423734575948, 9619.855702164334, 8364.121767214356, 8424.157584241526, 8428.4942903426, 8483.10927352619, 8505.91494085076, 8303.294219991127, 8317.168283171635, 8333.624986875726, 8339.624716887633, 8360.540170290693, 7710.0, 7809.375249980101, 7898.921010789819, 7916.247956444128, 7937.523748575104, 5355.812546560852, 5395.325584301962, 5414.337060702844, 5502.284702988586, 5537.529310008534, 5542.445755424425, 5542.556595472433, 5553.8333849984565, 5579.860503487445, 5585.804496842591], "value": 5038.823317619612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.22444407856983, 360.0799956112134, 360.6988164882321, 361.87515307219, 363.0958912308353, 5746.425357464257, 5755.712214389279, 5766.596338256319, 5770.394108618598, 5771.0, 5608.635438696482, 5659.971700141494, 5675.148727690848, 5675.318961724589, 5714.599978001542, 4477.835762701705, 4489.3939318192115, 4497.730136191823, 4498.257787465081, 4501.572350626701, 4508.143452743984, 4513.458384993805, 4539.319102134673, 4543.65922555808, 4551.089782043588, 4471.7987690554, 4512.16524942885, 4521.502634710179, 4525.185466616008, 4546.47715512717, 4297.452916949896, 4431.0, 4438.911221775563, 4451.154280686659, 4451.243288640939, 3993.4009898515164, 4007.458993035932, 4009.719319647626, 4010.0, 4026.71812973092, 5470.835874923719, 5589.0, 5594.496495315441, 5594.748236329334, 5600.85997850057, 5022.974885125587, 5121.129408000649, 5127.410347810012, 5137.434882162959, 5151.278820965068, 5919.5560332974765, 5943.821685349447, 5951.4048595140575, 5968.37332080134, 5983.401659833982, 4332.220200363933, 4425.734455932622, 4436.268015777393, 4437.2013037653205, 4442.888927776799, 6008.3390827009, 6165.475934545569, 6172.7530898764, 6193.318734939108, 6198.566100372976, 4399.62603178727, 4428.756418397019, 4443.756058077622, 4480.507144214133, 4485.887852803706, 4482.484514280834, 4486.394336764495, 4500.3249512573375, 4506.639468842484, 4524.47968483622, 4916.188828843272, 5119.334486516804, 5129.846104616868, 5153.201253805666, 5161.509656582619, 5995.312882577184, 6004.6697431640805, 6010.579259451883, 6019.42815432542, 6044.697765111727, 1552.433361822949, 1570.4895908829676, 1575.7872687187312, 1576.8961726791063, 1582.3037863340323, 950.8811398575178, 980.5930538826307, 984.1585444444896, 986.8322385194534, 1003.2976916158718, 5230.215467679803, 5248.553872920845, 5259.76331065103, 5264.394594621667, 5270.657407268515, 5420.810271640553, 5483.725813709299, 5491.9725401373535, 5576.33084029919, 5589.245451863946, 5007.795011192839, 5243.659162154448, 5277.973610131925, 5298.178782288752, 5301.310829592206, 2915.9271018224713, 2934.82391056533, 2937.6915423880614, 2940.2355387599378, 2972.7919045667027, 5639.379668236491, 5649.6327738696855, 5651.321841379061, 5660.547156227574, 5667.498113000058, 5939.851503712442, 6330.0, 6347.9051912868645, 6358.395952384516, 6384.361563843579, 6416.871662566722, 6420.5184611154355, 6437.356264373525, 6437.517186211053, 6444.967775161188, 6050.910836049553, 6230.470410015199, 6234.750609975732, 6267.561270711007, 6278.309385967631, 6175.104609831459, 6175.166352542529, 6180.969095154495, 6183.690815459119, 6188.039654620956, 6229.719662615284, 6414.743410263537, 6430.90674585331, 6431.260405053479, 6435.710393032418, 4457.50967393593, 4534.433195850519, 4535.297028960516, 4547.067851090453, 4559.133764584718, 6153.384661533811, 6248.4376406123665, 6290.21372328459, 6347.650879201688, 6383.872322553616, 6074.757009719562, 6104.8779024420155, 6116.785912493041, 6120.602160859708, 6125.479334256638, 5903.911441328298, 6064.666443345658, 6078.179445774764, 6083.0, 6098.664573448503, 6035.758569657164, 6076.392360764065, 6084.665343405978, 6091.847703807441, 6119.938800612115, 6125.938740612537, 6135.8466038347615, 6140.416660417253, 6147.538934579835, 6164.260288765377, 5805.970970145122, 5978.581499295007, 5989.861926234002, 6001.3698561652145, 6002.189704389852], "value": 4549.708636556087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.4812238595649, 866.190112245051, 873.5239294584455, 934.5280633280192, 938.1697197979786, 16461.50615481536, 17479.650406991852, 17658.911705441456, 17659.20533575989, 17723.11384430778, 15612.2974466149, 15623.921880390582, 15663.843361566382, 16391.754123688126, 16802.411915582958, 892.0366004714924, 910.9635614575409, 912.5710915869564, 912.9957047248007, 913.3058875254787, 880.6301353431542, 891.9821603567925, 892.9107089291084, 895.292718752185, 896.7713233125544, 945.2060269373725, 945.8108378324329, 947.2232769129316, 947.6446332625266, 947.7156852944123, 943.2501161576529, 945.1021529546958, 946.597695979213, 949.981000379992, 950.6957773512479, 696.7317582730634, 697.4490152779298, 697.5117417807555, 697.8150790040643, 700.7232143303366, 15976.600584985468, 15992.600184995468, 16017.519474415787, 16026.5993350166, 16061.678766424606, 16035.19824008795, 16203.594910127224, 16408.179591020402, 16589.0, 16640.33438662452, 13076.08467407282, 13245.47018119274, 13445.0, 13470.0, 13532.391042403115, 4139.482564679415, 4146.274401979642, 4166.500019997589, 4199.622034016953, 4272.594103560157, 92005.53997230038, 93669.53165234199, 94201.0, 94617.0, 97613.0, 12336.691582710504, 12337.136400451882, 12623.0, 12709.93645031769, 12771.233725976284, 23976.40058998504, 24071.638925416133, 24221.152259670827, 24231.273061808173, 24404.633930491058, 8650.653973841101, 9174.495402752913, 9305.0, 9426.293028022927, 9487.098725621056, 4634.073185362941, 4865.464798872121, 5050.0, 5190.351206099238, 5212.113940630102, 3739.9439008414897, 3881.4177873318663, 3888.6111388861455, 3896.201278737852, 3896.5129358830145, 631.4695655649185, 645.270843946347, 649.2922714241499, 673.1148539670415, 673.727140508095, 732.7472022152349, 763.8052296664315, 784.3411534311092, 815.8205194857122, 884.9557522123868, 9817.214622830299, 10378.688639340831, 10436.739081523023, 10482.633107841342, 10909.454527273605, 739.5008369350667, 780.2938340801584, 800.1438460846838, 827.9526399105137, 839.1482645115213, 4414.580614841585, 4447.510773814878, 4537.705049171794, 4538.160440318552, 4577.313402989578, 76189.0, 77847.61076194583, 101963.0, 135123.32438337745, 136805.3159734215, 89936.0, 105582.0, 107100.0, 108199.0, 110094.0, 93509.0, 94032.0596794037, 95269.52365238268, 95687.52156239175, 98143.0, 9990.950045249727, 10314.553804735062, 10379.702537182851, 10402.063814256451, 10616.469176541297, 39836.0, 48018.759906201645, 52881.7355913218, 53136.468635313155, 53989.73005134949, 81806.18193818224, 84196.0, 85482.14517854742, 86455.0, 87126.56436717777, 14052.718945620825, 14260.215688137252, 14361.138331700131, 14535.27323633793, 14535.709285814013, 14046.859531404556, 14127.64680882986, 14802.925985370004, 14998.175100369148, 15001.0, 13280.734385312433, 13466.20010651888, 13653.590392288248, 13843.861561384258, 14650.267486625839, 13916.304184790517, 13933.721325573635, 14583.708325833637, 14863.0, 15200.619984500476, 13121.329606885982, 13414.597562073153, 14321.856781432052, 14332.785008224677, 14765.557033289018, 11536.59621913229, 11960.975122888578, 11996.64010079699, 12189.817152742893, 12230.938845305716, 11614.187006909435, 11877.762444750884, 12055.21641093326, 12062.336571488653, 12145.14983951115], "value": 8175.39218933934, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 105.0, 111.0, 109.0, 113.0, 110.0, 110.0, 110.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 149.0, 169.0, 127.0, 144.0, 147.0, 122.0, 175.0, 115.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 163.0, 163.0, 161.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 172.0, 76.0, 75.0, 76.0, 76.0, 180.0, 77.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 152.0, 84.0, 83.0, 82.0, 148.0, 84.0, 84.0, 136.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 51.0, 50.0, 52.0, 52.0, 51.0, 51.0, 52.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 59.0, 62.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 77.0, 75.0, 73.0, 73.0, 77.0, 81.0, 78.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 138.0, 130.0, 127.0, 131.0, 121.0, 127.0, 120.0, 150.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 155.0, 160.0, 159.0, 160.0, 154.0, 155.0, 164.0, 149.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 65.0, 64.0, 61.0, 62.0, 66.0, 60.0, 65.0], "value": 63.1, "unit": "score"}]}]} 11:40:58 INFO - Return code: 0 11:40:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:58 ERROR - # TBPL SUCCESS # 11:40:58 INFO - Running post-action listener: _resource_record_post_action 11:40:58 INFO - [mozharness: 2016-09-30 18:40:58.716819Z] Finished run-tests step (success) 11:40:58 INFO - Running post-run listener: _resource_record_post_run 11:40:58 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287842304; Read time: 16; Write time: 280244 11:40:58 INFO - TinderboxPrint: CPU usage
13.2% 11:40:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 11:40:58 INFO - TinderboxPrint: I/O write bytes / time
287,842,304 / 280,244 11:40:58 INFO - TinderboxPrint: CPU idle
8,213.5 (86.8%) 11:40:58 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 11:40:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:58 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70115328; Read time: 0; Write time: 104456 11:40:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 217726976; Read time: 16; Write time: 175788 11:40:59 INFO - Running post-run listener: _upload_blobber_files 11:40:59 INFO - Blob upload gear active. 11:40:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:40:59 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'] 11:40:59 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 11:40:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:00 INFO - (blobuploader) - INFO - Done attempting. 11:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:04 INFO - (blobuploader) - INFO - Done attempting. 11:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:05 INFO - (blobuploader) - INFO - Done attempting. 11:41:05 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:05 INFO - Return code: 0 11:41:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6dd0bda0fe9b36a590c4506d9f06f869a08855f08a7c8634938826647a2ac3fe8ece5b0cea77a95abe4f861134fd3ddccc134bef9293541063eab862724eee4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1985b52726538ae4dc059bb3d7f18cc943cd2294c23e5cc5b791d8575f0c4edc4901a7e81ea8ea8d0785be08fe38497000623144f8487fd5930ed867ade9855b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34990bd6e345cc87a175ed4fda9f775afabdde6d68644c5bbfc02ed2ff6051c087a5d9c382fbc972bacde240ab09a0db8777d75d142d9612e886f47f76b9906f"} 11:41:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:05 INFO - Contents: 11:41:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6dd0bda0fe9b36a590c4506d9f06f869a08855f08a7c8634938826647a2ac3fe8ece5b0cea77a95abe4f861134fd3ddccc134bef9293541063eab862724eee4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1985b52726538ae4dc059bb3d7f18cc943cd2294c23e5cc5b791d8575f0c4edc4901a7e81ea8ea8d0785be08fe38497000623144f8487fd5930ed867ade9855b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34990bd6e345cc87a175ed4fda9f775afabdde6d68644c5bbfc02ed2ff6051c087a5d9c382fbc972bacde240ab09a0db8777d75d142d9612e886f47f76b9906f"} 11:41:05 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:05 INFO - Copying logs to upload dir... 11:41:05 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.814202 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-09-30 11:41:04.044329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 11:41:04.048089) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6dd0bda0fe9b36a590c4506d9f06f869a08855f08a7c8634938826647a2ac3fe8ece5b0cea77a95abe4f861134fd3ddccc134bef9293541063eab862724eee4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1985b52726538ae4dc059bb3d7f18cc943cd2294c23e5cc5b791d8575f0c4edc4901a7e81ea8ea8d0785be08fe38497000623144f8487fd5930ed867ade9855b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34990bd6e345cc87a175ed4fda9f775afabdde6d68644c5bbfc02ed2ff6051c087a5d9c382fbc972bacde240ab09a0db8777d75d142d9612e886f47f76b9906f"} build_url:https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/IYb56i9iRyysrPrVKo6zJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6dd0bda0fe9b36a590c4506d9f06f869a08855f08a7c8634938826647a2ac3fe8ece5b0cea77a95abe4f861134fd3ddccc134bef9293541063eab862724eee4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1985b52726538ae4dc059bb3d7f18cc943cd2294c23e5cc5b791d8575f0c4edc4901a7e81ea8ea8d0785be08fe38497000623144f8487fd5930ed867ade9855b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34990bd6e345cc87a175ed4fda9f775afabdde6d68644c5bbfc02ed2ff6051c087a5d9c382fbc972bacde240ab09a0db8777d75d142d9612e886f47f76b9906f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 11:41:04.073107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:41:04.073454) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475258993.411917-477211999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 11:41:04.156571) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 11:41:04.156914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 11:41:04.157205) ========= ========= Total master_lag: 0.14 =========