builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1475532416.33 results: success (0) buildid: 20161003130959 builduid: f49f7d6ae8464bb0bc8fc5b6545f05dd revision: 2f52a44aaffa799845357d77c74b371e81cba917 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.326213) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.326688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.327202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.364861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.365450) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 15:06:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-10-03 15:06:57 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125067 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.505194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.505514) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.556832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:56.557146) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2f52a44aaffa799845357d77c74b371e81cba917 --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 2f52a44aaffa799845357d77c74b371e81cba917 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 15:06:57,419 truncating revision to first 12 chars 2016-10-03 15:06:57,419 Setting DEBUG logging. 2016-10-03 15:06:57,419 attempt 1/10 2016-10-03 15:06:57,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2f52a44aaffa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 15:06:57,715 unpacking tar archive at: mozilla-beta-2f52a44aaffa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:57.212611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:57.212935) ========= script_repo_revision: 2f52a44aaffa799845357d77c74b371e81cba917 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:57.213329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:57.213744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 15:06:57.225578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-03 15:06:57.225895) ========= /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=8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:06:58 INFO - MultiFileLogger online at 20161003 15:06:58 in /builds/slave/test 15:06:58 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 15:06:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:06:58 INFO - {'append_to_log': False, 15:06:58 INFO - 'base_work_dir': '/builds/slave/test', 15:06:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:06:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:06:58 INFO - 'branch': 'Mozilla-Beta', 15:06:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:06:58 INFO - 'config_files': ('talos/linux_config.py',), 15:06:58 INFO - 'default_actions': ('clobber', 15:06:58 INFO - 'read-buildbot-config', 15:06:58 INFO - 'download-and-extract', 15:06:58 INFO - 'populate-webroot', 15:06:58 INFO - 'create-virtualenv', 15:06:58 INFO - 'install', 15:06:58 INFO - 'run-tests'), 15:06:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:06:58 INFO - 'download_minidump_stackwalk': True, 15:06:58 INFO - 'download_symbols': 'ondemand', 15:06:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:06:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:06:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:06:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:06:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:06:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:06:58 INFO - 'installer_path': 'installer.exe', 15:06:58 INFO - 'log_level': 'info', 15:06:58 INFO - 'log_name': 'talos', 15:06:58 INFO - 'log_to_console': True, 15:06:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:06:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:06:58 INFO - 'opt_config_files': (), 15:06:58 INFO - 'pip_index': False, 15:06:58 INFO - 'sps_profile': False, 15:06:58 INFO - 'sps_profile_interval': 0, 15:06:58 INFO - 'suite': 'dromaeojs-e10s', 15:06:58 INFO - 'system_bits': '32', 15:06:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:06:58 INFO - 'title': 'talos-linux64-ix-001', 15:06:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:06:58 INFO - 'use_talos_json': True, 15:06:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:06:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:06:58 INFO - 'work_dir': 'build'} 15:06:58 INFO - [mozharness: 2016-10-03 22:06:58.179015Z] Running clobber step. 15:06:58 INFO - Running pre-action listener: _resource_record_pre_action 15:06:58 INFO - Running main action method: clobber 15:06:58 INFO - rmtree: /builds/slave/test/build 15:06:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:06:58 INFO - Running post-action listener: _resource_record_post_action 15:06:58 INFO - [mozharness: 2016-10-03 22:06:58.636201Z] Finished clobber step (success) 15:06:58 INFO - [mozharness: 2016-10-03 22:06:58.636303Z] Running read-buildbot-config step. 15:06:58 INFO - Running pre-action listener: _resource_record_pre_action 15:06:58 INFO - Running main action method: read_buildbot_config 15:06:58 INFO - Using buildbot properties: 15:06:58 INFO - { 15:06:58 INFO - "project": "", 15:06:58 INFO - "product": "firefox", 15:06:58 INFO - "script_repo_revision": "production", 15:06:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:06:58 INFO - "repository": "", 15:06:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:06:58 INFO - "buildid": "20161003130959", 15:06:58 INFO - "pgo_build": "True", 15:06:58 INFO - "basedir": "/builds/slave/test", 15:06:58 INFO - "buildnumber": 266, 15:06:58 INFO - "slavename": "talos-linux64-ix-001", 15:06:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:06:58 INFO - "platform": "ubuntu64_hw", 15:06:58 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:06:58 INFO - "branch": "mozilla-beta", 15:06:58 INFO - "repo_path": "releases/mozilla-beta", 15:06:58 INFO - "revision": "2f52a44aaffa799845357d77c74b371e81cba917", 15:06:58 INFO - "stage_platform": "linux64-pgo", 15:06:58 INFO - "builduid": "f49f7d6ae8464bb0bc8fc5b6545f05dd", 15:06:58 INFO - "slavebuilddir": "test" 15:06:58 INFO - } 15:06:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:06:58 INFO - Running post-action listener: _resource_record_post_action 15:06:58 INFO - [mozharness: 2016-10-03 22:06:58.639061Z] Finished read-buildbot-config step (success) 15:06:58 INFO - [mozharness: 2016-10-03 22:06:58.639149Z] Running download-and-extract step. 15:06:58 INFO - Running pre-action listener: _resource_record_pre_action 15:06:58 INFO - Running main action method: download_and_extract 15:06:58 INFO - mkdir: /builds/slave/test/build/tests 15:06:58 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')]} 15:06:58 INFO - https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:06:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:06:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:06:58 INFO - retry: Failed, sleeping 30 seconds before retrying 15:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:07:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:07:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:07:28 INFO - retry: Failed, sleeping 60 seconds before retrying 15:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:08:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:08:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:08:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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! 15:08:28 INFO - Caught exception: HTTP Error 404: Not Found 15:08:28 INFO - Caught exception: HTTP Error 404: Not Found 15:08:28 INFO - Caught exception: HTTP Error 404: Not Found 15:08:28 INFO - trying https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:08:28 INFO - Downloading https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:08:29 INFO - Downloaded 1327 bytes. 15:08:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:08:29 INFO - Using the following test package requirements: 15:08:29 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:08:29 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:08:29 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:08:29 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'jsshell-linux-x86_64.zip'], 15:08:29 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:08:29 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:08:29 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:08:29 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:08:29 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:08:29 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:08:29 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:08:29 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:29 INFO - https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:08:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:08:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:08:29 INFO - retry: Failed, sleeping 30 seconds before retrying 15:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:08:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:08:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:08:59 INFO - retry: Failed, sleeping 60 seconds before retrying 15:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:09:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:09:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:09:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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! 15:09:59 INFO - Caught exception: HTTP Error 404: Not Found 15:09:59 INFO - Caught exception: HTTP Error 404: Not Found 15:09:59 INFO - Caught exception: HTTP Error 404: Not Found 15:09:59 INFO - trying https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:09:59 INFO - Downloading https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:10:00 INFO - Downloaded 21773823 bytes. 15:10:00 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'] 15:10:00 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 15:10:01 INFO - Return code: 0 15:10:01 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 15:10:01 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')]} 15:10:01 INFO - https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:10:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:10:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:10:01 INFO - retry: Failed, sleeping 30 seconds before retrying 15:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:10:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:10:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:10:31 INFO - retry: Failed, sleeping 60 seconds before retrying 15:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:11:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:11:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:11:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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! 15:11:31 INFO - Caught exception: HTTP Error 404: Not Found 15:11:31 INFO - Caught exception: HTTP Error 404: Not Found 15:11:31 INFO - Caught exception: HTTP Error 404: Not Found 15:11:31 INFO - trying https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:11:32 INFO - Downloaded 21773823 bytes. 15:11:32 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'] 15:11:32 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 15:11:33 INFO - Return code: 0 15:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:33 INFO - https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:11:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:11:33 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:11:33 INFO - retry: Failed, sleeping 30 seconds before retrying 15:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:12:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:12:03 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:12:03 INFO - retry: Failed, sleeping 60 seconds before retrying 15:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:13:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:13:03 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:13:03 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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! 15:13:03 INFO - Caught exception: HTTP Error 404: Not Found 15:13:03 INFO - Caught exception: HTTP Error 404: Not Found 15:13:03 INFO - Caught exception: HTTP Error 404: Not Found 15:13:03 INFO - trying https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:13:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:13:04 INFO - Downloaded 14413740 bytes. 15:13:04 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'] 15:13:04 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 15:13:04 INFO - Return code: 0 15:13: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')]} 15:13:04 INFO - https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:13:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:13:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:13:04 INFO - retry: Failed, sleeping 30 seconds before retrying 15:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:13:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:13:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:13:34 INFO - retry: Failed, sleeping 60 seconds before retrying 15:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:14:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:14:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:14:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bakuT_8zR-CFGYbgmCQvxg/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! 15:14:34 INFO - Caught exception: HTTP Error 404: Not Found 15:14:34 INFO - Caught exception: HTTP Error 404: Not Found 15:14:34 INFO - Caught exception: HTTP Error 404: Not Found 15:14:34 INFO - trying https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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 15:14:36 INFO - Downloaded 56784716 bytes. 15:14:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:14:36 INFO - mkdir: /builds/slave/test/properties 15:14:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:14:36 INFO - Writing to file /builds/slave/test/properties/build_url 15:14:36 INFO - Contents: 15:14:36 INFO - build_url:https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:14:36 INFO - Running post-action listener: _resource_record_post_action 15:14:36 INFO - Running post-action listener: set_extra_try_arguments 15:14:36 INFO - [mozharness: 2016-10-03 22:14:36.734984Z] Finished download-and-extract step (success) 15:14:36 INFO - [mozharness: 2016-10-03 22:14:36.735219Z] Running populate-webroot step. 15:14:36 INFO - Running pre-action listener: _resource_record_pre_action 15:14:36 INFO - Running main action method: populate_webroot 15:14:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:14:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:14:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:14:36 INFO - '--tppagecycles', 15:14:36 INFO - '7'], 15:14:36 INFO - 'tests': ['tsvgm']}}, 15:14:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:14:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:14:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:14:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:14:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['damp', 'tps']}, 15:14:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'tests': ['damp', 'tps']}, 15:14:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['dromaeo_dom']}, 15:14:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:14:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['basic_compositor_video']}, 15:14:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:14:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['a11yr', 15:14:36 INFO - 'ts_paint', 15:14:36 INFO - 'tpaint', 15:14:36 INFO - 'sessionrestore', 15:14:36 INFO - 'sessionrestore_no_auto_restore', 15:14:36 INFO - 'tabpaint']}, 15:14:36 INFO - 'other-e10s': {'tests': ['a11yr', 15:14:36 INFO - 'ts_paint', 15:14:36 INFO - 'tpaint', 15:14:36 INFO - 'sessionrestore', 15:14:36 INFO - 'sessionrestore_no_auto_restore', 15:14:36 INFO - 'tabpaint']}, 15:14:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:14:36 INFO - 'ts_paint', 15:14:36 INFO - 'tpaint', 15:14:36 INFO - 'sessionrestore', 15:14:36 INFO - 'sessionrestore_no_auto_restore', 15:14:36 INFO - 'tabpaint']}, 15:14:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:14:36 INFO - 'ts_paint', 15:14:36 INFO - 'tpaint', 15:14:36 INFO - 'sessionrestore', 15:14:36 INFO - 'sessionrestore_no_auto_restore', 15:14:36 INFO - 'tabpaint']}, 15:14:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['a11yr', 15:14:36 INFO - 'ts_paint', 15:14:36 INFO - 'tpaint', 15:14:36 INFO - 'sessionrestore', 15:14:36 INFO - 'sessionrestore_no_auto_restore', 15:14:36 INFO - 'tabpaint']}, 15:14:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['a11yr', 15:14:36 INFO - 'ts_paint', 15:14:36 INFO - 'tpaint', 15:14:36 INFO - 'sessionrestore', 15:14:36 INFO - 'sessionrestore_no_auto_restore', 15:14:36 INFO - 'tabpaint']}, 15:14:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['tsvgx', 15:14:36 INFO - 'tsvgr_opacity', 15:14:36 INFO - 'tart', 15:14:36 INFO - 'tscrollx', 15:14:36 INFO - 'cart']}, 15:14:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:14:36 INFO - 'tsvgr_opacity', 15:14:36 INFO - 'tart', 15:14:36 INFO - 'tscrollx', 15:14:36 INFO - 'cart']}, 15:14:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'talos_options': ['--disable-e10s'], 15:14:36 INFO - 'tests': ['tp5o']}, 15:14:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'tests': ['tp5o']}, 15:14:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'talos_options': ['--disable-e10s', 15:14:36 INFO - '--xperf_path', 15:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:36 INFO - 'tests': ['tp5n']}, 15:14:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:36 INFO - 'talos_options': ['--xperf_path', 15:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:36 INFO - 'tests': ['tp5n']}}, 15:14:36 INFO - 'talos.zip': {'path': '', 15:14:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:14:36 INFO - Running post-action listener: _resource_record_post_action 15:14:36 INFO - [mozharness: 2016-10-03 22:14:36.755398Z] Finished populate-webroot step (success) 15:14:36 INFO - [mozharness: 2016-10-03 22:14:36.755487Z] Running create-virtualenv step. 15:14:36 INFO - Running pre-action listener: _resource_record_pre_action 15:14:36 INFO - Running main action method: create_virtualenv 15:14:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:14:36 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 15:14:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:14:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:14:36 INFO - Using real prefix '/usr' 15:14:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:14:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:39 INFO - Installing pip.................done. 15:14:39 INFO - Return code: 0 15:14:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:39 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:39 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 15:14:39 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 15:14:39 INFO - Using env: {'DISPLAY': ':0', 15:14:39 INFO - 'HOME': '/home/cltbld', 15:14:39 INFO - 'LANG': 'en_US.UTF-8', 15:14:39 INFO - 'LANGUAGE': 'en_US:en', 15:14:39 INFO - 'LOGNAME': 'cltbld', 15:14:39 INFO - 'MAIL': '/var/mail/cltbld', 15:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:39 INFO - 'MOZ_NO_REMOTE': '1', 15:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:39 INFO - 'NO_EM_RESTART': '1', 15:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:39 INFO - 'PWD': '/builds/slave/test', 15:14:39 INFO - 'SHELL': '/bin/bash', 15:14:39 INFO - 'SHLVL': '1', 15:14:39 INFO - 'TERM': 'linux', 15:14:39 INFO - 'TMOUT': '86400', 15:14:39 INFO - 'USER': 'cltbld', 15:14:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:39 INFO - '_': '/tools/buildbot/bin/python'} 15:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:39 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 15:14:39 INFO - Cleaning up... 15:14:39 INFO - Return code: 0 15:14:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:39 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:39 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 15:14:39 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 15:14:39 INFO - Using env: {'DISPLAY': ':0', 15:14:39 INFO - 'HOME': '/home/cltbld', 15:14:39 INFO - 'LANG': 'en_US.UTF-8', 15:14:39 INFO - 'LANGUAGE': 'en_US:en', 15:14:39 INFO - 'LOGNAME': 'cltbld', 15:14:39 INFO - 'MAIL': '/var/mail/cltbld', 15:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:39 INFO - 'MOZ_NO_REMOTE': '1', 15:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:39 INFO - 'NO_EM_RESTART': '1', 15:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:39 INFO - 'PWD': '/builds/slave/test', 15:14:39 INFO - 'SHELL': '/bin/bash', 15:14:39 INFO - 'SHLVL': '1', 15:14:39 INFO - 'TERM': 'linux', 15:14:39 INFO - 'TMOUT': '86400', 15:14:39 INFO - 'USER': 'cltbld', 15:14:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:39 INFO - '_': '/tools/buildbot/bin/python'} 15:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:39 INFO - Downloading/unpacking psutil>=3.1.1 15:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:41 INFO - Installing collected packages: psutil 15:14:41 INFO - Running setup.py install for psutil 15:14:41 INFO - building 'psutil._psutil_linux' extension 15:14:41 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 15:14:41 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 15:14:42 INFO - building 'psutil._psutil_posix' extension 15:14:42 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 15:14:42 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 15:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:42 INFO - Successfully installed psutil 15:14:42 INFO - Cleaning up... 15:14:42 INFO - Return code: 0 15:14:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:42 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:42 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 15:14:42 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 15:14:42 INFO - Using env: {'DISPLAY': ':0', 15:14:42 INFO - 'HOME': '/home/cltbld', 15:14:42 INFO - 'LANG': 'en_US.UTF-8', 15:14:42 INFO - 'LANGUAGE': 'en_US:en', 15:14:42 INFO - 'LOGNAME': 'cltbld', 15:14:42 INFO - 'MAIL': '/var/mail/cltbld', 15:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:42 INFO - 'MOZ_NO_REMOTE': '1', 15:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:42 INFO - 'NO_EM_RESTART': '1', 15:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:42 INFO - 'PWD': '/builds/slave/test', 15:14:42 INFO - 'SHELL': '/bin/bash', 15:14:42 INFO - 'SHLVL': '1', 15:14:42 INFO - 'TERM': 'linux', 15:14:42 INFO - 'TMOUT': '86400', 15:14:42 INFO - 'USER': 'cltbld', 15:14:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:42 INFO - '_': '/tools/buildbot/bin/python'} 15:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:14:42 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 15:14:42 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 15:14:42 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 15:14:42 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 15:14:42 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 15:14:42 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 15:14:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:14:44 INFO - Installing collected packages: mozsystemmonitor 15:14:44 INFO - Running setup.py install for mozsystemmonitor 15:14:44 INFO - Successfully installed mozsystemmonitor 15:14:44 INFO - Cleaning up... 15:14:44 INFO - Return code: 0 15:14:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:14:44 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')]} 15:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:44 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')]} 15:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:44 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:44 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 15:14:44 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 15:14:44 INFO - Using env: {'DISPLAY': ':0', 15:14:44 INFO - 'HOME': '/home/cltbld', 15:14:44 INFO - 'LANG': 'en_US.UTF-8', 15:14:44 INFO - 'LANGUAGE': 'en_US:en', 15:14:44 INFO - 'LOGNAME': 'cltbld', 15:14:44 INFO - 'MAIL': '/var/mail/cltbld', 15:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:44 INFO - 'MOZ_NO_REMOTE': '1', 15:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:44 INFO - 'NO_EM_RESTART': '1', 15:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:44 INFO - 'PWD': '/builds/slave/test', 15:14:44 INFO - 'SHELL': '/bin/bash', 15:14:44 INFO - 'SHLVL': '1', 15:14:44 INFO - 'TERM': 'linux', 15:14:44 INFO - 'TMOUT': '86400', 15:14:44 INFO - 'USER': 'cltbld', 15:14:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:44 INFO - '_': '/tools/buildbot/bin/python'} 15:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:44 INFO - Downloading/unpacking jsonschema==2.5.1 15:14:44 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 15:14:44 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 15:14:44 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 15:14:44 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 15:14:44 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 15:14:44 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 15:14:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:14:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:14:46 INFO - warning: no files found matching '*.txt' 15:14:46 INFO - no previously-included directories found matching 'build' 15:14:46 INFO - no previously-included directories found matching 'dist' 15:14:46 INFO - no previously-included directories found matching '.git*' 15:14:47 INFO - Installing collected packages: jsonschema, functools32 15:14:47 INFO - Running setup.py install for functools32 15:14:47 INFO - warning: no files found matching '*.txt' 15:14:47 INFO - no previously-included directories found matching 'build' 15:14:47 INFO - no previously-included directories found matching 'dist' 15:14:47 INFO - no previously-included directories found matching '.git*' 15:14:47 INFO - Successfully installed jsonschema functools32 15:14:47 INFO - Cleaning up... 15:14:47 INFO - Return code: 0 15:14:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:47 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:47 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 15:14:47 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 15:14:47 INFO - Using env: {'DISPLAY': ':0', 15:14:47 INFO - 'HOME': '/home/cltbld', 15:14:47 INFO - 'LANG': 'en_US.UTF-8', 15:14:47 INFO - 'LANGUAGE': 'en_US:en', 15:14:47 INFO - 'LOGNAME': 'cltbld', 15:14:47 INFO - 'MAIL': '/var/mail/cltbld', 15:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:47 INFO - 'MOZ_NO_REMOTE': '1', 15:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:47 INFO - 'NO_EM_RESTART': '1', 15:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:47 INFO - 'PWD': '/builds/slave/test', 15:14:47 INFO - 'SHELL': '/bin/bash', 15:14:47 INFO - 'SHLVL': '1', 15:14:47 INFO - 'TERM': 'linux', 15:14:47 INFO - 'TMOUT': '86400', 15:14:47 INFO - 'USER': 'cltbld', 15:14:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:47 INFO - '_': '/tools/buildbot/bin/python'} 15:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:14:47 INFO - Cleaning up... 15:14:47 INFO - Return code: 0 15:14:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:47 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:47 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 15:14:47 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 15:14:47 INFO - Using env: {'DISPLAY': ':0', 15:14:47 INFO - 'HOME': '/home/cltbld', 15:14:47 INFO - 'LANG': 'en_US.UTF-8', 15:14:47 INFO - 'LANGUAGE': 'en_US:en', 15:14:47 INFO - 'LOGNAME': 'cltbld', 15:14:47 INFO - 'MAIL': '/var/mail/cltbld', 15:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:47 INFO - 'MOZ_NO_REMOTE': '1', 15:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:47 INFO - 'NO_EM_RESTART': '1', 15:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:47 INFO - 'PWD': '/builds/slave/test', 15:14:47 INFO - 'SHELL': '/bin/bash', 15:14:47 INFO - 'SHLVL': '1', 15:14:47 INFO - 'TERM': 'linux', 15:14:47 INFO - 'TMOUT': '86400', 15:14:47 INFO - 'USER': 'cltbld', 15:14:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:47 INFO - '_': '/tools/buildbot/bin/python'} 15:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:14:47 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 15:14:47 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 15:14:47 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 15:14:47 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 15:14:47 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 15:14:47 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 15:14:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:14:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:14:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 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 15:14:49 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 15:14:50 INFO - Downloading docopt-0.6.1.tar.gz 15:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:14:50 INFO - Installing collected packages: blobuploader, requests, docopt 15:14:50 INFO - Running setup.py install for blobuploader 15:14:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:14:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:14:50 INFO - Running setup.py install for requests 15:14:50 INFO - Running setup.py install for docopt 15:14:50 INFO - Successfully installed blobuploader requests docopt 15:14:50 INFO - Cleaning up... 15:14:50 INFO - Return code: 0 15:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:50 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:50 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 15:14:50 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 15:14:50 INFO - Using env: {'DISPLAY': ':0', 15:14:50 INFO - 'HOME': '/home/cltbld', 15:14:50 INFO - 'LANG': 'en_US.UTF-8', 15:14:50 INFO - 'LANGUAGE': 'en_US:en', 15:14:50 INFO - 'LOGNAME': 'cltbld', 15:14:50 INFO - 'MAIL': '/var/mail/cltbld', 15:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:50 INFO - 'MOZ_NO_REMOTE': '1', 15:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:50 INFO - 'NO_EM_RESTART': '1', 15:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:50 INFO - 'PWD': '/builds/slave/test', 15:14:50 INFO - 'SHELL': '/bin/bash', 15:14:50 INFO - 'SHLVL': '1', 15:14:50 INFO - 'TERM': 'linux', 15:14:50 INFO - 'TMOUT': '86400', 15:14:50 INFO - 'USER': 'cltbld', 15:14:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:50 INFO - '_': '/tools/buildbot/bin/python'} 15:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:51 INFO - Running setup.py (path:/tmp/pip-Jj9ZRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:51 INFO - Running setup.py (path:/tmp/pip-QKScmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:51 INFO - Running setup.py (path:/tmp/pip-WElOY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:51 INFO - Running setup.py (path:/tmp/pip-feHXn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:51 INFO - Running setup.py (path:/tmp/pip-Rm2BlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:51 INFO - Running setup.py (path:/tmp/pip-OrqRHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:51 INFO - Running setup.py (path:/tmp/pip-cxgmjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:51 INFO - Running setup.py (path:/tmp/pip-hadmN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:51 INFO - Running setup.py (path:/tmp/pip-iC8cQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:51 INFO - Running setup.py (path:/tmp/pip-ET2J3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:51 INFO - Running setup.py (path:/tmp/pip-zH_eZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:51 INFO - Running setup.py (path:/tmp/pip-h8TBUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:51 INFO - Running setup.py (path:/tmp/pip-WnCw2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:52 INFO - Running setup.py (path:/tmp/pip-MiE7rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:52 INFO - Running setup.py (path:/tmp/pip-yBS1d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:52 INFO - Running setup.py (path:/tmp/pip-K4egQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:52 INFO - Running setup.py (path:/tmp/pip-9sLbBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:52 INFO - Running setup.py install for manifestparser 15:14:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:52 INFO - Running setup.py install for mozcrash 15:14:52 INFO - Running setup.py install for mozdebug 15:14:52 INFO - Running setup.py install for mozdevice 15:14:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:14:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:52 INFO - Running setup.py install for mozfile 15:14:52 INFO - Running setup.py install for mozhttpd 15:14:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:52 INFO - Running setup.py install for mozinfo 15:14:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Running setup.py install for mozInstall 15:14:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Running setup.py install for mozleak 15:14:53 INFO - Running setup.py install for mozlog 15:14:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Running setup.py install for moznetwork 15:14:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Running setup.py install for mozprocess 15:14:53 INFO - Running setup.py install for mozprofile 15:14:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Running setup.py install for mozrunner 15:14:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:53 INFO - Running setup.py install for mozscreenshot 15:14:53 INFO - Running setup.py install for moztest 15:14:54 INFO - Running setup.py install for mozversion 15:14:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:54 INFO - Cleaning up... 15:14:54 INFO - Return code: 0 15:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:54 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:54 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 15:14:54 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 15:14:54 INFO - Using env: {'DISPLAY': ':0', 15:14:54 INFO - 'HOME': '/home/cltbld', 15:14:54 INFO - 'LANG': 'en_US.UTF-8', 15:14:54 INFO - 'LANGUAGE': 'en_US:en', 15:14:54 INFO - 'LOGNAME': 'cltbld', 15:14:54 INFO - 'MAIL': '/var/mail/cltbld', 15:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:54 INFO - 'MOZ_NO_REMOTE': '1', 15:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:54 INFO - 'NO_EM_RESTART': '1', 15:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:54 INFO - 'PWD': '/builds/slave/test', 15:14:54 INFO - 'SHELL': '/bin/bash', 15:14:54 INFO - 'SHLVL': '1', 15:14:54 INFO - 'TERM': 'linux', 15:14:54 INFO - 'TMOUT': '86400', 15:14:54 INFO - 'USER': 'cltbld', 15:14:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:54 INFO - '_': '/tools/buildbot/bin/python'} 15:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:54 INFO - Running setup.py (path:/tmp/pip-Wnlv0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:54 INFO - Running setup.py (path:/tmp/pip-jpjMDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:54 INFO - Running setup.py (path:/tmp/pip-eC_g0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:54 INFO - Running setup.py (path:/tmp/pip-ltagmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:54 INFO - Running setup.py (path:/tmp/pip-qREkyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:54 INFO - Running setup.py (path:/tmp/pip-VZGr2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:54 INFO - Running setup.py (path:/tmp/pip-UaTOCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:54 INFO - Running setup.py (path:/tmp/pip-Ohc1p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:54 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)) 15:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:54 INFO - Running setup.py (path:/tmp/pip-FpsOPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:55 INFO - Running setup.py (path:/tmp/pip-rhfqzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:55 INFO - Running setup.py (path:/tmp/pip-H_jcPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:55 INFO - Running setup.py (path:/tmp/pip-rk1wXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:55 INFO - Running setup.py (path:/tmp/pip-aTmZIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:55 INFO - Running setup.py (path:/tmp/pip-U3ZMdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:55 INFO - Running setup.py (path:/tmp/pip-Orw6S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:55 INFO - Running setup.py (path:/tmp/pip-Jlz1LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:55 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)) 15:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:55 INFO - Running setup.py (path:/tmp/pip-_LTmfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:55 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)) 15:14:55 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)) 15:14:55 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)) 15:14:55 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)) 15:14:55 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)) 15:14:55 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)) 15:14:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:57 INFO - Downloading blessings-1.6.tar.gz 15:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:57 INFO - Installing collected packages: blessings 15:14:57 INFO - Running setup.py install for blessings 15:14:57 INFO - Successfully installed blessings 15:14:57 INFO - Cleaning up... 15:14:57 INFO - Return code: 0 15:14:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:57 INFO - Reading from file tmpfile_stdout 15:14:57 INFO - Current package versions: 15:14:57 INFO - argparse == 1.2.1 15:14:57 INFO - blessings == 1.6 15:14:57 INFO - blobuploader == 1.2.4 15:14:57 INFO - docopt == 0.6.1 15:14:57 INFO - functools32 == 3.2.3-2 15:14:57 INFO - jsonschema == 2.5.1 15:14:57 INFO - manifestparser == 1.1 15:14:57 INFO - mozInstall == 1.12 15:14:57 INFO - mozcrash == 0.17 15:14:57 INFO - mozdebug == 0.1 15:14:57 INFO - mozdevice == 0.48 15:14:57 INFO - mozfile == 1.2 15:14:57 INFO - mozhttpd == 0.7 15:14:57 INFO - mozinfo == 0.9 15:14:57 INFO - mozleak == 0.1 15:14:57 INFO - mozlog == 3.3 15:14:57 INFO - moznetwork == 0.27 15:14:57 INFO - mozprocess == 0.23 15:14:57 INFO - mozprofile == 0.28 15:14:57 INFO - mozrunner == 6.12 15:14:57 INFO - mozscreenshot == 0.1 15:14:57 INFO - mozsystemmonitor == 0.3 15:14:57 INFO - moztest == 0.7 15:14:57 INFO - mozversion == 1.4 15:14:57 INFO - psutil == 3.1.1 15:14:57 INFO - requests == 1.2.3 15:14:57 INFO - wsgiref == 0.1.2 15:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:57 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 15:14:57 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 15:14:57 INFO - Using env: {'DISPLAY': ':0', 15:14:57 INFO - 'HOME': '/home/cltbld', 15:14:57 INFO - 'LANG': 'en_US.UTF-8', 15:14:57 INFO - 'LANGUAGE': 'en_US:en', 15:14:57 INFO - 'LOGNAME': 'cltbld', 15:14:57 INFO - 'MAIL': '/var/mail/cltbld', 15:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:57 INFO - 'MOZ_NO_REMOTE': '1', 15:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:57 INFO - 'NO_EM_RESTART': '1', 15:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:57 INFO - 'PWD': '/builds/slave/test', 15:14:57 INFO - 'SHELL': '/bin/bash', 15:14:57 INFO - 'SHLVL': '1', 15:14:57 INFO - 'TERM': 'linux', 15:14:57 INFO - 'TMOUT': '86400', 15:14:57 INFO - 'USER': 'cltbld', 15:14:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:57 INFO - '_': '/tools/buildbot/bin/python'} 15:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 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)) 15:14:58 INFO - Cleaning up... 15:14:58 INFO - Return code: 0 15:14:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:14:58 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')]} 15:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:58 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')]} 15:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:58 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 0x14cb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', '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 15:14:58 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 15:14:58 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 15:14:58 INFO - Using env: {'DISPLAY': ':0', 15:14:58 INFO - 'HOME': '/home/cltbld', 15:14:58 INFO - 'LANG': 'en_US.UTF-8', 15:14:58 INFO - 'LANGUAGE': 'en_US:en', 15:14:58 INFO - 'LOGNAME': 'cltbld', 15:14:58 INFO - 'MAIL': '/var/mail/cltbld', 15:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:58 INFO - 'MOZ_NO_REMOTE': '1', 15:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:58 INFO - 'NO_EM_RESTART': '1', 15:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:58 INFO - 'PWD': '/builds/slave/test', 15:14:58 INFO - 'SHELL': '/bin/bash', 15:14:58 INFO - 'SHLVL': '1', 15:14:58 INFO - 'TERM': 'linux', 15:14:58 INFO - 'TMOUT': '86400', 15:14:58 INFO - 'USER': 'cltbld', 15:14:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:58 INFO - '_': '/tools/buildbot/bin/python'} 15:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:14:58 INFO - Cleaning up... 15:14:58 INFO - Return code: 0 15:14:58 INFO - Running post-action listener: _resource_record_post_action 15:14:58 INFO - Running post-action listener: _start_resource_monitoring 15:14:58 INFO - Starting resource monitoring. 15:14:58 INFO - [mozharness: 2016-10-03 22:14:58.419799Z] Finished create-virtualenv step (success) 15:14:58 INFO - [mozharness: 2016-10-03 22:14:58.420279Z] Running install step. 15:14:58 INFO - Running pre-action listener: _resource_record_pre_action 15:14:58 INFO - Running main action method: install 15:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:58 INFO - Reading from file tmpfile_stdout 15:14:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:58 INFO - Reading from file tmpfile_stdout 15:14:58 INFO - Output received: 15:14:58 INFO - Usage: mozinstall [options] installer 15:14:58 INFO - Options: 15:14:58 INFO - -h, --help show this help message and exit 15:14:58 INFO - -d DEST, --destination=DEST 15:14:58 INFO - Directory to install application into. [default: 15:14:58 INFO - "/builds/slave/test"] 15:14:58 INFO - --app=APP Application being installed. [default: firefox] 15:14:58 INFO - mkdir: /builds/slave/test/build/application 15:14:58 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'] 15:14:58 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 15:15:12 INFO - Reading from file tmpfile_stdout 15:15:12 INFO - Output received: 15:15:12 INFO - /builds/slave/test/build/application/firefox/firefox 15:15:12 INFO - Running post-action listener: _resource_record_post_action 15:15:12 INFO - [mozharness: 2016-10-03 22:15:12.220961Z] Finished install step (success) 15:15:12 INFO - [mozharness: 2016-10-03 22:15:12.221237Z] Running run-tests step. 15:15:12 INFO - Running pre-action listener: _resource_record_pre_action 15:15:12 INFO - Running main action method: run_tests 15:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:12 INFO - Python 2.7.3 15:15:12 INFO - Return code: 0 15:15:12 INFO - grabbing minidump binary from tooltool 15:15:12 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')]} 15:15:12 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 0x1789570>, '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 0x178a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:12 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 15:15:12 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 15:15:12 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 15:15:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:12 INFO - Return code: 0 15:15:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:15:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:15:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:12 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/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:15:12 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/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:15:12 INFO - Using env: {'DISPLAY': ':0', 15:15:12 INFO - 'HOME': '/home/cltbld', 15:15:12 INFO - 'LANG': 'en_US.UTF-8', 15:15:12 INFO - 'LANGUAGE': 'en_US:en', 15:15:12 INFO - 'LOGNAME': 'cltbld', 15:15:12 INFO - 'MAIL': '/var/mail/cltbld', 15:15:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:12 INFO - 'MOZ_NO_REMOTE': '1', 15:15:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:12 INFO - 'NO_EM_RESTART': '1', 15:15:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:12 INFO - 'PWD': '/builds/slave/test', 15:15:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:12 INFO - 'SHELL': '/bin/bash', 15:15:12 INFO - 'SHLVL': '1', 15:15:12 INFO - 'TERM': 'linux', 15:15:12 INFO - 'TMOUT': '86400', 15:15:12 INFO - 'USER': 'cltbld', 15:15:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595', 15:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:12 INFO - '_': '/tools/buildbot/bin/python'} 15:15:12 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/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:15:12 INFO - mozversion application_buildid: 20161003130959 15:15:12 INFO - mozversion application_changeset: 2f52a44aaffa799845357d77c74b371e81cba917 15:15:12 INFO - mozversion application_display_name: Firefox 15:15:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:12 INFO - mozversion application_name: Firefox 15:15:12 INFO - mozversion application_remotingname: firefox 15:15:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:15:12 INFO - mozversion application_vendor: Mozilla 15:15:12 INFO - mozversion application_version: 50.0 15:15:12 INFO - mozversion platform_buildid: 20161003130959 15:15:12 INFO - mozversion platform_changeset: 2f52a44aaffa799845357d77c74b371e81cba917 15:15:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:15:12 INFO - mozversion platform_version: 50.0 15:15:12 INFO - using testdate: 1475532912 15:15:12 INFO - actual date: 1475532912 15:15:12 INFO - starting webserver on 'localhost:37514' 15:15:12 INFO - SUITE-START | Running 2 tests 15:15:12 INFO - TEST-START | dromaeo_css 15:15:12 INFO - operating with platform_type : linux_ 15:15:12 INFO - Initialising browser for dromaeo_css test... 15:15:12 INFO - TEST-INFO | started process 29133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8YzDH/profile http://localhost:37514/getInfo.html) 15:15:16 INFO - PROCESS | 29133 | __metrics Screen width/height:1600/1200 15:15:16 INFO - PROCESS | 29133 | colorDepth:24 15:15:16 INFO - PROCESS | 29133 | Browser inner width/height: 1024/697 15:15:16 INFO - PROCESS | 29133 | __metrics 15:15:17 ERROR - PROCESS | 29133 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:15:18 INFO - TEST-INFO | 29133: exit 0 15:15:18 INFO - Browser initialized. 15:15:18 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:18 INFO - TEST-INFO | started process 29260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8YzDH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:30 INFO - PROCESS | 29260 | RSS: Main: 149934080 15:15:30 INFO - PROCESS | 29260 | 15:16:19 INFO - PROCESS | 29260 | 1475532979836 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] 15:18:28 INFO - PROCESS | 29260 | Cycle 1(1): loaded http://localhost:37514/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37514/tests/dromaeo/cssquery-ext.html) 15:18:29 INFO - PROCESS | 29260 | RSS: Main: 158322688 15:18:29 INFO - PROCESS | 29260 | 15:21:31 INFO - PROCESS | 29260 | Cycle 1(1): loaded http://localhost:37514/tests/dromaeo/cssquery-ext.html (next: http://localhost:37514/tests/dromaeo/cssquery-jquery.html) 15:21:32 INFO - PROCESS | 29260 | RSS: Main: 155496448 15:21:32 INFO - PROCESS | 29260 | 15:24:33 INFO - PROCESS | 29260 | Cycle 1(1): loaded http://localhost:37514/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37514/tests/dromaeo/cssquery-mootools.html) 15:24:34 INFO - PROCESS | 29260 | RSS: Main: 155185152 15:24:34 INFO - PROCESS | 29260 | 15:27:36 INFO - PROCESS | 29260 | Cycle 1(1): loaded http://localhost:37514/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37514/tests/dromaeo/cssquery-prototype.html) 15:27:36 INFO - PROCESS | 29260 | RSS: Main: 156221440 15:27:36 INFO - PROCESS | 29260 | 15:30:39 INFO - PROCESS | 29260 | Cycle 1(1): loaded http://localhost:37514/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37514/tests/dromaeo/cssquery-yui.html) 15:30:39 INFO - PROCESS | 29260 | RSS: Main: 157184000 15:30:39 INFO - PROCESS | 29260 | 15:33:41 INFO - PROCESS | 29260 | Cycle 1(1): loaded http://localhost:37514/tests/dromaeo/cssquery-yui.html (next: http://localhost:37514/tests/dromaeo/cssquery-dojo.html) 15:33:42 INFO - PROCESS | 29260 | RSS: Main: 157462528 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | __start_tp_report 15:33:42 INFO - PROCESS | 29260 | _x_x_mozilla_page_load 15:33:42 INFO - PROCESS | 29260 | _x_x_mozilla_page_load_details 15:33:42 INFO - PROCESS | 29260 | |i|pagename|runs| 15:33:42 INFO - PROCESS | 29260 | |0;dojo.html;3341.097903566037;3350.983245083775;3362.8822991195298;3373.865045398184;3382.3066271414364;5835.299764028317;5900.675462849542;5924.555658325627;5926.911096333559;5936.37668044855;5759.5968282220265;5761.999999999989;5768.307803063628;5768.39431859655;5769.942300576993;5202.479752024796;5243.86890327741;5281.735913204344;5316.5215130638235;5365.543928766059;5328.120860058086;5335.599830012745;5336.359636843584;5360.115580929161;5365.543928766059;5275.947240527584;5282.973585132069;5287.894242115155;5313.920291195635;5327.680339179642;5363.115086010804;5443.074677304868;5465.808696695596;5478.479544443271;5511.53151982082;5345.118055520835;5416.593755468356;5422.91865622016;5438.184272359138;5447.836564903019;5697.287839020122;5736.282964629421;5867.178594996704;5912.846994836009;5986.07215881539;6190.969045154746;6265.154204182422;6319.6524191169465;6321.083442900754;6343.175387199681;6360.586561873463;6361.522885783538;6361.968190159019;6362.650054247015;6380.330065343165;5650.152477128422;5849.298084229919;5855.443732845373;5856.472917437409;5906.675132867691;6372.330905254974;6482.286948435668;6499.5775274607;6500.707468163944;6565.376289252514;6227.314995350508;6282.968585157045;6285.465735412541;6289.96855015722;6297.464715499143;6129.080637904261;6139.969300153471;6314.0528920661345;6395.712192951329;6401.615903045832;6125.327021303102;6206.689665516707;6210.875782484325;6212.627242365473;6217.782377616762;6196.287426945869;6197.721102550396;6198.473129784019;6202.937970620326;6217.782377616762;4623.583877451046;4720.834770783006;4754.049190161982;4768.213244814567;4768.737719425465;4198.8110535026;4257.084726783694;4271.765052922119;4293.2701440755145;4307.698461107692;6037.396260373927;6099.634021958696;6108.5418593605655;6129.08063790435;6136.447719705248;6106.794380079898;6141.424638644238;6327.145835312174;6385.584936979081;6420.486361091102;6016;6083.300420451616;6101.145839582462;6112.572119951649;6127.509799216052;5263.078961181778;5267;5268.683878967274;5272.367315922113;5285.471452854684;6283.622982621057;6423.261324947597;6447.6453795041725;6567.408933196035;6572.605643661395;6360.968195158995;6364.745410183726;6372.617642941438;6385.45723613498;6396.71214795326;6537.640429776408;6570.605763654196;6575.704093315908;6581.276059633532;6617.735290588323;5912.113183022409;6109.1010297800785;6133.106994857385;6225.564210505402;6236.968815155895;6351.745930162741;6368.044793280859;6373.808785736435;6375.5218358624215;6377.1390862233;6196.535259855439;6207.099970504342;6216.347283535164;6221.782237621662;6221.9377806221355;6000.69996500182;6104.847378815565;6125.907024958145;6186.721597528212;6193.504519638328;6167.599106058092;6172.197614310111;6207.81376558704;6209;6211.81364559064;6217.09852071438;6221.875562488634;6234.594751341148;6253.468455181361;6256.311805701278;5914.408559144051;5931.762729490944;6018.097285407224;6078.3617720138745;6083.239595050619 15:33:42 INFO - PROCESS | 29260 | |1;ext.html;588.6468119128523;616.4790751814717;643.3405759096927;668.1748041169155;697.6093387702883;46899;47542.28686569696;47616.761916190415;47937.28094078592;48053.279200812016;47564.28653570199;48196;48240;48261.276080858814;48338.75830620851;8831.161039701234;9011.504367259831;9029.006809250977;9036.819263614723;9040.412373195753;9141.405808622452;9242.953785231099;9248.352615316931;9250.121238482334;9274.304427167956;9345.345825792198;9361.531923403803;9363.625454981793;9364.953175234148;9365.063493650614;9272.211861991738;9274.860877086849;9279.95360023199;9306.208972237368;9334.626614935394;9153.725388238363;9219.90780092204;9222.815543689156;9249.260059195316;9295;37737.43393849095;38036;38140.42789358162;38150.046248843726;38274;3926.921461570781;3997.420374045776;4035.475388199545;4229.006183546864;4467.865964021084;35166.472502912475;35523.4671479928;35669.64330356715;35849.10377240564;35974;4771.618270538349;4775.9761201194115;4800.807967681323;4896.804127834882;4907.68100073494;378754;379486;381617;382143;382799;60229.39770602326;60266;60439.69780151159;60447.39552604418;60587.69706151441;40840.387394189114;41042;41587.58412415837;43965.241390344665;69668;17802.46592602224;17941;17960.730589041174;17994.190261438267;18043.278268869097;13577.981651376187;13585.524506642418;13594.524191653443;13623.046386752832;13653.658658533615;21271.78728212729;21618.351449456542;21733.456663583536;21801.78198218029;21841.126354945944;7409.407247420193;7598.848023039508;7735.303822655876;7884.21157884207;7903.604819758989;1069.8127827630133;1075.301054314686;1109.5728144664201;1155.5146838327923;1216.8174773784003;34479.31041379159;34494.31011379758;34511;34812.30375392478;35480.64519354825;1156.2773266708307;1162.4885050577718;1198.72429341252;1236.5857437758452;1277.3357853915911;18333.54166145857;18432.723509147374;18484.353047643537;18549;18582.53543661392;595183;988279;988863;989098;994093;66130.67738645297;66874.66562667156;67045.66477167583;67161.66419167873;67232.6638366805;1467.1783801071433;1475.1370448287657;1482.918439485817;1517.7799219113388;1526.564928995231;33098;34036.319273614885;34134;34277.828610856785;34314.14214644654;44552;45327.093458129995;45335.31997020113;45524;45585.54414455813;557157;559128;560301;561472;562012;31901.20246993751;32169;32363;32756.344873101927;33032.009039728844;52692.47307527029;52913.206301904735;53011.469885300656;53119.73440132775;54470.18294725662;44634.77682611566;44657.55342446534;45179.322310164716;46088.53911460842;47263.76368118137;44771.86974225208;45845;46223.30665040094;46631;47679;44186.337204942596;45454.545454545034;46933.06133877235;47066;49846.501534984185;40578.98552536092;41018.384724229756;41178;41307.7934610325;41356.1728765417;31282.843585781924;31466;31773.682263177074;31916.52125218077;32081.358372831946 15:33:42 INFO - PROCESS | 29260 | |2;jquery.html;422.48245898773985;422.61753113432343;425.86159498163084;430.92243396188684;446.61591031712743;19189.136488858;20746.066427010803;20963.16147354106;21069.367918962456;21475.46311342217;18712.157952892117;19328.420147395565;19501.707474387895;19727.210911563558;20106.49733756657;5335.093034184198;5536.557075433956;5541.196526503654;5542.75057622406;5556.611037227396;5472.808451704191;5474.042042642542;5486.945130548704;5493.423190564993;5510.531604813596;5315.388730296007;5473.698946557938;5487;5516.9448305516835;5531.778728850841;5441.265429167091;5451.618386712932;5481.725913704318;5491;5494.560435165177;5282.894342113174;5368.463153684639;5377;5382.2464854920345;5383.676979381211;14479.131252124906;22018.88990555053;25137.748622513725;25393.74606253932;25494.235172944842;2302.6085565453914;2315.073970411832;2357.893894774722;2859.7140285971445;2979.8808047678067;10441.321314114559;10885.782284354347;10886.564537418493;11012.339259644366;11026.558937642485;1968.2028778344793;2107.2729908181655;2113.926012589552;2119.9258025969016;2120.257909731597;85442.14557854403;85596.57201714013;86269;88989.55505222433;90363.54818225867;11881.702957425961;11910.583129590423;11926.224795388272;12142.575009874612;12173.939130304469;17144.657106857794;17214.827851721322;17253.223604937808;17258.82741172597;17271.39550115765;8806.603702833389;8818.95590522056;8922.776930576787;8979.46123232608;8980.820383592292;8216.137305582948;8250.133735957757;8322.916770832335;8459.111793261742;8480;4898.363212782387;5050.823221187241;5098.770555325019;5159.638825282269;5229.137192363293;2121.9363419097454;2136.198925402974;2140.165335519149;2166.5450255446217;2190.8795016274257;1016.6187679620142;1034.7826956339254;1058.3385384134915;1118.8601424821898;1126.3305964863325;19278.421647350602;20204.29284975019;21159.576808463746;21231.893840530698;21444.892775536333;1016.192127258831;1049.490996866519;1053.2364036073939;1107.8338249262674;1109.7447587054862;11174.441277936234;11471.311721296748;11674.94162529182;11833.171677982631;11925.284482931052;414534.92732536147;439257;513457;515758;520672;95928;96479.51760241295;98154;98797.50601247091;101931.49034254781;1035.1201478743008;1061.7080302916606;1075.1882328841675;1075.682673611302;1075.8816530181673;18222.817771822112;18361.540961475537;18919.905400472908;19025.238990440226;19158.904205478884;31348.216294592818;40933.79533102315;43883;44012;46088.07823843437;51770;59477.7026114884;60023;60394.396056040634;61036.69481652563;9211.309151813506;9248.768780780534;9537.713868583953;9583.377080489747;9583.90416095858;10582.047615714622;14037.5086871959;14361.64095897611;14414.783778243545;14500.85499144995;12271.263724176579;12457.1902826316;12695.619131426072;12842;12913.806292905427;7930.722424715107;12192.695182620506;12231.143819932875;12403.193792403465;12911.483540658268;12209.938950305192;12542.561010364594;12601.18092323996;12688;12835.743285134431;9173.266138708754;9228;9341.673041443517;9394.436333819993;9578.521073946136;9466.570213946623;12351.69120771988;12518.624441266777;12792.74414511686;12841.357932103545 15:33:42 INFO - PROCESS | 29260 | |3;mootools.html;1485.5246321177221;1603.1022627328696;1771.3977247735768;1837.4487653703886;1840.861935354848;9176.724698259046;9681.515924203797;9913.553890074945;10016.59933602656;10048.045435683607;9497.572609232584;9599.088086631777;9621.037896210375;9649.56576954037;9665.661701840438;2519.7858182054547;2545.809064320174;2551.2473820223076;2551.2728872271405;2563.9487210255784;2497.4880149569385;2560.4495033567778;2561.2700380391593;2561.7950563954932;2572.9228123156336;2512.38446580588;2527.36815796051;2570;2575;2575.459153577751;2452.852828830276;2459.434330104077;2465.285067330463;2496.126355775464;2510.071273628751;2394.0902457066204;2399.6040653292184;2410.758924107593;2427.9150229741877;2488.6142647889606;10068.597256109746;10150.086492215736;10150.898491015143;10153.441560714158;10173;5643.407442218549;5800.129980502916;5802.88394232113;5803.65178089316;5812.070068788974;3627.9818600907092;3698.31581157484;3724.7578907370935;3772.5661548921953;3818.694504439666;1254.2975933477283;1302.1210682789078;1307.5685023942076;1320.2408615046386;1333.1467860569244;13842.100263482942;13938.790918136236;13947.860521394758;13963.092398994033;14074.718505629933;4617.746023968714;4758.405199350082;4785.856424307276;4793.808247670054;4972.179590367549;10431.426271555138;10450.947745261225;10453.895461045444;10475.685729428129;10524.947375263075;5708.40061793514;5744.712764361765;5749.482546570829;5768.048272035151;5800.274965629296;4696.412948381452;5138.511841375063;5244.160934250502;5268.315119034501;5340.25236466895;4186.665066794649;4189.219581677775;4211.284081706117;4279.2083464559155;4284.485861696554;1243.6517775023008;1283.8395200599925;1287.9356032198352;1293.9805902911276;1296.6758310422395;952.4666186935339;977.0571398600242;999.6201443451587;1023.0741179232806;1026.712520494263;6361.2048493938255;6385.297617262097;6518.543701940914;6593.80218593443;6660.500462465335;478.3757196858064;478.5358202543527;478.7414796010185;482.97343646099097;482.97343646099097;4283.485981682218;4421.801018954155;4459.152760975404;4468.084042771224;4514.616257618073;11554.711132221762;11856.525738970517;12057.397130143458;12266.754664906652;12328.07539434546;12360;12405.75188496243;12407.565735199225;12416.317102559446;12452.190607610477;8962.73111806647;9183.816323673489;9199.540022998823;9210.07899210087;9216.95391523038;6507.544471886922;6749.257581666111;6796.762113326207;6851.554648947803;6896.069030680794;10954.233203675667;11120.388378639253;11239.494222759831;11339.319640821577;11363.943180284046;11272.210945233755;11359.261647992855;11398.08815294758;11470.025047871024;11529.711757205801;8575.61409736551;8700.956495217484;8925.955370223108;8937.59780809852;8973.730788076367;9468.337216395063;9548.42709437436;9595.136437720359;9601.663941762004;9652.469114198786;8514.78713032179;8527.829443410972;8597.65609375643;8630.56847157627;8703.695370661997;8376.288015518505;8419.62111704987;8544.91455085466;8569.10024447424;8588;7764.961175194087;7855.685772569262;7883.251091146332;7891.171427000312;7895.84208315842;5433.320834895638;5712.6286791358425;5720.141978703062;5774.335951365479;5780.393058728773;5666.405027472056;5718.599698021098;5807.651540907559;5823.475887170175;5876.206712093813 15:33:42 INFO - PROCESS | 29260 | |4;prototype.html;352.9576450825901;353.6043306597798;354.2489921366703;355.1193041257681;359.5074747595794;5790.623609465387;5830.621009634376;5841.766329346821;5868.794592189274;5884.911726324109;5666.993551454633;5719.571032172583;5727.568107973007;5754.453326933945;5757.165211044396;4490.259107247301;4500.459944806627;4540.341650460681;4541.409616749835;4543.772811359436;4519.141363140992;4536.319552067183;4542.227821270392;4546.954530454703;4554.65840061995;4490.191765482212;4510;4513.7517436540975;4522.886927826798;4526.954730452702;4332.545082766312;4408.779561021936;4434.2905135178535;4441.888952776174;4449.621782148522;3909.612087708851;3918.746001279592;3928.5678575356687;3930.6855451563806;3933.8229779659982;5562.554995600342;5577.386487486373;5582.86042848928;5588.4411558844195;5601.831945041656;4997.525235102659;5104.3619547556555;5138.665986710852;5176.6893986360565;5200.245964335188;5997.580169388145;6005.40856672982;6028.668423236764;6030.698465076773;6039.426254505859;4405.31717583775;4405.691601587891;4408.669349798778;4411.757353345564;4414.757188354672;5938.198343223653;5953.642781433128;6052.455279024909;6171;6241.251049873998;4383.189110014658;4393.714408563497;4394.231009573312;4416.536263692266;4419.248727716296;4429.490608580055;4448;4455.443069616298;4476.619487343547;4479.17135329965;4953.529414705597;5070.138076527;5112.74436278192;5118.10433174193;5122.718250496184;5970.402959704082;5974.581779275409;5979.760809567569;6013.398660133952;6013.6993150342305;1513.5156749840166;1525.0697074784373;1528.9006214596238;1537.446519253068;1539.93070311834;931.9580618872167;977.726236653738;982.1210017034714;985.9260555458369;998.8801343838786;5125.923111153335;5139.588832893434;5160.535551800356;5171.345169545709;5183.0563538673;5392.622516423813;5421.83734487966;5455.727213639302;5466.289382380344;5488.341399032061;4966.230234313687;5121.3854337479;5159.74201289934;5193.221016847428;5213.504717051874;2844.7013063628433;2878.7409133178116;2912.339966219277;2917.839518826485;2922.8392438415667;5461.2354270402175;5657.2928383952;5662.603617746719;5667.489925906688;5678.4037676044245;5212.7914883405;5453.591505309182;5486.204500347428;5506.752196151103;5533.584981126432;5548.4174161712435;5550.946979161526;5559.9444005560235;5587.441255874462;5590.776368945197;5109.8978020438635;5265.473452654704;5366.919496207482;5386.4110087523495;5408.810061786401;5306.230596563554;5308.46915308466;5325.813596524103;5351.277577526984;5351.608581768846;6292.056191571301;6457.838554036187;6481.870362592627;6494.6103233806125;6497.0833604085965;4331.566843315643;4409.206342858316;4420.204363214652;4426.712263702849;4439.733615983051;6154.78458253959;6207.689615519115;6265.122882796503;6282;6298.779542715983;6096.847578810565;6116.908246376397;6125.84685382869;6131;6147.323794382525;5933.923126905548;6116.755329786759;6126.111713801563;6128.4790792783115;6131.877362452815;6064.93863573864;6080.148779170831;6106.786262480792;6117.357677443804;6119.44924956756;6127.632342059491;6163.722632481459;6165.352637972948;6170.9074363885475;6183.423227077066;5841.4450627190345;5974.253218347707;6017.518598512021;6018.849528761816;6037.969810150921 15:33:42 INFO - PROCESS | 29260 | |5;yui.html;690.3441730356163;706.7031846624417;736.124012425214;752.574795240689;790.3677058353318;15984.280707368167;17166.39917602884;17212.741808872877;17257.964522128666;17387.217575209113;15913.204339783022;16035.35858565656;16100.275487603056;16116.597085072879;16131.43539976101;729.1614643160368;884.2925659472428;901.4861528928514;902.6660135749781;907.2968449451662;895.7760559860035;897.0401670212875;898.2634239923266;899.3974037394961;899.8155378147464;956.9043095690445;957.8180145772316;959.7648576098866;960.159860122393;962.2494454325603;952.5142177489496;952.7189479103681;952.885653721551;953.823542644613;954.8233576788282;701.4353445476389;706.4207349973024;706.9010338552607;706.9823254418629;708.3341658840674;15592.922035389864;15606.141662208574;15611.063336199752;15615.921920390325;15653.608659783482;13770.380332885044;13798.65503362414;13858;14064.2967851607;14329.140251584835;12252.81620775689;12353.382330883509;12370;12377.93811030948;12385.071119666061;4167.729097608646;4171.478565179353;4180.644645205161;4204.789760511992;4275.978620106911;82284;82328.58835705783;83024;83552.58223708904;84115.57942210311;10722.946385268024;10731.731706707395;10762.300450470695;11179.944100279447;11377.772444551063;19656;19691.01544922777;19706.70439943402;19708.507287317643;19711.310104146287;9019.323550733721;9107.772305692279;9211.30915181364;9596.376235544667;9602.519874006412;5192.81825136126;5329.307190065267;5361.651492652965;5381.3811411687375;5427.83716488506;4004.8598299059395;4076.8165432555606;4097.385392191195;4119.835206591702;4147.81334839933;689.0628744906923;692.4183685704032;692.6744430117836;706.5654622407183;714.2500374606747;757.9279968402993;775.6703401054642;788.3535500889216;795.3915254830059;807.8505476486869;10593.52329145175;10760.569577216824;10773.676789696321;10832.945835270932;11005.559777608965;762.3951581920089;787.173467858746;799.7800604833601;812.5368539932182;814.1126172471916;5141.691498510101;5313.388960269541;5359.651622644516;5407.405185429599;5409.486098820685;134214;134687;135812.29349635306;137114.31442842723;137132;91103.54448227717;93960;113620.43189783998;113966;117002;55094;76237.9999999989;91278.54360728154;94876.52561737286;96119.51940240254;10429.634962776267;10842.241043126905;11013;11060.336379817236;11136.220464567403;55633;56589.15116273342;56684;57391.42608573861;59702.402975969686;72677;74358;81615.59192204001;82071;82111;13761.17432954026;14093.365798539295;14284.71430571362;14343.426262949366;14384.136951782926;15115.622109447351;15496.84503154999;15666;15746.842531574996;15997.520074397788;14245.287735613385;14299.21354325522;14367.281635917952;14382.640433989234;14600.707985840012;14199.219042952736;14526.491572794901;14849.183294918883;14954.177520236492;14973.700525989638;13673.794893076412;13893.166410015432;14191.148531088167;14296.142231466145;14913.105213687213;11692.532298707956;11728.537007228577;11901.821472677744;12075.154739168174;12204.206726562745;12126.878731212928;12562.685932851751;12661.93669031649;12904.612861614167;12958.28729419891 15:33:42 INFO - PROCESS | 29260 | __end_tp_report 15:33:42 INFO - PROCESS | 29260 | __start_cc_report 15:33:42 INFO - PROCESS | 29260 | _x_x_mozilla_cycle_collect,338 15:33:42 INFO - PROCESS | 29260 | __end_cc_report 15:33:42 INFO - PROCESS | 29260 | __startTimestamp1475534022210__endTimestamp 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | ------- Summary: start ------- 15:33:42 INFO - PROCESS | 29260 | Number of tests: 6 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | [#0] dojo.html Cycles:165 Average:5847.90 Median:6125.33 stddev:685.96 (11.2%) stddev-sans-first:659.28 15:33:42 INFO - PROCESS | 29260 | Values: 3341.1 3351.0 3362.9 3373.9 3382.3 5835.3 5900.7 5924.6 5926.9 5936.4 5759.6 5762.0 5768.3 5768.4 5769.9 5202.5 5243.9 5281.7 5316.5 5365.5 5328.1 5335.6 5336.4 5360.1 5365.5 5275.9 5283.0 5287.9 5313.9 5327.7 5363.1 5443.1 5465.8 5478.5 5511.5 5345.1 5416.6 5422.9 5438.2 5447.8 5697.3 5736.3 5867.2 5912.8 5986.1 6191.0 6265.2 6319.7 6321.1 6343.2 6360.6 6361.5 6362.0 6362.7 6380.3 5650.2 5849.3 5855.4 5856.5 5906.7 6372.3 6482.3 6499.6 6500.7 6565.4 6227.3 6283.0 6285.5 6290.0 6297.5 6129.1 6140.0 6314.1 6395.7 6401.6 6125.3 6206.7 6210.9 6212.6 6217.8 6196.3 6197.7 6198.5 6202.9 6217.8 4623.6 4720.8 4754.0 4768.2 4768.7 4198.8 4257.1 4271.8 4293.3 4307.7 6037.4 6099.6 6108.5 6129.1 6136.4 6106.8 6141.4 6327.1 6385.6 6420.5 6016.0 6083.3 6101.1 6112.6 6127.5 5263.1 5267.0 5268.7 5272.4 5285.5 6283.6 6423.3 6447.6 6567.4 6572.6 6361.0 6364.7 6372.6 6385.5 6396.7 6537.6 6570.6 6575.7 6581.3 6617.7 5912.1 6109.1 6133.1 6225.6 6237.0 6351.7 6368.0 6373.8 6375.5 6377.1 6196.5 6207.1 6216.3 6221.8 6221.9 6000.7 6104.8 6125.9 6186.7 6193.5 6167.6 6172.2 6207.8 6209.0 6211.8 6217.1 6221.9 6234.6 6253.5 6256.3 5914.4 5931.8 6018.1 6078.4 6083.2 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | [#1] ext.html Cycles:180 Average:76280.60 Median:45331.21 stddev:178555.62 (393.9%) stddev-sans-first:178966.07 15:33:42 INFO - PROCESS | 29260 | Values: 588.6 616.5 643.3 668.2 697.6 46899.0 47542.3 47616.8 47937.3 48053.3 47564.3 48196.0 48240.0 48261.3 48338.8 8831.2 9011.5 9029.0 9036.8 9040.4 9141.4 9243.0 9248.4 9250.1 9274.3 9345.3 9361.5 9363.6 9365.0 9365.1 9272.2 9274.9 9280.0 9306.2 9334.6 9153.7 9219.9 9222.8 9249.3 9295.0 37737.4 38036.0 38140.4 38150.0 38274.0 3926.9 3997.4 4035.5 4229.0 4467.9 35166.5 35523.5 35669.6 35849.1 35974.0 4771.6 4776.0 4800.8 4896.8 4907.7 378754.0 379486.0 381617.0 382143.0 382799.0 60229.4 60266.0 60439.7 60447.4 60587.7 40840.4 41042.0 41587.6 43965.2 69668.0 17802.5 17941.0 17960.7 17994.2 18043.3 13578.0 13585.5 13594.5 13623.0 13653.7 21271.8 21618.4 21733.5 21801.8 21841.1 7409.4 7598.8 7735.3 7884.2 7903.6 1069.8 1075.3 1109.6 1155.5 1216.8 34479.3 34494.3 34511.0 34812.3 35480.6 1156.3 1162.5 1198.7 1236.6 1277.3 18333.5 18432.7 18484.4 18549.0 18582.5 595183.0 988279.0 988863.0 989098.0 994093.0 66130.7 66874.7 67045.7 67161.7 67232.7 1467.2 1475.1 1482.9 1517.8 1526.6 33098.0 34036.3 34134.0 34277.8 34314.1 44552.0 45327.1 45335.3 45524.0 45585.5 557157.0 559128.0 560301.0 561472.0 562012.0 31901.2 32169.0 32363.0 32756.3 33032.0 52692.5 52913.2 53011.5 53119.7 54470.2 44634.8 44657.6 45179.3 46088.5 47263.8 44771.9 45845.0 46223.3 46631.0 47679.0 44186.3 45454.5 46933.1 47066.0 49846.5 40579.0 41018.4 41178.0 41307.8 41356.2 31282.8 31466.0 31773.7 31916.5 32081.4 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | [#2] jquery.html Cycles:180 Average:29473.33 Median:12160.75 stddev:79874.56 (656.8%) stddev-sans-first:80068.84 15:33:42 INFO - PROCESS | 29260 | Values: 422.5 422.6 425.9 430.9 446.6 19189.1 20746.1 20963.2 21069.4 21475.5 18712.2 19328.4 19501.7 19727.2 20106.5 5335.1 5536.6 5541.2 5542.8 5556.6 5472.8 5474.0 5486.9 5493.4 5510.5 5315.4 5473.7 5487.0 5516.9 5531.8 5441.3 5451.6 5481.7 5491.0 5494.6 5282.9 5368.5 5377.0 5382.2 5383.7 14479.1 22018.9 25137.7 25393.7 25494.2 2302.6 2315.1 2357.9 2859.7 2979.9 10441.3 10885.8 10886.6 11012.3 11026.6 1968.2 2107.3 2113.9 2119.9 2120.3 85442.1 85596.6 86269.0 88989.6 90363.5 11881.7 11910.6 11926.2 12142.6 12173.9 17144.7 17214.8 17253.2 17258.8 17271.4 8806.6 8819.0 8922.8 8979.5 8980.8 8216.1 8250.1 8322.9 8459.1 8480.0 4898.4 5050.8 5098.8 5159.6 5229.1 2121.9 2136.2 2140.2 2166.5 2190.9 1016.6 1034.8 1058.3 1118.9 1126.3 19278.4 20204.3 21159.6 21231.9 21444.9 1016.2 1049.5 1053.2 1107.8 1109.7 11174.4 11471.3 11674.9 11833.2 11925.3 414534.9 439257.0 513457.0 515758.0 520672.0 95928.0 96479.5 98154.0 98797.5 101931.5 1035.1 1061.7 1075.2 1075.7 1075.9 18222.8 18361.5 18919.9 19025.2 19158.9 31348.2 40933.8 43883.0 44012.0 46088.1 51770.0 59477.7 60023.0 60394.4 61036.7 9211.3 9248.8 9537.7 9583.4 9583.9 10582.0 14037.5 14361.6 14414.8 14500.9 12271.3 12457.2 12695.6 12842.0 12913.8 7930.7 12192.7 12231.1 12403.2 12911.5 12209.9 12542.6 12601.2 12688.0 12835.7 9173.3 9228.0 9341.7 9394.4 9578.5 9466.6 12351.7 12518.6 12792.7 12841.4 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | [#3] mootools.html Cycles:180 Average:6398.63 Median:4440.48 stddev:3722.75 (83.8%) stddev-sans-first:3714.88 15:33:42 INFO - PROCESS | 29260 | Values: 1485.5 1603.1 1771.4 1837.4 1840.9 9176.7 9681.5 9913.6 10016.6 10048.0 9497.6 9599.1 9621.0 9649.6 9665.7 2519.8 2545.8 2551.2 2551.3 2563.9 2497.5 2560.4 2561.3 2561.8 2572.9 2512.4 2527.4 2570.0 2575.0 2575.5 2452.9 2459.4 2465.3 2496.1 2510.1 2394.1 2399.6 2410.8 2427.9 2488.6 10068.6 10150.1 10150.9 10153.4 10173.0 5643.4 5800.1 5802.9 5803.7 5812.1 3628.0 3698.3 3724.8 3772.6 3818.7 1254.3 1302.1 1307.6 1320.2 1333.1 13842.1 13938.8 13947.9 13963.1 14074.7 4617.7 4758.4 4785.9 4793.8 4972.2 10431.4 10450.9 10453.9 10475.7 10524.9 5708.4 5744.7 5749.5 5768.0 5800.3 4696.4 5138.5 5244.2 5268.3 5340.3 4186.7 4189.2 4211.3 4279.2 4284.5 1243.7 1283.8 1287.9 1294.0 1296.7 952.5 977.1 999.6 1023.1 1026.7 6361.2 6385.3 6518.5 6593.8 6660.5 478.4 478.5 478.7 483.0 483.0 4283.5 4421.8 4459.2 4468.1 4514.6 11554.7 11856.5 12057.4 12266.8 12328.1 12360.0 12405.8 12407.6 12416.3 12452.2 8962.7 9183.8 9199.5 9210.1 9217.0 6507.5 6749.3 6796.8 6851.6 6896.1 10954.2 11120.4 11239.5 11339.3 11363.9 11272.2 11359.3 11398.1 11470.0 11529.7 8575.6 8701.0 8926.0 8937.6 8973.7 9468.3 9548.4 9595.1 9601.7 9652.5 8514.8 8527.8 8597.7 8630.6 8703.7 8376.3 8419.6 8544.9 8569.1 8588.0 7765.0 7855.7 7883.3 7891.2 7895.8 5433.3 5712.6 5720.1 5774.3 5780.4 5666.4 5718.6 5807.7 5823.5 5876.2 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | [#4] prototype.html Cycles:180 Average:4914.14 Median:5400.72 stddev:1431.05 (26.5%) stddev-sans-first:1393.51 15:33:42 INFO - PROCESS | 29260 | Values: 353.0 353.6 354.2 355.1 359.5 5790.6 5830.6 5841.8 5868.8 5884.9 5667.0 5719.6 5727.6 5754.5 5757.2 4490.3 4500.5 4540.3 4541.4 4543.8 4519.1 4536.3 4542.2 4547.0 4554.7 4490.2 4510.0 4513.8 4522.9 4527.0 4332.5 4408.8 4434.3 4441.9 4449.6 3909.6 3918.7 3928.6 3930.7 3933.8 5562.6 5577.4 5582.9 5588.4 5601.8 4997.5 5104.4 5138.7 5176.7 5200.2 5997.6 6005.4 6028.7 6030.7 6039.4 4405.3 4405.7 4408.7 4411.8 4414.8 5938.2 5953.6 6052.5 6171.0 6241.3 4383.2 4393.7 4394.2 4416.5 4419.2 4429.5 4448.0 4455.4 4476.6 4479.2 4953.5 5070.1 5112.7 5118.1 5122.7 5970.4 5974.6 5979.8 6013.4 6013.7 1513.5 1525.1 1528.9 1537.4 1539.9 932.0 977.7 982.1 985.9 998.9 5125.9 5139.6 5160.5 5171.3 5183.1 5392.6 5421.8 5455.7 5466.3 5488.3 4966.2 5121.4 5159.7 5193.2 5213.5 2844.7 2878.7 2912.3 2917.8 2922.8 5461.2 5657.3 5662.6 5667.5 5678.4 5212.8 5453.6 5486.2 5506.8 5533.6 5548.4 5550.9 5559.9 5587.4 5590.8 5109.9 5265.5 5366.9 5386.4 5408.8 5306.2 5308.5 5325.8 5351.3 5351.6 6292.1 6457.8 6481.9 6494.6 6497.1 4331.6 4409.2 4420.2 4426.7 4439.7 6154.8 6207.7 6265.1 6282.0 6298.8 6096.8 6116.9 6125.8 6131.0 6147.3 5933.9 6116.8 6126.1 6128.5 6131.9 6064.9 6080.1 6106.8 6117.4 6119.4 6127.6 6163.7 6165.4 6170.9 6183.4 5841.4 5974.3 6017.5 6018.8 6038.0 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - PROCESS | 29260 | [#5] yui.html Cycles:180 Average:22329.77 Median:4108.61 stddev:32886.40 (800.4%) stddev-sans-first:32938.52 15:33:42 INFO - PROCESS | 29260 | Values: 690.3 706.7 736.1 752.6 790.4 15984.3 17166.4 17212.7 17258.0 17387.2 15913.2 16035.4 16100.3 16116.6 16131.4 729.2 884.3 901.5 902.7 907.3 895.8 897.0 898.3 899.4 899.8 956.9 957.8 959.8 960.2 962.2 952.5 952.7 952.9 953.8 954.8 701.4 706.4 706.9 707.0 708.3 15592.9 15606.1 15611.1 15615.9 15653.6 13770.4 13798.7 13858.0 14064.3 14329.1 12252.8 12353.4 12370.0 12377.9 12385.1 4167.7 4171.5 4180.6 4204.8 4276.0 82284.0 82328.6 83024.0 83552.6 84115.6 10722.9 10731.7 10762.3 11179.9 11377.8 19656.0 19691.0 19706.7 19708.5 19711.3 9019.3 9107.8 9211.3 9596.4 9602.5 5192.8 5329.3 5361.7 5381.4 5427.8 4004.9 4076.8 4097.4 4119.8 4147.8 689.1 692.4 692.7 706.6 714.3 757.9 775.7 788.4 795.4 807.9 10593.5 10760.6 10773.7 10832.9 11005.6 762.4 787.2 799.8 812.5 814.1 5141.7 5313.4 5359.7 5407.4 5409.5 134214.0 134687.0 135812.3 137114.3 137132.0 91103.5 93960.0 113620.4 113966.0 117002.0 55094.0 76238.0 91278.5 94876.5 96119.5 10429.6 10842.2 11013.0 11060.3 11136.2 55633.0 56589.2 56684.0 57391.4 59702.4 72677.0 74358.0 81615.6 82071.0 82111.0 13761.2 14093.4 14284.7 14343.4 14384.1 15115.6 15496.8 15666.0 15746.8 15997.5 14245.3 14299.2 14367.3 14382.6 14600.7 14199.2 14526.5 14849.2 14954.2 14973.7 13673.8 13893.2 14191.1 14296.1 14913.1 11692.5 11728.5 11901.8 12075.2 12204.2 12126.9 12562.7 12661.9 12904.6 12958.3 15:33:42 INFO - PROCESS | 29260 | -------- Summary: end -------- 15:33:42 INFO - PROCESS | 29260 | 15:33:42 INFO - TEST-INFO | 29260: exit 0 15:33:42 INFO - TEST-OK | dromaeo_css | took 1110439ms 15:33:42 INFO - TEST-START | kraken 15:33:42 INFO - operating with platform_type : linux_ 15:33:42 INFO - Initialising browser for kraken test... 15:33:42 INFO - TEST-INFO | started process 29501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQGD4yY/profile http://localhost:37514/getInfo.html) 15:33:47 INFO - PROCESS | 29501 | __metrics Screen width/height:1600/1200 15:33:47 INFO - PROCESS | 29501 | colorDepth:24 15:33:47 INFO - PROCESS | 29501 | Browser inner width/height: 1024/697 15:33:47 INFO - PROCESS | 29501 | __metrics 15:33:47 ERROR - PROCESS | 29501 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:33:48 INFO - TEST-INFO | 29501: exit 0 15:33:48 INFO - Browser initialized. 15:33:48 INFO - Running cycle 1/1 for kraken test... 15:33:48 INFO - TEST-INFO | started process 29628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQGD4yY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:00 INFO - PROCESS | 29628 | RSS: Main: 150196224 15:34:00 INFO - PROCESS | 29628 | 15:34:02 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37514/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:03 INFO - PROCESS | 29628 | RSS: Main: 156917760 15:34:03 INFO - PROCESS | 29628 | 15:34:06 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37514/tests/kraken/driver.html?testName=audio-dft) 15:34:07 INFO - PROCESS | 29628 | RSS: Main: 155246592 15:34:07 INFO - PROCESS | 29628 | 15:34:09 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37514/tests/kraken/driver.html?testName=audio-fft) 15:34:10 INFO - PROCESS | 29628 | RSS: Main: 156250112 15:34:10 INFO - PROCESS | 29628 | 15:34:12 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37514/tests/kraken/driver.html?testName=audio-oscillator) 15:34:13 INFO - PROCESS | 29628 | RSS: Main: 155811840 15:34:13 INFO - PROCESS | 29628 | 15:34:15 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37514/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:16 INFO - PROCESS | 29628 | RSS: Main: 156028928 15:34:16 INFO - PROCESS | 29628 | 15:34:19 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37514/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:19 INFO - PROCESS | 29628 | RSS: Main: 156672000 15:34:19 INFO - PROCESS | 29628 | 15:34:23 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37514/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:23 INFO - PROCESS | 29628 | RSS: Main: 156545024 15:34:23 INFO - PROCESS | 29628 | 15:34:26 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37514/tests/kraken/driver.html?testName=json-parse-financial) 15:34:27 INFO - PROCESS | 29628 | RSS: Main: 156037120 15:34:27 INFO - PROCESS | 29628 | 15:34:28 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37514/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:29 INFO - PROCESS | 29628 | RSS: Main: 155279360 15:34:29 INFO - PROCESS | 29628 | 15:34:31 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:34:31 INFO - PROCESS | 29628 | RSS: Main: 155459584 15:34:31 INFO - PROCESS | 29628 | 15:34:33 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:34:34 INFO - PROCESS | 29628 | RSS: Main: 155607040 15:34:34 INFO - PROCESS | 29628 | 15:34:36 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:34:37 INFO - PROCESS | 29628 | RSS: Main: 155901952 15:34:37 INFO - PROCESS | 29628 | 15:34:40 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:40 INFO - PROCESS | 29628 | RSS: Main: 157319168 15:34:40 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:37514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37514/tests/kraken/driver.html?testName=ai-astar) 15:34:42 INFO - PROCESS | 29628 | RSS: Main: 158863360 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | __start_tp_report 15:34:42 INFO - PROCESS | 29628 | _x_x_mozilla_page_load 15:34:42 INFO - PROCESS | 29628 | _x_x_mozilla_page_load_details 15:34:42 INFO - PROCESS | 29628 | |i|pagename|runs| 15:34:42 INFO - PROCESS | 29628 | |0;ai-astar;106;115;104;111;112;113;113;114;113;112 15:34:42 INFO - PROCESS | 29628 | |1;audio-beat-detection;156;118;143;174;118;147;151;115;177;126 15:34:42 INFO - PROCESS | 29628 | |2;audio-dft;163;162;162;162;161;161;163;163;161;163 15:34:42 INFO - PROCESS | 29628 | |3;audio-fft;75;76;75;184;76;75;74;76;180;75 15:34:42 INFO - PROCESS | 29628 | |4;audio-oscillator;83;83;152;84;84;84;142;83;84;143 15:34:42 INFO - PROCESS | 29628 | |5;imaging-gaussian-blur;117;118;118;117;116;117;116;117;118;118 15:34:42 INFO - PROCESS | 29628 | |6;imaging-darkroom;147;149;147;147;147;146;148;147;147;146 15:34:42 INFO - PROCESS | 29628 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;96 15:34:42 INFO - PROCESS | 29628 | |8;json-parse-financial;52;52;55;51;55;51;51;51;52;54 15:34:42 INFO - PROCESS | 29628 | |9;json-stringify-tinderbox;62;61;59;59;60;61;65;63;63;61 15:34:42 INFO - PROCESS | 29628 | |10;stanford-crypto-aes;73;72;82;75;78;71;72;72;78;71 15:34:42 INFO - PROCESS | 29628 | |11;stanford-crypto-ccm;121;132;119;122;118;124;119;128;163;118 15:34:42 INFO - PROCESS | 29628 | |12;stanford-crypto-pbkdf2;149;151;157;152;150;158;149;153;149;156 15:34:42 INFO - PROCESS | 29628 | |13;stanford-crypto-sha256-iterative;63;62;70;61;61;62;63;60;61;60 15:34:42 INFO - PROCESS | 29628 | __end_tp_report 15:34:42 INFO - PROCESS | 29628 | __start_cc_report 15:34:42 INFO - PROCESS | 29628 | _x_x_mozilla_cycle_collect,914 15:34:42 INFO - PROCESS | 29628 | __end_cc_report 15:34:42 INFO - PROCESS | 29628 | __startTimestamp1475534082676__endTimestamp 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | ------- Summary: start ------- 15:34:42 INFO - PROCESS | 29628 | Number of tests: 14 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.53 (3.1%) stddev-sans-first:3.18 15:34:42 INFO - PROCESS | 29628 | Values: 106.0 115.0 104.0 111.0 112.0 113.0 113.0 114.0 113.0 112.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:149.00 stddev:22.82 (15.3%) stddev-sans-first:23.67 15:34:42 INFO - PROCESS | 29628 | Values: 156.0 118.0 143.0 174.0 118.0 147.0 151.0 115.0 177.0 126.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 15:34:42 INFO - PROCESS | 29628 | Values: 163.0 162.0 162.0 162.0 161.0 161.0 163.0 163.0 161.0 163.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#3] audio-fft Cycles:10 Average:96.60 Median:75.00 stddev:45.02 (60.0%) stddev-sans-first:47.07 15:34:42 INFO - PROCESS | 29628 | Values: 75.0 76.0 75.0 184.0 76.0 75.0 74.0 76.0 180.0 75.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:83.50 stddev:30.11 (36.1%) stddev-sans-first:31.12 15:34:42 INFO - PROCESS | 29628 | Values: 83.0 83.0 152.0 84.0 84.0 84.0 142.0 83.0 84.0 143.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 15:34:42 INFO - PROCESS | 29628 | Values: 117.0 118.0 118.0 117.0 116.0 117.0 116.0 117.0 118.0 118.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 15:34:42 INFO - PROCESS | 29628 | Values: 147.0 149.0 147.0 147.0 147.0 146.0 148.0 147.0 147.0 146.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:34:42 INFO - PROCESS | 29628 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:1.65 (3.2%) stddev-sans-first:1.74 15:34:42 INFO - PROCESS | 29628 | Values: 52.0 52.0 55.0 51.0 55.0 51.0 51.0 51.0 52.0 54.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:1.90 (3.1%) stddev-sans-first:2.00 15:34:42 INFO - PROCESS | 29628 | Values: 62.0 61.0 59.0 59.0 60.0 61.0 65.0 63.0 63.0 61.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:3.75 (5.1%) stddev-sans-first:3.94 15:34:42 INFO - PROCESS | 29628 | Values: 73.0 72.0 82.0 75.0 78.0 71.0 72.0 72.0 78.0 71.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:123.00 stddev:13.66 (11.1%) stddev-sans-first:14.34 15:34:42 INFO - PROCESS | 29628 | Values: 121.0 132.0 119.0 122.0 118.0 124.0 119.0 128.0 163.0 118.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:152.50 stddev:3.47 (2.3%) stddev-sans-first:3.46 15:34:42 INFO - PROCESS | 29628 | Values: 149.0 151.0 157.0 152.0 150.0 158.0 149.0 153.0 149.0 156.0 15:34:42 INFO - PROCESS | 29628 | 15:34:42 INFO - PROCESS | 29628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:2.91 (4.7%) stddev-sans-first:3.07 15:34:42 INFO - PROCESS | 29628 | Values: 63.0 62.0 70.0 61.0 61.0 62.0 63.0 60.0 61.0 60.0 15:34:42 INFO - PROCESS | 29628 | -------- Summary: end -------- 15:34:42 INFO - PROCESS | 29628 | 15:34:43 INFO - TEST-INFO | 29628: exit 0 15:34:43 INFO - TEST-OK | kraken | took 60731ms 15:34:43 INFO - SUITE-END | took 1171s 15:34:43 INFO - Completed test suite (00:19:31) 15:34:43 INFO - javascript benchmark 15:34:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7778.854654965354, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.097903566037, 3350.983245083775, 3362.8822991195298, 3373.865045398184, 3382.3066271414364, 5835.299764028317, 5900.675462849542, 5924.555658325627, 5926.911096333559, 5936.37668044855, 5759.5968282220265, 5761.999999999989, 5768.307803063628, 5768.39431859655, 5769.942300576993, 5202.479752024796, 5243.86890327741, 5281.735913204344, 5316.5215130638235, 5365.543928766059, 5328.120860058086, 5335.599830012745, 5336.359636843584, 5360.115580929161, 5365.543928766059, 5275.947240527584, 5282.973585132069, 5287.894242115155, 5313.920291195635, 5327.680339179642, 5363.115086010804, 5443.074677304868, 5465.808696695596, 5478.479544443271, 5511.53151982082, 5345.118055520835, 5416.593755468356, 5422.91865622016, 5438.184272359138, 5447.836564903019, 5697.287839020122, 5736.282964629421, 5867.178594996704, 5912.846994836009, 5986.07215881539, 6190.969045154746, 6265.154204182422, 6319.6524191169465, 6321.083442900754, 6343.175387199681, 6360.586561873463, 6361.522885783538, 6361.968190159019, 6362.650054247015, 6380.330065343165, 5650.152477128422, 5849.298084229919, 5855.443732845373, 5856.472917437409, 5906.675132867691, 6372.330905254974, 6482.286948435668, 6499.5775274607, 6500.707468163944, 6565.376289252514, 6227.314995350508, 6282.968585157045, 6285.465735412541, 6289.96855015722, 6297.464715499143, 6129.080637904261, 6139.969300153471, 6314.0528920661345, 6395.712192951329, 6401.615903045832, 6125.327021303102, 6206.689665516707, 6210.875782484325, 6212.627242365473, 6217.782377616762, 6196.287426945869, 6197.721102550396, 6198.473129784019, 6202.937970620326, 6217.782377616762, 4623.583877451046, 4720.834770783006, 4754.049190161982, 4768.213244814567, 4768.737719425465, 4198.8110535026, 4257.084726783694, 4271.765052922119, 4293.2701440755145, 4307.698461107692, 6037.396260373927, 6099.634021958696, 6108.5418593605655, 6129.08063790435, 6136.447719705248, 6106.794380079898, 6141.424638644238, 6327.145835312174, 6385.584936979081, 6420.486361091102, 6016.0, 6083.300420451616, 6101.145839582462, 6112.572119951649, 6127.509799216052, 5263.078961181778, 5267.0, 5268.683878967274, 5272.367315922113, 5285.471452854684, 6283.622982621057, 6423.261324947597, 6447.6453795041725, 6567.408933196035, 6572.605643661395, 6360.968195158995, 6364.745410183726, 6372.617642941438, 6385.45723613498, 6396.71214795326, 6537.640429776408, 6570.605763654196, 6575.704093315908, 6581.276059633532, 6617.735290588323, 5912.113183022409, 6109.1010297800785, 6133.106994857385, 6225.564210505402, 6236.968815155895, 6351.745930162741, 6368.044793280859, 6373.808785736435, 6375.5218358624215, 6377.1390862233, 6196.535259855439, 6207.099970504342, 6216.347283535164, 6221.782237621662, 6221.9377806221355, 6000.69996500182, 6104.847378815565, 6125.907024958145, 6186.721597528212, 6193.504519638328, 6167.599106058092, 6172.197614310111, 6207.81376558704, 6209.0, 6211.81364559064, 6217.09852071438, 6221.875562488634, 6234.594751341148, 6253.468455181361, 6256.311805701278, 5914.408559144051, 5931.762729490944, 6018.097285407224, 6078.3617720138745, 6083.239595050619], "value": 5799.975386899768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.6468119128523, 616.4790751814717, 643.3405759096927, 668.1748041169155, 697.6093387702883, 46899.0, 47542.28686569696, 47616.761916190415, 47937.28094078592, 48053.279200812016, 47564.28653570199, 48196.0, 48240.0, 48261.276080858814, 48338.75830620851, 8831.161039701234, 9011.504367259831, 9029.006809250977, 9036.819263614723, 9040.412373195753, 9141.405808622452, 9242.953785231099, 9248.352615316931, 9250.121238482334, 9274.304427167956, 9345.345825792198, 9361.531923403803, 9363.625454981793, 9364.953175234148, 9365.063493650614, 9272.211861991738, 9274.860877086849, 9279.95360023199, 9306.208972237368, 9334.626614935394, 9153.725388238363, 9219.90780092204, 9222.815543689156, 9249.260059195316, 9295.0, 37737.43393849095, 38036.0, 38140.42789358162, 38150.046248843726, 38274.0, 3926.921461570781, 3997.420374045776, 4035.475388199545, 4229.006183546864, 4467.865964021084, 35166.472502912475, 35523.4671479928, 35669.64330356715, 35849.10377240564, 35974.0, 4771.618270538349, 4775.9761201194115, 4800.807967681323, 4896.804127834882, 4907.68100073494, 378754.0, 379486.0, 381617.0, 382143.0, 382799.0, 60229.39770602326, 60266.0, 60439.69780151159, 60447.39552604418, 60587.69706151441, 40840.387394189114, 41042.0, 41587.58412415837, 43965.241390344665, 69668.0, 17802.46592602224, 17941.0, 17960.730589041174, 17994.190261438267, 18043.278268869097, 13577.981651376187, 13585.524506642418, 13594.524191653443, 13623.046386752832, 13653.658658533615, 21271.78728212729, 21618.351449456542, 21733.456663583536, 21801.78198218029, 21841.126354945944, 7409.407247420193, 7598.848023039508, 7735.303822655876, 7884.21157884207, 7903.604819758989, 1069.8127827630133, 1075.301054314686, 1109.5728144664201, 1155.5146838327923, 1216.8174773784003, 34479.31041379159, 34494.31011379758, 34511.0, 34812.30375392478, 35480.64519354825, 1156.2773266708307, 1162.4885050577718, 1198.72429341252, 1236.5857437758452, 1277.3357853915911, 18333.54166145857, 18432.723509147374, 18484.353047643537, 18549.0, 18582.53543661392, 595183.0, 988279.0, 988863.0, 989098.0, 994093.0, 66130.67738645297, 66874.66562667156, 67045.66477167583, 67161.66419167873, 67232.6638366805, 1467.1783801071433, 1475.1370448287657, 1482.918439485817, 1517.7799219113388, 1526.564928995231, 33098.0, 34036.319273614885, 34134.0, 34277.828610856785, 34314.14214644654, 44552.0, 45327.093458129995, 45335.31997020113, 45524.0, 45585.54414455813, 557157.0, 559128.0, 560301.0, 561472.0, 562012.0, 31901.20246993751, 32169.0, 32363.0, 32756.344873101927, 33032.009039728844, 52692.47307527029, 52913.206301904735, 53011.469885300656, 53119.73440132775, 54470.18294725662, 44634.77682611566, 44657.55342446534, 45179.322310164716, 46088.53911460842, 47263.76368118137, 44771.86974225208, 45845.0, 46223.30665040094, 46631.0, 47679.0, 44186.337204942596, 45454.545454545034, 46933.06133877235, 47066.0, 49846.501534984185, 40578.98552536092, 41018.384724229756, 41178.0, 41307.7934610325, 41356.1728765417, 31282.843585781924, 31466.0, 31773.682263177074, 31916.52125218077, 32081.358372831946], "value": 21896.953282814036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.48245898773985, 422.61753113432343, 425.86159498163084, 430.92243396188684, 446.61591031712743, 19189.136488858, 20746.066427010803, 20963.16147354106, 21069.367918962456, 21475.46311342217, 18712.157952892117, 19328.420147395565, 19501.707474387895, 19727.210911563558, 20106.49733756657, 5335.093034184198, 5536.557075433956, 5541.196526503654, 5542.75057622406, 5556.611037227396, 5472.808451704191, 5474.042042642542, 5486.945130548704, 5493.423190564993, 5510.531604813596, 5315.388730296007, 5473.698946557938, 5487.0, 5516.9448305516835, 5531.778728850841, 5441.265429167091, 5451.618386712932, 5481.725913704318, 5491.0, 5494.560435165177, 5282.894342113174, 5368.463153684639, 5377.0, 5382.2464854920345, 5383.676979381211, 14479.131252124906, 22018.88990555053, 25137.748622513725, 25393.74606253932, 25494.235172944842, 2302.6085565453914, 2315.073970411832, 2357.893894774722, 2859.7140285971445, 2979.8808047678067, 10441.321314114559, 10885.782284354347, 10886.564537418493, 11012.339259644366, 11026.558937642485, 1968.2028778344793, 2107.2729908181655, 2113.926012589552, 2119.9258025969016, 2120.257909731597, 85442.14557854403, 85596.57201714013, 86269.0, 88989.55505222433, 90363.54818225867, 11881.702957425961, 11910.583129590423, 11926.224795388272, 12142.575009874612, 12173.939130304469, 17144.657106857794, 17214.827851721322, 17253.223604937808, 17258.82741172597, 17271.39550115765, 8806.603702833389, 8818.95590522056, 8922.776930576787, 8979.46123232608, 8980.820383592292, 8216.137305582948, 8250.133735957757, 8322.916770832335, 8459.111793261742, 8480.0, 4898.363212782387, 5050.823221187241, 5098.770555325019, 5159.638825282269, 5229.137192363293, 2121.9363419097454, 2136.198925402974, 2140.165335519149, 2166.5450255446217, 2190.8795016274257, 1016.6187679620142, 1034.7826956339254, 1058.3385384134915, 1118.8601424821898, 1126.3305964863325, 19278.421647350602, 20204.29284975019, 21159.576808463746, 21231.893840530698, 21444.892775536333, 1016.192127258831, 1049.490996866519, 1053.2364036073939, 1107.8338249262674, 1109.7447587054862, 11174.441277936234, 11471.311721296748, 11674.94162529182, 11833.171677982631, 11925.284482931052, 414534.92732536147, 439257.0, 513457.0, 515758.0, 520672.0, 95928.0, 96479.51760241295, 98154.0, 98797.50601247091, 101931.49034254781, 1035.1201478743008, 1061.7080302916606, 1075.1882328841675, 1075.682673611302, 1075.8816530181673, 18222.817771822112, 18361.540961475537, 18919.905400472908, 19025.238990440226, 19158.904205478884, 31348.216294592818, 40933.79533102315, 43883.0, 44012.0, 46088.07823843437, 51770.0, 59477.7026114884, 60023.0, 60394.396056040634, 61036.69481652563, 9211.309151813506, 9248.768780780534, 9537.713868583953, 9583.377080489747, 9583.90416095858, 10582.047615714622, 14037.5086871959, 14361.64095897611, 14414.783778243545, 14500.85499144995, 12271.263724176579, 12457.1902826316, 12695.619131426072, 12842.0, 12913.806292905427, 7930.722424715107, 12192.695182620506, 12231.143819932875, 12403.193792403465, 12911.483540658268, 12209.938950305192, 12542.561010364594, 12601.18092323996, 12688.0, 12835.743285134431, 9173.266138708754, 9228.0, 9341.673041443517, 9394.436333819993, 9578.521073946136, 9466.570213946623, 12351.69120771988, 12518.624441266777, 12792.74414511686, 12841.357932103545], "value": 9638.125938344043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.5246321177221, 1603.1022627328696, 1771.3977247735768, 1837.4487653703886, 1840.861935354848, 9176.724698259046, 9681.515924203797, 9913.553890074945, 10016.59933602656, 10048.045435683607, 9497.572609232584, 9599.088086631777, 9621.037896210375, 9649.56576954037, 9665.661701840438, 2519.7858182054547, 2545.809064320174, 2551.2473820223076, 2551.2728872271405, 2563.9487210255784, 2497.4880149569385, 2560.4495033567778, 2561.2700380391593, 2561.7950563954932, 2572.9228123156336, 2512.38446580588, 2527.36815796051, 2570.0, 2575.0, 2575.459153577751, 2452.852828830276, 2459.434330104077, 2465.285067330463, 2496.126355775464, 2510.071273628751, 2394.0902457066204, 2399.6040653292184, 2410.758924107593, 2427.9150229741877, 2488.6142647889606, 10068.597256109746, 10150.086492215736, 10150.898491015143, 10153.441560714158, 10173.0, 5643.407442218549, 5800.129980502916, 5802.88394232113, 5803.65178089316, 5812.070068788974, 3627.9818600907092, 3698.31581157484, 3724.7578907370935, 3772.5661548921953, 3818.694504439666, 1254.2975933477283, 1302.1210682789078, 1307.5685023942076, 1320.2408615046386, 1333.1467860569244, 13842.100263482942, 13938.790918136236, 13947.860521394758, 13963.092398994033, 14074.718505629933, 4617.746023968714, 4758.405199350082, 4785.856424307276, 4793.808247670054, 4972.179590367549, 10431.426271555138, 10450.947745261225, 10453.895461045444, 10475.685729428129, 10524.947375263075, 5708.40061793514, 5744.712764361765, 5749.482546570829, 5768.048272035151, 5800.274965629296, 4696.412948381452, 5138.511841375063, 5244.160934250502, 5268.315119034501, 5340.25236466895, 4186.665066794649, 4189.219581677775, 4211.284081706117, 4279.2083464559155, 4284.485861696554, 1243.6517775023008, 1283.8395200599925, 1287.9356032198352, 1293.9805902911276, 1296.6758310422395, 952.4666186935339, 977.0571398600242, 999.6201443451587, 1023.0741179232806, 1026.712520494263, 6361.2048493938255, 6385.297617262097, 6518.543701940914, 6593.80218593443, 6660.500462465335, 478.3757196858064, 478.5358202543527, 478.7414796010185, 482.97343646099097, 482.97343646099097, 4283.485981682218, 4421.801018954155, 4459.152760975404, 4468.084042771224, 4514.616257618073, 11554.711132221762, 11856.525738970517, 12057.397130143458, 12266.754664906652, 12328.07539434546, 12360.0, 12405.75188496243, 12407.565735199225, 12416.317102559446, 12452.190607610477, 8962.73111806647, 9183.816323673489, 9199.540022998823, 9210.07899210087, 9216.95391523038, 6507.544471886922, 6749.257581666111, 6796.762113326207, 6851.554648947803, 6896.069030680794, 10954.233203675667, 11120.388378639253, 11239.494222759831, 11339.319640821577, 11363.943180284046, 11272.210945233755, 11359.261647992855, 11398.08815294758, 11470.025047871024, 11529.711757205801, 8575.61409736551, 8700.956495217484, 8925.955370223108, 8937.59780809852, 8973.730788076367, 9468.337216395063, 9548.42709437436, 9595.136437720359, 9601.663941762004, 9652.469114198786, 8514.78713032179, 8527.829443410972, 8597.65609375643, 8630.56847157627, 8703.695370661997, 8376.288015518505, 8419.62111704987, 8544.91455085466, 8569.10024447424, 8588.0, 7764.961175194087, 7855.685772569262, 7883.251091146332, 7891.171427000312, 7895.84208315842, 5433.320834895638, 5712.6286791358425, 5720.141978703062, 5774.335951365479, 5780.393058728773, 5666.405027472056, 5718.599698021098, 5807.651540907559, 5823.475887170175, 5876.206712093813], "value": 4986.3512456364315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9576450825901, 353.6043306597798, 354.2489921366703, 355.1193041257681, 359.5074747595794, 5790.623609465387, 5830.621009634376, 5841.766329346821, 5868.794592189274, 5884.911726324109, 5666.993551454633, 5719.571032172583, 5727.568107973007, 5754.453326933945, 5757.165211044396, 4490.259107247301, 4500.459944806627, 4540.341650460681, 4541.409616749835, 4543.772811359436, 4519.141363140992, 4536.319552067183, 4542.227821270392, 4546.954530454703, 4554.65840061995, 4490.191765482212, 4510.0, 4513.7517436540975, 4522.886927826798, 4526.954730452702, 4332.545082766312, 4408.779561021936, 4434.2905135178535, 4441.888952776174, 4449.621782148522, 3909.612087708851, 3918.746001279592, 3928.5678575356687, 3930.6855451563806, 3933.8229779659982, 5562.554995600342, 5577.386487486373, 5582.86042848928, 5588.4411558844195, 5601.831945041656, 4997.525235102659, 5104.3619547556555, 5138.665986710852, 5176.6893986360565, 5200.245964335188, 5997.580169388145, 6005.40856672982, 6028.668423236764, 6030.698465076773, 6039.426254505859, 4405.31717583775, 4405.691601587891, 4408.669349798778, 4411.757353345564, 4414.757188354672, 5938.198343223653, 5953.642781433128, 6052.455279024909, 6171.0, 6241.251049873998, 4383.189110014658, 4393.714408563497, 4394.231009573312, 4416.536263692266, 4419.248727716296, 4429.490608580055, 4448.0, 4455.443069616298, 4476.619487343547, 4479.17135329965, 4953.529414705597, 5070.138076527, 5112.74436278192, 5118.10433174193, 5122.718250496184, 5970.402959704082, 5974.581779275409, 5979.760809567569, 6013.398660133952, 6013.6993150342305, 1513.5156749840166, 1525.0697074784373, 1528.9006214596238, 1537.446519253068, 1539.93070311834, 931.9580618872167, 977.726236653738, 982.1210017034714, 985.9260555458369, 998.8801343838786, 5125.923111153335, 5139.588832893434, 5160.535551800356, 5171.345169545709, 5183.0563538673, 5392.622516423813, 5421.83734487966, 5455.727213639302, 5466.289382380344, 5488.341399032061, 4966.230234313687, 5121.3854337479, 5159.74201289934, 5193.221016847428, 5213.504717051874, 2844.7013063628433, 2878.7409133178116, 2912.339966219277, 2917.839518826485, 2922.8392438415667, 5461.2354270402175, 5657.2928383952, 5662.603617746719, 5667.489925906688, 5678.4037676044245, 5212.7914883405, 5453.591505309182, 5486.204500347428, 5506.752196151103, 5533.584981126432, 5548.4174161712435, 5550.946979161526, 5559.9444005560235, 5587.441255874462, 5590.776368945197, 5109.8978020438635, 5265.473452654704, 5366.919496207482, 5386.4110087523495, 5408.810061786401, 5306.230596563554, 5308.46915308466, 5325.813596524103, 5351.277577526984, 5351.608581768846, 6292.056191571301, 6457.838554036187, 6481.870362592627, 6494.6103233806125, 6497.0833604085965, 4331.566843315643, 4409.206342858316, 4420.204363214652, 4426.712263702849, 4439.733615983051, 6154.78458253959, 6207.689615519115, 6265.122882796503, 6282.0, 6298.779542715983, 6096.847578810565, 6116.908246376397, 6125.84685382869, 6131.0, 6147.323794382525, 5933.923126905548, 6116.755329786759, 6126.111713801563, 6128.4790792783115, 6131.877362452815, 6064.93863573864, 6080.148779170831, 6106.786262480792, 6117.357677443804, 6119.44924956756, 6127.632342059491, 6163.722632481459, 6165.352637972948, 6170.9074363885475, 6183.423227077066, 5841.4450627190345, 5974.253218347707, 6017.518598512021, 6018.849528761816, 6037.969810150921], "value": 4457.916347206838, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3441730356163, 706.7031846624417, 736.124012425214, 752.574795240689, 790.3677058353318, 15984.280707368167, 17166.39917602884, 17212.741808872877, 17257.964522128666, 17387.217575209113, 15913.204339783022, 16035.35858565656, 16100.275487603056, 16116.597085072879, 16131.43539976101, 729.1614643160368, 884.2925659472428, 901.4861528928514, 902.6660135749781, 907.2968449451662, 895.7760559860035, 897.0401670212875, 898.2634239923266, 899.3974037394961, 899.8155378147464, 956.9043095690445, 957.8180145772316, 959.7648576098866, 960.159860122393, 962.2494454325603, 952.5142177489496, 952.7189479103681, 952.885653721551, 953.823542644613, 954.8233576788282, 701.4353445476389, 706.4207349973024, 706.9010338552607, 706.9823254418629, 708.3341658840674, 15592.922035389864, 15606.141662208574, 15611.063336199752, 15615.921920390325, 15653.608659783482, 13770.380332885044, 13798.65503362414, 13858.0, 14064.2967851607, 14329.140251584835, 12252.81620775689, 12353.382330883509, 12370.0, 12377.93811030948, 12385.071119666061, 4167.729097608646, 4171.478565179353, 4180.644645205161, 4204.789760511992, 4275.978620106911, 82284.0, 82328.58835705783, 83024.0, 83552.58223708904, 84115.57942210311, 10722.946385268024, 10731.731706707395, 10762.300450470695, 11179.944100279447, 11377.772444551063, 19656.0, 19691.01544922777, 19706.70439943402, 19708.507287317643, 19711.310104146287, 9019.323550733721, 9107.772305692279, 9211.30915181364, 9596.376235544667, 9602.519874006412, 5192.81825136126, 5329.307190065267, 5361.651492652965, 5381.3811411687375, 5427.83716488506, 4004.8598299059395, 4076.8165432555606, 4097.385392191195, 4119.835206591702, 4147.81334839933, 689.0628744906923, 692.4183685704032, 692.6744430117836, 706.5654622407183, 714.2500374606747, 757.9279968402993, 775.6703401054642, 788.3535500889216, 795.3915254830059, 807.8505476486869, 10593.52329145175, 10760.569577216824, 10773.676789696321, 10832.945835270932, 11005.559777608965, 762.3951581920089, 787.173467858746, 799.7800604833601, 812.5368539932182, 814.1126172471916, 5141.691498510101, 5313.388960269541, 5359.651622644516, 5407.405185429599, 5409.486098820685, 134214.0, 134687.0, 135812.29349635306, 137114.31442842723, 137132.0, 91103.54448227717, 93960.0, 113620.43189783998, 113966.0, 117002.0, 55094.0, 76237.9999999989, 91278.54360728154, 94876.52561737286, 96119.51940240254, 10429.634962776267, 10842.241043126905, 11013.0, 11060.336379817236, 11136.220464567403, 55633.0, 56589.15116273342, 56684.0, 57391.42608573861, 59702.402975969686, 72677.0, 74358.0, 81615.59192204001, 82071.0, 82111.0, 13761.17432954026, 14093.365798539295, 14284.71430571362, 14343.426262949366, 14384.136951782926, 15115.622109447351, 15496.84503154999, 15666.0, 15746.842531574996, 15997.520074397788, 14245.287735613385, 14299.21354325522, 14367.281635917952, 14382.640433989234, 14600.707985840012, 14199.219042952736, 14526.491572794901, 14849.183294918883, 14954.177520236492, 14973.700525989638, 13673.794893076412, 13893.166410015432, 14191.148531088167, 14296.142231466145, 14913.105213687213, 11692.532298707956, 11728.537007228577, 11901.821472677744, 12075.154739168174, 12204.206726562745, 12126.878731212928, 12562.685932851751, 12661.93669031649, 12904.612861614167, 12958.28729419891], "value": 8142.055943611925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 104.0, 111.0, 112.0, 113.0, 113.0, 114.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 118.0, 143.0, 174.0, 118.0, 147.0, 151.0, 115.0, 177.0, 126.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 163.0, 163.0, 161.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 184.0, 76.0, 75.0, 74.0, 76.0, 180.0, 75.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 152.0, 84.0, 84.0, 84.0, 142.0, 83.0, 84.0, 143.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 51.0, 55.0, 51.0, 51.0, 51.0, 52.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 59.0, 60.0, 61.0, 65.0, 63.0, 63.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 82.0, 75.0, 78.0, 71.0, 72.0, 72.0, 78.0, 71.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 132.0, 119.0, 122.0, 118.0, 124.0, 119.0, 128.0, 163.0, 118.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 157.0, 152.0, 150.0, 158.0, 149.0, 153.0, 149.0, 156.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 70.0, 61.0, 61.0, 62.0, 63.0, 60.0, 61.0, 60.0], "value": 62.3, "unit": "score"}]}]} 15:34:43 INFO - Return code: 0 15:34:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:34:44 ERROR - # TBPL SUCCESS # 15:34:44 INFO - Running post-action listener: _resource_record_post_action 15:34:44 INFO - [mozharness: 2016-10-03 22:34:44.005449Z] Finished run-tests step (success) 15:34:44 INFO - Running post-run listener: _resource_record_post_run 15:34:44 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288907264; Read time: 184; Write time: 157172 15:34:44 INFO - TinderboxPrint: CPU usage
13.2% 15:34:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 15:34:44 INFO - TinderboxPrint: I/O write bytes / time
288,907,264 / 157,172 15:34:44 INFO - TinderboxPrint: CPU idle
8,205.3 (86.8%) 15:34:44 INFO - TinderboxPrint: CPU user
1,197.2 (12.7%) 15:34:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:34:44 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 70103040; Read time: 16; Write time: 48996 15:34:44 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218804224; Read time: 168; Write time: 108176 15:34:44 INFO - Running post-run listener: _upload_blobber_files 15:34:44 INFO - Blob upload gear active. 15:34:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:44 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 15:34:44 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'] 15:34:44 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 15:34:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:48 INFO - (blobuploader) - INFO - Done attempting. 15:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:49 INFO - (blobuploader) - INFO - Done attempting. 15:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:50 INFO - (blobuploader) - INFO - Done attempting. 15:34:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:50 INFO - Return code: 0 15:34:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eec8e6558b2e2c0b4c88ee941c97f85d5063842575506bdc1a14c1a2f887f13991c1299892ff8328eeee617d7ff54ef1bfadfe99c88fd1b3f8289151fc03767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f8042db9317f399ebc2e74dd82ebe1d384ca9e385bf0fa06f473109aa20a09135310d397177560b2c3ac4c27bc7a69f74b6a2af2d73af82670b410f57ff1df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4873e0d8aef87eca2974a167b77fce12232c1d4f66078753720f07736c8ecba8c3769db603a8496152b79a27a3c63e4b759a3b3da36fe81022b6953723a40a8f"} 15:34:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:50 INFO - Contents: 15:34:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eec8e6558b2e2c0b4c88ee941c97f85d5063842575506bdc1a14c1a2f887f13991c1299892ff8328eeee617d7ff54ef1bfadfe99c88fd1b3f8289151fc03767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f8042db9317f399ebc2e74dd82ebe1d384ca9e385bf0fa06f473109aa20a09135310d397177560b2c3ac4c27bc7a69f74b6a2af2d73af82670b410f57ff1df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4873e0d8aef87eca2974a167b77fce12232c1d4f66078753720f07736c8ecba8c3769db603a8496152b79a27a3c63e4b759a3b3da36fe81022b6953723a40a8f"} 15:34:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:50 INFO - Copying logs to upload dir... 15:34:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.117909 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-03 15:34:49.360877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 15:34:49.364825) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595 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/2eec8e6558b2e2c0b4c88ee941c97f85d5063842575506bdc1a14c1a2f887f13991c1299892ff8328eeee617d7ff54ef1bfadfe99c88fd1b3f8289151fc03767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f8042db9317f399ebc2e74dd82ebe1d384ca9e385bf0fa06f473109aa20a09135310d397177560b2c3ac4c27bc7a69f74b6a2af2d73af82670b410f57ff1df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4873e0d8aef87eca2974a167b77fce12232c1d4f66078753720f07736c8ecba8c3769db603a8496152b79a27a3c63e4b759a3b3da36fe81022b6953723a40a8f"} build_url:https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/bakuT_8zR-CFGYbgmCQvxg/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/2eec8e6558b2e2c0b4c88ee941c97f85d5063842575506bdc1a14c1a2f887f13991c1299892ff8328eeee617d7ff54ef1bfadfe99c88fd1b3f8289151fc03767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f8042db9317f399ebc2e74dd82ebe1d384ca9e385bf0fa06f473109aa20a09135310d397177560b2c3ac4c27bc7a69f74b6a2af2d73af82670b410f57ff1df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4873e0d8aef87eca2974a167b77fce12232c1d4f66078753720f07736c8ecba8c3769db603a8496152b79a27a3c63e4b759a3b3da36fe81022b6953723a40a8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 15:34:49.395140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:34:49.395517) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475531810.257866-29180595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:34:49.480901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 15:34:49.481577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 15:34:49.482170) ========= ========= Total master_lag: 0.18 =========