builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1472163408.78 results: success (0) buildid: 20160825133418 builduid: 7d5b5d41f4454299a73fa8bd7997747e revision: 3a73ccd4e90e826d14b54d084d0fb3768271796c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.778531) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.779041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.779367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.793865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.794185) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 15:16:48-- 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% 87.8M=0s 2016-08-25 15:16:48 (87.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.903814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.904220) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.954130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:48.954512) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a73ccd4e90e826d14b54d084d0fb3768271796c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a73ccd4e90e826d14b54d084d0fb3768271796c --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=e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 15:16:49,062 truncating revision to first 12 chars 2016-08-25 15:16:49,062 Setting DEBUG logging. 2016-08-25 15:16:49,062 attempt 1/10 2016-08-25 15:16:49,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a73ccd4e90e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 15:16:49,400 unpacking tar archive at: mozilla-aurora-3a73ccd4e90e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:49.600412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:49.600780) ========= script_repo_revision: 3a73ccd4e90e826d14b54d084d0fb3768271796c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:49.601289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:49.601598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 15:16:49.612114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-25 15:16:49.612426) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:16:49 INFO - MultiFileLogger online at 20160825 15:16:49 in /builds/slave/test 15:16:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:16:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:49 INFO - {'append_to_log': False, 15:16:49 INFO - 'base_work_dir': '/builds/slave/test', 15:16:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:16:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:49 INFO - 'branch': 'Mozilla-Aurora', 15:16:49 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:49 INFO - 'config_files': ('talos/linux_config.py',), 15:16:49 INFO - 'default_actions': ('clobber', 15:16:49 INFO - 'read-buildbot-config', 15:16:49 INFO - 'download-and-extract', 15:16:49 INFO - 'populate-webroot', 15:16:49 INFO - 'create-virtualenv', 15:16:49 INFO - 'install', 15:16:49 INFO - 'run-tests'), 15:16:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:49 INFO - 'download_minidump_stackwalk': True, 15:16:49 INFO - 'download_symbols': 'ondemand', 15:16:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:49 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:49 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:49 INFO - 'installer_path': 'installer.exe', 15:16:49 INFO - 'log_level': 'info', 15:16:49 INFO - 'log_name': 'talos', 15:16:49 INFO - 'log_to_console': True, 15:16:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:16:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:16:49 INFO - 'opt_config_files': (), 15:16:49 INFO - 'pip_index': False, 15:16:49 INFO - 'sps_profile': False, 15:16:49 INFO - 'sps_profile_interval': 0, 15:16:49 INFO - 'suite': 'dromaeojs-e10s', 15:16:49 INFO - 'system_bits': '32', 15:16:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:49 INFO - 'title': 'talos-linux64-ix-067', 15:16:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:49 INFO - 'use_talos_json': True, 15:16:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:49 INFO - 'work_dir': 'build'} 15:16:49 INFO - [mozharness: 2016-08-25 22:16:49.809773Z] Running clobber step. 15:16:49 INFO - Running pre-action listener: _resource_record_pre_action 15:16:49 INFO - Running main action method: clobber 15:16:49 INFO - rmtree: /builds/slave/test/build 15:16:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:50 INFO - Running post-action listener: _resource_record_post_action 15:16:50 INFO - [mozharness: 2016-08-25 22:16:50.253517Z] Finished clobber step (success) 15:16:50 INFO - [mozharness: 2016-08-25 22:16:50.253636Z] Running read-buildbot-config step. 15:16:50 INFO - Running pre-action listener: _resource_record_pre_action 15:16:50 INFO - Running main action method: read_buildbot_config 15:16:50 INFO - Using buildbot properties: 15:16:50 INFO - { 15:16:50 INFO - "project": "", 15:16:50 INFO - "product": "firefox", 15:16:50 INFO - "script_repo_revision": "production", 15:16:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:16:50 INFO - "repository": "", 15:16:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:16:50 INFO - "buildid": "20160825133418", 15:16:50 INFO - "pgo_build": "True", 15:16:50 INFO - "basedir": "/builds/slave/test", 15:16:50 INFO - "buildnumber": 510, 15:16:50 INFO - "slavename": "talos-linux64-ix-067", 15:16:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:16:50 INFO - "platform": "ubuntu64_hw", 15:16:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:16:50 INFO - "branch": "mozilla-aurora", 15:16:50 INFO - "repo_path": "releases/mozilla-aurora", 15:16:50 INFO - "revision": "3a73ccd4e90e826d14b54d084d0fb3768271796c", 15:16:50 INFO - "stage_platform": "linux64-pgo", 15:16:50 INFO - "builduid": "7d5b5d41f4454299a73fa8bd7997747e", 15:16:50 INFO - "slavebuilddir": "test" 15:16:50 INFO - } 15:16:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 15:16:50 INFO - Running post-action listener: _resource_record_post_action 15:16:50 INFO - [mozharness: 2016-08-25 22:16:50.256074Z] Finished read-buildbot-config step (success) 15:16:50 INFO - [mozharness: 2016-08-25 22:16:50.256163Z] Running download-and-extract step. 15:16:50 INFO - Running pre-action listener: _resource_record_pre_action 15:16:50 INFO - Running main action method: download_and_extract 15:16:50 INFO - mkdir: /builds/slave/test/build/tests 15:16: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:16:50 INFO - https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:16:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:16:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:16:50 INFO - retry: Failed, sleeping 30 seconds before retrying 15:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 15:17:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:17:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:17:20 INFO - retry: Failed, sleeping 60 seconds before retrying 15:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 15:18:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:18:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:18:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 15:18:20 INFO - Caught exception: HTTP Error 404: Not Found 15:18:20 INFO - Caught exception: HTTP Error 404: Not Found 15:18:20 INFO - Caught exception: HTTP Error 404: Not Found 15:18:20 INFO - trying https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:18:20 INFO - Downloading https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:18:20 INFO - Downloaded 1361 bytes. 15:18:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:18:20 INFO - Using the following test package requirements: 15:18:20 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:20 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:20 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:18:20 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'jsshell-linux-x86_64.zip'], 15:18:20 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:20 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:20 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:18:20 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:18:20 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:20 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:20 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:20 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18:20 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:18:20 INFO - https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:18:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:18:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:18:20 INFO - retry: Failed, sleeping 30 seconds before retrying 15:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 15:18:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:18:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:18:50 INFO - retry: Failed, sleeping 60 seconds before retrying 15:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:19:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:19:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 15:19:51 INFO - Caught exception: HTTP Error 404: Not Found 15:19:51 INFO - Caught exception: HTTP Error 404: Not Found 15:19:51 INFO - Caught exception: HTTP Error 404: Not Found 15:19:51 INFO - trying https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:51 INFO - Downloading https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:19:51 INFO - Downloaded 21768186 bytes. 15:19:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:19:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:19:53 INFO - Return code: 0 15:19:53 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:19:53 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:19:53 INFO - https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:19:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:19:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:19:53 INFO - retry: Failed, sleeping 30 seconds before retrying 15:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 15:20:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:20:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:20:23 INFO - retry: Failed, sleeping 60 seconds before retrying 15:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:21:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:21:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:21:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 15:21:23 INFO - Caught exception: HTTP Error 404: Not Found 15:21:23 INFO - Caught exception: HTTP Error 404: Not Found 15:21:23 INFO - Caught exception: HTTP Error 404: Not Found 15:21:23 INFO - trying https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:21:23 INFO - Downloading https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:23 INFO - Downloaded 21768186 bytes. 15:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:21:25 INFO - Return code: 0 15:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:25 INFO - https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:21:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:21:25 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:21:25 INFO - retry: Failed, sleeping 30 seconds before retrying 15:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 15:21:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:21:55 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:21:55 INFO - retry: Failed, sleeping 60 seconds before retrying 15:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 15:22:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:22:55 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:22:55 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 15:22:55 INFO - Caught exception: HTTP Error 404: Not Found 15:22:55 INFO - Caught exception: HTTP Error 404: Not Found 15:22:55 INFO - Caught exception: HTTP Error 404: Not Found 15:22:55 INFO - trying https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:22:55 INFO - Downloading https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:22:56 INFO - Downloaded 14413723 bytes. 15:22:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:22:56 INFO - Return code: 0 15:22:56 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:22:56 INFO - https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:22:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:22:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:22:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:22:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:22:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:22:56 INFO - retry: Failed, sleeping 30 seconds before retrying 15:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 15:23:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:23:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:23:26 INFO - retry: Failed, sleeping 60 seconds before retrying 15:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 15:24:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:24:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:24:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 15:24:26 INFO - Caught exception: HTTP Error 404: Not Found 15:24:26 INFO - Caught exception: HTTP Error 404: Not Found 15:24:26 INFO - Caught exception: HTTP Error 404: Not Found 15:24:26 INFO - trying https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:24:26 INFO - Downloading https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:24:27 INFO - Downloaded 63768836 bytes. 15:24:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:24:27 INFO - mkdir: /builds/slave/test/properties 15:24:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:27 INFO - Contents: 15:24:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:24:28 INFO - Running post-action listener: _resource_record_post_action 15:24:28 INFO - Running post-action listener: set_extra_try_arguments 15:24:28 INFO - [mozharness: 2016-08-25 22:24:28.477611Z] Finished download-and-extract step (success) 15:24:28 INFO - [mozharness: 2016-08-25 22:24:28.477879Z] Running populate-webroot step. 15:24:28 INFO - Running pre-action listener: _resource_record_pre_action 15:24:28 INFO - Running main action method: populate_webroot 15:24:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:28 INFO - '--tppagecycles', 15:24:28 INFO - '7'], 15:24:28 INFO - 'tests': ['tsvgm']}}, 15:24:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['damp', 'tps']}, 15:24:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'tests': ['damp', 'tps']}, 15:24:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['dromaeo_dom']}, 15:24:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['basic_compositor_video']}, 15:24:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:24:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['tsvgx', 15:24:28 INFO - 'tsvgr_opacity', 15:24:28 INFO - 'tart', 15:24:28 INFO - 'tscrollx', 15:24:28 INFO - 'cart']}, 15:24:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:28 INFO - 'tsvgr_opacity', 15:24:28 INFO - 'tart', 15:24:28 INFO - 'tscrollx', 15:24:28 INFO - 'cart']}, 15:24:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'talos_options': ['--disable-e10s'], 15:24:28 INFO - 'tests': ['tp5o']}, 15:24:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'tests': ['tp5o']}, 15:24:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'talos_options': ['--disable-e10s', 15:24:28 INFO - '--xperf_path', 15:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:28 INFO - 'tests': ['tp5n']}, 15:24:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:28 INFO - 'talos_options': ['--xperf_path', 15:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:28 INFO - 'tests': ['tp5n']}}, 15:24:28 INFO - 'talos.zip': {'path': '', 15:24:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:28 INFO - Running post-action listener: _resource_record_post_action 15:24:28 INFO - [mozharness: 2016-08-25 22:24:28.496157Z] Finished populate-webroot step (success) 15:24:28 INFO - [mozharness: 2016-08-25 22:24:28.496246Z] Running create-virtualenv step. 15:24:28 INFO - Running pre-action listener: _resource_record_pre_action 15:24:28 INFO - Running main action method: create_virtualenv 15:24:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:28 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:24:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:28 INFO - Using real prefix '/usr' 15:24:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:31 INFO - Installing pip.................done. 15:24:31 INFO - Return code: 0 15:24:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:31 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:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:31 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:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:31 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:31 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:24:31 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:24:31 INFO - Using env: {'DISPLAY': ':0', 15:24:31 INFO - 'HOME': '/home/cltbld', 15:24:31 INFO - 'LANG': 'en_US.UTF-8', 15:24:31 INFO - 'LANGUAGE': 'en_US:en', 15:24:31 INFO - 'LOGNAME': 'cltbld', 15:24:31 INFO - 'MAIL': '/var/mail/cltbld', 15:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:31 INFO - 'MOZ_NO_REMOTE': '1', 15:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:31 INFO - 'NO_EM_RESTART': '1', 15:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:31 INFO - 'PWD': '/builds/slave/test', 15:24:31 INFO - 'SHELL': '/bin/bash', 15:24:31 INFO - 'SHLVL': '1', 15:24:31 INFO - 'TERM': 'linux', 15:24:31 INFO - 'TMOUT': '86400', 15:24:31 INFO - 'USER': 'cltbld', 15:24:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:31 INFO - '_': '/tools/buildbot/bin/python'} 15:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:31 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:24:31 INFO - Cleaning up... 15:24:31 INFO - Return code: 0 15:24:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:31 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:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:31 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:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:31 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:31 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:24:31 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:24:31 INFO - Using env: {'DISPLAY': ':0', 15:24:31 INFO - 'HOME': '/home/cltbld', 15:24:31 INFO - 'LANG': 'en_US.UTF-8', 15:24:31 INFO - 'LANGUAGE': 'en_US:en', 15:24:31 INFO - 'LOGNAME': 'cltbld', 15:24:31 INFO - 'MAIL': '/var/mail/cltbld', 15:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:31 INFO - 'MOZ_NO_REMOTE': '1', 15:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:31 INFO - 'NO_EM_RESTART': '1', 15:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:31 INFO - 'PWD': '/builds/slave/test', 15:24:31 INFO - 'SHELL': '/bin/bash', 15:24:31 INFO - 'SHLVL': '1', 15:24:31 INFO - 'TERM': 'linux', 15:24:31 INFO - 'TMOUT': '86400', 15:24:31 INFO - 'USER': 'cltbld', 15:24:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:31 INFO - '_': '/tools/buildbot/bin/python'} 15:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:31 INFO - Downloading/unpacking psutil>=3.1.1 15:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:33 INFO - Installing collected packages: psutil 15:24:33 INFO - Running setup.py install for psutil 15:24:33 INFO - building 'psutil._psutil_linux' extension 15:24:33 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:24:33 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:24:33 INFO - building 'psutil._psutil_posix' extension 15:24:33 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:24:33 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:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:33 INFO - Successfully installed psutil 15:24:33 INFO - Cleaning up... 15:24:34 INFO - Return code: 0 15:24:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:24:34 INFO - Using env: {'DISPLAY': ':0', 15:24:34 INFO - 'HOME': '/home/cltbld', 15:24:34 INFO - 'LANG': 'en_US.UTF-8', 15:24:34 INFO - 'LANGUAGE': 'en_US:en', 15:24:34 INFO - 'LOGNAME': 'cltbld', 15:24:34 INFO - 'MAIL': '/var/mail/cltbld', 15:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:34 INFO - 'MOZ_NO_REMOTE': '1', 15:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:34 INFO - 'NO_EM_RESTART': '1', 15:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:34 INFO - 'PWD': '/builds/slave/test', 15:24:34 INFO - 'SHELL': '/bin/bash', 15:24:34 INFO - 'SHLVL': '1', 15:24:34 INFO - 'TERM': 'linux', 15:24:34 INFO - 'TMOUT': '86400', 15:24:34 INFO - 'USER': 'cltbld', 15:24:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:34 INFO - '_': '/tools/buildbot/bin/python'} 15:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:36 INFO - Installing collected packages: mozsystemmonitor 15:24:36 INFO - Running setup.py install for mozsystemmonitor 15:24:36 INFO - Successfully installed mozsystemmonitor 15:24:36 INFO - Cleaning up... 15:24:36 INFO - Return code: 0 15:24:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:36 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:36 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:24:36 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:24:36 INFO - Using env: {'DISPLAY': ':0', 15:24:36 INFO - 'HOME': '/home/cltbld', 15:24:36 INFO - 'LANG': 'en_US.UTF-8', 15:24:36 INFO - 'LANGUAGE': 'en_US:en', 15:24:36 INFO - 'LOGNAME': 'cltbld', 15:24:36 INFO - 'MAIL': '/var/mail/cltbld', 15:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:36 INFO - 'MOZ_NO_REMOTE': '1', 15:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:36 INFO - 'NO_EM_RESTART': '1', 15:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:36 INFO - 'PWD': '/builds/slave/test', 15:24:36 INFO - 'SHELL': '/bin/bash', 15:24:36 INFO - 'SHLVL': '1', 15:24:36 INFO - 'TERM': 'linux', 15:24:36 INFO - 'TMOUT': '86400', 15:24:36 INFO - 'USER': 'cltbld', 15:24:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:36 INFO - '_': '/tools/buildbot/bin/python'} 15:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:36 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:36 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:24:36 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:24:36 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:24:36 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:24:36 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:24:36 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:24:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:38 INFO - warning: no files found matching '*.txt' 15:24:38 INFO - no previously-included directories found matching 'build' 15:24:38 INFO - no previously-included directories found matching 'dist' 15:24:38 INFO - no previously-included directories found matching '.git*' 15:24:38 INFO - Installing collected packages: jsonschema, functools32 15:24:38 INFO - Running setup.py install for functools32 15:24:38 INFO - warning: no files found matching '*.txt' 15:24:38 INFO - no previously-included directories found matching 'build' 15:24:38 INFO - no previously-included directories found matching 'dist' 15:24:38 INFO - no previously-included directories found matching '.git*' 15:24:38 INFO - Successfully installed jsonschema functools32 15:24:38 INFO - Cleaning up... 15:24:38 INFO - Return code: 0 15:24:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:24:38 INFO - Using env: {'DISPLAY': ':0', 15:24:38 INFO - 'HOME': '/home/cltbld', 15:24:38 INFO - 'LANG': 'en_US.UTF-8', 15:24:38 INFO - 'LANGUAGE': 'en_US:en', 15:24:38 INFO - 'LOGNAME': 'cltbld', 15:24:38 INFO - 'MAIL': '/var/mail/cltbld', 15:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:38 INFO - 'MOZ_NO_REMOTE': '1', 15:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:38 INFO - 'NO_EM_RESTART': '1', 15:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:38 INFO - 'PWD': '/builds/slave/test', 15:24:38 INFO - 'SHELL': '/bin/bash', 15:24:38 INFO - 'SHLVL': '1', 15:24:38 INFO - 'TERM': 'linux', 15:24:38 INFO - 'TMOUT': '86400', 15:24:38 INFO - 'USER': 'cltbld', 15:24:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:38 INFO - '_': '/tools/buildbot/bin/python'} 15:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:39 INFO - Cleaning up... 15:24:39 INFO - Return code: 0 15:24:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24: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:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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', '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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:24: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 blobuploader==1.2.4 15:24:39 INFO - Using env: {'DISPLAY': ':0', 15:24:39 INFO - 'HOME': '/home/cltbld', 15:24:39 INFO - 'LANG': 'en_US.UTF-8', 15:24:39 INFO - 'LANGUAGE': 'en_US:en', 15:24:39 INFO - 'LOGNAME': 'cltbld', 15:24:39 INFO - 'MAIL': '/var/mail/cltbld', 15:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:39 INFO - 'MOZ_NO_REMOTE': '1', 15:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:39 INFO - 'NO_EM_RESTART': '1', 15:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:39 INFO - 'PWD': '/builds/slave/test', 15:24:39 INFO - 'SHELL': '/bin/bash', 15:24:39 INFO - 'SHLVL': '1', 15:24:39 INFO - 'TERM': 'linux', 15:24:39 INFO - 'TMOUT': '86400', 15:24:39 INFO - 'USER': 'cltbld', 15:24:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:39 INFO - '_': '/tools/buildbot/bin/python'} 15:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:24: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:24: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:24: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:24: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:24: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:24: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:24:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:41 INFO - Downloading docopt-0.6.1.tar.gz 15:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:41 INFO - Running setup.py install for blobuploader 15:24:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:42 INFO - Running setup.py install for requests 15:24:42 INFO - Running setup.py install for docopt 15:24:42 INFO - Successfully installed blobuploader requests docopt 15:24:42 INFO - Cleaning up... 15:24:42 INFO - Return code: 0 15:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24: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:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:42 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:42 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:24:42 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:24:42 INFO - Using env: {'DISPLAY': ':0', 15:24:42 INFO - 'HOME': '/home/cltbld', 15:24:42 INFO - 'LANG': 'en_US.UTF-8', 15:24:42 INFO - 'LANGUAGE': 'en_US:en', 15:24:42 INFO - 'LOGNAME': 'cltbld', 15:24:42 INFO - 'MAIL': '/var/mail/cltbld', 15:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:42 INFO - 'MOZ_NO_REMOTE': '1', 15:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:42 INFO - 'NO_EM_RESTART': '1', 15:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:42 INFO - 'PWD': '/builds/slave/test', 15:24:42 INFO - 'SHELL': '/bin/bash', 15:24:42 INFO - 'SHLVL': '1', 15:24:42 INFO - 'TERM': 'linux', 15:24:42 INFO - 'TMOUT': '86400', 15:24:42 INFO - 'USER': 'cltbld', 15:24:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:42 INFO - '_': '/tools/buildbot/bin/python'} 15:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:42 INFO - Running setup.py (path:/tmp/pip-1NtlqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:42 INFO - Running setup.py (path:/tmp/pip-aAgwnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:42 INFO - Running setup.py (path:/tmp/pip-dDrayl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:42 INFO - Running setup.py (path:/tmp/pip-dmrJZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:43 INFO - Running setup.py (path:/tmp/pip-njlWlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:43 INFO - Running setup.py (path:/tmp/pip-MRxi0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:43 INFO - Running setup.py (path:/tmp/pip-S7l02Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:43 INFO - Running setup.py (path:/tmp/pip-W7JLcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:43 INFO - Running setup.py (path:/tmp/pip-KOwl7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:43 INFO - Running setup.py (path:/tmp/pip-Z3NcNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:43 INFO - Running setup.py (path:/tmp/pip-YWfO0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:43 INFO - Running setup.py (path:/tmp/pip-2sZwWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:43 INFO - Running setup.py (path:/tmp/pip-URFxGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:43 INFO - Running setup.py (path:/tmp/pip-szRuJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:43 INFO - Running setup.py (path:/tmp/pip-7KQhD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:43 INFO - Running setup.py (path:/tmp/pip-dAYi1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:43 INFO - Running setup.py (path:/tmp/pip-plZkeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:43 INFO - Running setup.py install for manifestparser 15:24:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozcrash 15:24:44 INFO - Running setup.py install for mozdebug 15:24:44 INFO - Running setup.py install for mozdevice 15:24:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozfile 15:24:44 INFO - Running setup.py install for mozhttpd 15:24:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozinfo 15:24:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozInstall 15:24:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozleak 15:24:44 INFO - Running setup.py install for mozlog 15:24:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for moznetwork 15:24:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:45 INFO - Running setup.py install for mozprocess 15:24:45 INFO - Running setup.py install for mozprofile 15:24:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:45 INFO - Running setup.py install for mozrunner 15:24:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:45 INFO - Running setup.py install for mozscreenshot 15:24:45 INFO - Running setup.py install for moztest 15:24:45 INFO - Running setup.py install for mozversion 15:24:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:45 INFO - Cleaning up... 15:24:45 INFO - Return code: 0 15:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:45 INFO - Using env: {'DISPLAY': ':0', 15:24:45 INFO - 'HOME': '/home/cltbld', 15:24:45 INFO - 'LANG': 'en_US.UTF-8', 15:24:45 INFO - 'LANGUAGE': 'en_US:en', 15:24:45 INFO - 'LOGNAME': 'cltbld', 15:24:45 INFO - 'MAIL': '/var/mail/cltbld', 15:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:45 INFO - 'MOZ_NO_REMOTE': '1', 15:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:45 INFO - 'NO_EM_RESTART': '1', 15:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:45 INFO - 'PWD': '/builds/slave/test', 15:24:45 INFO - 'SHELL': '/bin/bash', 15:24:45 INFO - 'SHLVL': '1', 15:24:45 INFO - 'TERM': 'linux', 15:24:45 INFO - 'TMOUT': '86400', 15:24:45 INFO - 'USER': 'cltbld', 15:24:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:45 INFO - '_': '/tools/buildbot/bin/python'} 15:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:45 INFO - Running setup.py (path:/tmp/pip-BtZjaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:46 INFO - Running setup.py (path:/tmp/pip-T705AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:46 INFO - Running setup.py (path:/tmp/pip-K7ldUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:46 INFO - Running setup.py (path:/tmp/pip-boZIdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:46 INFO - Running setup.py (path:/tmp/pip-8wHYHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:46 INFO - Running setup.py (path:/tmp/pip-WPQiNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:46 INFO - Running setup.py (path:/tmp/pip-061fLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:46 INFO - Running setup.py (path:/tmp/pip-S49qXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:46 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:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:46 INFO - Running setup.py (path:/tmp/pip-QVUCs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:46 INFO - Running setup.py (path:/tmp/pip-6gzUR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:46 INFO - Running setup.py (path:/tmp/pip-kM1RPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:46 INFO - Running setup.py (path:/tmp/pip-31giSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:46 INFO - Running setup.py (path:/tmp/pip-nvFwFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:46 INFO - Running setup.py (path:/tmp/pip-qFiBtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:47 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:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:47 INFO - Running setup.py (path:/tmp/pip-oH53P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:47 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:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:47 INFO - Running setup.py (path:/tmp/pip-zHXynU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:47 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:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:47 INFO - Running setup.py (path:/tmp/pip-jB30XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:47 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:24:47 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:24:47 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:24:47 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:24:47 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:24:47 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:24:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24: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:24: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:24: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:24: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:24: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:24: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:24:49 INFO - Downloading blessings-1.6.tar.gz 15:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:49 INFO - Installing collected packages: blessings 15:24:49 INFO - Running setup.py install for blessings 15:24:49 INFO - Successfully installed blessings 15:24:49 INFO - Cleaning up... 15:24:49 INFO - Return code: 0 15:24:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:49 INFO - Reading from file tmpfile_stdout 15:24:49 INFO - Current package versions: 15:24:49 INFO - argparse == 1.2.1 15:24:49 INFO - blessings == 1.6 15:24:49 INFO - blobuploader == 1.2.4 15:24:49 INFO - docopt == 0.6.1 15:24:49 INFO - functools32 == 3.2.3-2 15:24:49 INFO - jsonschema == 2.5.1 15:24:49 INFO - manifestparser == 1.1 15:24:49 INFO - mozInstall == 1.12 15:24:49 INFO - mozcrash == 0.17 15:24:49 INFO - mozdebug == 0.1 15:24:49 INFO - mozdevice == 0.48 15:24:49 INFO - mozfile == 1.2 15:24:49 INFO - mozhttpd == 0.7 15:24:49 INFO - mozinfo == 0.9 15:24:49 INFO - mozleak == 0.1 15:24:49 INFO - mozlog == 3.3 15:24:49 INFO - moznetwork == 0.27 15:24:49 INFO - mozprocess == 0.23 15:24:49 INFO - mozprofile == 0.28 15:24:49 INFO - mozrunner == 6.12 15:24:49 INFO - mozscreenshot == 0.1 15:24:49 INFO - mozsystemmonitor == 0.3 15:24:49 INFO - moztest == 0.7 15:24:49 INFO - mozversion == 1.4 15:24:49 INFO - psutil == 3.1.1 15:24:49 INFO - requests == 1.2.3 15:24:49 INFO - wsgiref == 0.1.2 15:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:49 INFO - Using env: {'DISPLAY': ':0', 15:24:49 INFO - 'HOME': '/home/cltbld', 15:24:49 INFO - 'LANG': 'en_US.UTF-8', 15:24:49 INFO - 'LANGUAGE': 'en_US:en', 15:24:49 INFO - 'LOGNAME': 'cltbld', 15:24:49 INFO - 'MAIL': '/var/mail/cltbld', 15:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:49 INFO - 'MOZ_NO_REMOTE': '1', 15:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:49 INFO - 'NO_EM_RESTART': '1', 15:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:49 INFO - 'PWD': '/builds/slave/test', 15:24:49 INFO - 'SHELL': '/bin/bash', 15:24:49 INFO - 'SHLVL': '1', 15:24:49 INFO - 'TERM': 'linux', 15:24:49 INFO - 'TMOUT': '86400', 15:24:49 INFO - 'USER': 'cltbld', 15:24:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:49 INFO - '_': '/tools/buildbot/bin/python'} 15:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:24:49 INFO - Cleaning up... 15:24:49 INFO - Return code: 0 15:24:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1268400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', '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:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:24:49 INFO - Using env: {'DISPLAY': ':0', 15:24:49 INFO - 'HOME': '/home/cltbld', 15:24:49 INFO - 'LANG': 'en_US.UTF-8', 15:24:49 INFO - 'LANGUAGE': 'en_US:en', 15:24:49 INFO - 'LOGNAME': 'cltbld', 15:24:49 INFO - 'MAIL': '/var/mail/cltbld', 15:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:49 INFO - 'MOZ_NO_REMOTE': '1', 15:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:49 INFO - 'NO_EM_RESTART': '1', 15:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:49 INFO - 'PWD': '/builds/slave/test', 15:24:49 INFO - 'SHELL': '/bin/bash', 15:24:49 INFO - 'SHLVL': '1', 15:24:49 INFO - 'TERM': 'linux', 15:24:49 INFO - 'TMOUT': '86400', 15:24:49 INFO - 'USER': 'cltbld', 15:24:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:49 INFO - '_': '/tools/buildbot/bin/python'} 15:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:49 INFO - Cleaning up... 15:24:50 INFO - Return code: 0 15:24:50 INFO - Running post-action listener: _resource_record_post_action 15:24:50 INFO - Running post-action listener: _start_resource_monitoring 15:24:50 INFO - Starting resource monitoring. 15:24:50 INFO - [mozharness: 2016-08-25 22:24:50.028990Z] Finished create-virtualenv step (success) 15:24:50 INFO - [mozharness: 2016-08-25 22:24:50.029412Z] Running install step. 15:24:50 INFO - Running pre-action listener: _resource_record_pre_action 15:24:50 INFO - Running main action method: install 15:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:50 INFO - Reading from file tmpfile_stdout 15:24:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:50 INFO - Reading from file tmpfile_stdout 15:24:50 INFO - Output received: 15:24:50 INFO - Usage: mozinstall [options] installer 15:24:50 INFO - Options: 15:24:50 INFO - -h, --help show this help message and exit 15:24:50 INFO - -d DEST, --destination=DEST 15:24:50 INFO - Directory to install application into. [default: 15:24:50 INFO - "/builds/slave/test"] 15:24:50 INFO - --app=APP Application being installed. [default: firefox] 15:24:50 INFO - mkdir: /builds/slave/test/build/application 15:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:25:06 INFO - Reading from file tmpfile_stdout 15:25:06 INFO - Output received: 15:25:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:06 INFO - Running post-action listener: _resource_record_post_action 15:25:06 INFO - [mozharness: 2016-08-25 22:25:06.311843Z] Finished install step (success) 15:25:06 INFO - [mozharness: 2016-08-25 22:25:06.312122Z] Running run-tests step. 15:25:06 INFO - Running pre-action listener: _resource_record_pre_action 15:25:06 INFO - Running main action method: run_tests 15:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:06 INFO - Python 2.7.3 15:25:06 INFO - Return code: 0 15:25:06 INFO - grabbing minidump binary from tooltool 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:25:06 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 0x12f7570>, '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 0x12f8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:06 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:25:06 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:25:06 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:25:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:06 INFO - Return code: 0 15:25:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:25:06 INFO - Using env: {'DISPLAY': ':0', 15:25:06 INFO - 'HOME': '/home/cltbld', 15:25:06 INFO - 'LANG': 'en_US.UTF-8', 15:25:06 INFO - 'LANGUAGE': 'en_US:en', 15:25:06 INFO - 'LOGNAME': 'cltbld', 15:25:06 INFO - 'MAIL': '/var/mail/cltbld', 15:25:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:06 INFO - 'MOZ_NO_REMOTE': '1', 15:25:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:06 INFO - 'NO_EM_RESTART': '1', 15:25:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:06 INFO - 'PWD': '/builds/slave/test', 15:25:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:06 INFO - 'SHELL': '/bin/bash', 15:25:06 INFO - 'SHLVL': '1', 15:25:06 INFO - 'TERM': 'linux', 15:25:06 INFO - 'TMOUT': '86400', 15:25:06 INFO - 'USER': 'cltbld', 15:25:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660', 15:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:06 INFO - '_': '/tools/buildbot/bin/python'} 15:25:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:25:06 INFO - mozversion application_buildid: 20160825133418 15:25:06 INFO - mozversion application_changeset: 3a73ccd4e90e826d14b54d084d0fb3768271796c 15:25:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:25:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:06 INFO - mozversion application_name: Firefox 15:25:06 INFO - mozversion application_remotingname: firefox-dev 15:25:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:25:06 INFO - mozversion application_vendor: Mozilla 15:25:06 INFO - mozversion application_version: 50.0a2 15:25:06 INFO - mozversion platform_buildid: 20160825133418 15:25:06 INFO - mozversion platform_changeset: 3a73ccd4e90e826d14b54d084d0fb3768271796c 15:25:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:25:06 INFO - mozversion platform_version: 50.0a2 15:25:06 INFO - using testdate: 1472163906 15:25:06 INFO - actual date: 1472163906 15:25:06 INFO - starting webserver on 'localhost:40653' 15:25:06 INFO - SUITE-START | Running 2 tests 15:25:06 INFO - TEST-START | dromaeo_css 15:25:06 INFO - operating with platform_type : linux_ 15:25:06 INFO - Initialising browser for dromaeo_css test... 15:25:06 INFO - TEST-INFO | started process 5466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYWJrR9/profile http://localhost:40653/getInfo.html) 15:25:10 INFO - PROCESS | 5466 | __metrics Screen width/height:1600/1200 15:25:10 INFO - PROCESS | 5466 | colorDepth:24 15:25:10 INFO - PROCESS | 5466 | Browser inner width/height: 1024/697 15:25:10 INFO - PROCESS | 5466 | __metrics 15:25:11 ERROR - PROCESS | 5466 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:25:11 INFO - TEST-INFO | 5466: exit 0 15:25:11 INFO - Browser initialized. 15:25:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:11 INFO - TEST-INFO | started process 5596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYWJrR9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:23 INFO - PROCESS | 5596 | RSS: Main: 152768512 15:25:23 INFO - PROCESS | 5596 | 15:26:13 INFO - PROCESS | 5596 | 1472163973157 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:28:21 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:40653/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40653/tests/dromaeo/cssquery-ext.html) 15:28:23 INFO - PROCESS | 5596 | RSS: Main: 157859840 15:28:23 INFO - PROCESS | 5596 | 15:31:25 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:40653/tests/dromaeo/cssquery-ext.html (next: http://localhost:40653/tests/dromaeo/cssquery-jquery.html) 15:31:25 INFO - PROCESS | 5596 | RSS: Main: 153309184 15:31:25 INFO - PROCESS | 5596 | 15:34:27 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:40653/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40653/tests/dromaeo/cssquery-mootools.html) 15:34:28 INFO - PROCESS | 5596 | RSS: Main: 153501696 15:34:28 INFO - PROCESS | 5596 | 15:37:29 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:40653/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40653/tests/dromaeo/cssquery-prototype.html) 15:37:30 INFO - PROCESS | 5596 | RSS: Main: 152031232 15:37:30 INFO - PROCESS | 5596 | 15:40:32 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:40653/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40653/tests/dromaeo/cssquery-yui.html) 15:40:33 INFO - PROCESS | 5596 | RSS: Main: 155033600 15:40:33 INFO - PROCESS | 5596 | 15:43:35 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:40653/tests/dromaeo/cssquery-yui.html (next: http://localhost:40653/tests/dromaeo/cssquery-dojo.html) 15:43:36 INFO - PROCESS | 5596 | RSS: Main: 155852800 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | __start_tp_report 15:43:36 INFO - PROCESS | 5596 | _x_x_mozilla_page_load 15:43:36 INFO - PROCESS | 5596 | _x_x_mozilla_page_load_details 15:43:36 INFO - PROCESS | 5596 | |i|pagename|runs| 15:43:36 INFO - PROCESS | 5596 | |0;dojo.html;3353.211995181132;3382.966170338296;3388.695017448429;3402.761806673531;3413.9317213655727;5787.045137552304;5849.853753656161;5860.003799354115;5868.29580450346;5884.117382392643;5765.5099316558035;5832.620879642831;5837.416258374171;5843.678597677126;5853.7951171709;5240.60695447841;5311.176767601028;5329.2006199070065;5364.892702145955;5366.490183432567;5164.1995490699;5165.612579056567;5224.164133738603;5231.293775340338;5281.366236051679;5284.2073688946775;5289.206619007141;5313.1764576490705;5321.627486075976;5384.3538775347015;5362.168863826113;5367.838964831042;5383;5383.16560933056;5404.648697834628;5006.974965125151;5132.871678208075;5169.353830771153;5272.1300985337375;5293.497117773805;5760.74076666551;5788.6816225107605;5814.738336774855;5823.301203855522;5850.882982340329;6208.161898143783;6254.124422580842;6263.029230469285;6265.592736472115;6270.153529273535;6105.236845394325;6155;6184.041473571604;6308.085327627468;6315.842103947392;5853.180554722342;5854;5870.295564532284;5873.030949893263;5893.970530147365;6334.841628959313;6348.904766428507;6387.616742995435;6394.0408938659575;6406.8718625627225;5948.315943666447;6078.392160783975;6085.6044357117535;6145.539084568675;6181.474574661204;6225.097360882647;6272.6236425814595;6276.372362763778;6280.120783090371;6283.246010478681;6235.033569796688;6246.593971391936;6255.562110652301;6258;6283.654399008007;6073.4837538808815;6078.878422431527;6108.3280839107665;6219.440250377488;6246.437820596168;4730.290456431494;4731.219348807477;4732.905341893143;4758.595519380822;4779.235322348408;4224.746515209097;4234.915301693949;4237.216115018731;4239.342901850218;4262.42457268271;5753.942460575425;5787;5861.032929566573;5916.201312822714;5965.821025369246;6203.472704820141;6226.377362263828;6250.937490625127;6256.968715156486;6268.529860260499;5813.79651712188;5822.883542329129;5836.124581312837;5843.590948633555;5857.355690874;5193.532582067632;5257.948410317952;5266.315379000705;5327.200919862052;5383.757730902119;6311.747530098836;6419.390157934989;6422.614643121427;6433.356664333529;6438.291787903327;6189.133521306931;6201.81394558164;6221.720022599085;6223.0354295084335;6241.21984751906;6208.689565521616;6382.5532212744665;6417.326180750954;6418.005209192583;6441.871162576816;6097.359777223328;6195.411435913581;6216.813495595139;6240.719167637377;6275;6355;6361.61830290184;6363.872722545616;6368.554201205871;6376.298607153117;5770.538356931519;6090.878182436238;6143.508519318354;6167.1366008759705;6178.62928224308;6072.635641861502;6091.664958427329;6140.815775526741;6187.288461826947;6202.317745048132;6069.726862291296;6121.816345509642;6123.8162855114415;6137.202163718866;6151.96924015377;5947.434993675594;6019.819405417845;6131.938680613137;6138.723757431016;6187.907181392373;5923.348431672426;6028.819135425944;6037.728302226323;6056.000759874748;6068.241469816273 15:43:36 INFO - PROCESS | 5596 | |1;ext.html;576.4350936082639;650.193759737925;661.8411581220505;671.6742379945729;726.6657337624692;40642.59357406425;45509.0898182037;45567;45581.31628025574;45691.31463028053;46109.53890461094;46619;46623.533764662345;46643.30035049477;46704.299435508496;9109.362344635862;9193.310501712398;9224.769380765467;9239.260859131287;9249.12133347331;9233.769155771091;9286.814263714721;9288.071192880692;9320.487373194472;9342.346035777498;9245.44527328359;9288.674896378629;9333.813323733555;9338.579763910606;9340.252779777602;9179.31155163362;9226.446413215195;9256.398334108295;9274.629014839398;9307.441553506744;9168.220701240336;9246.630134794601;9247.861282080774;9253.72238832836;9258.490783006931;44339.55660443386;44519.109617807466;44806.551934480565;44837.327440088426;44887;3688.686461650763;3843.673287770543;3903.746256493319;4058.472398588194;4070.104576993057;35671;35803.64196358029;36001.639983600355;36232;36736;4814.398200224972;4844.927326090112;4850.49468852851;4962.702237865739;5118;366442;369170;369452;370086;373110;62905.685471572346;63426;63435;63467.68266158732;63496.36503634997;41442.792786035876;41805.79097104495;42432.36351454731;42504.3624345635;42542;16935.830641693672;17016.31934722622;17041.829581704023;17093.316267349168;17104.914475427544;14575.708485830224;14741.557753267205;14793.038452500768;14796.926015369854;14835.961482696108;20699.27552535654;21081.578368432547;21088.578228435654;21141.68287475689;21191.57616847685;7637.579933103732;7730.690772369155;7787.883181752279;7807.960960195276;7814.765557033298;1077.7575045614674;1168.67861338131;1177.1759768162322;1199.0108160767402;1231.4950870143198;34008;35137.12157196039;35321.823390882884;35336.82331588377;35853.282934341165;1182.7457096724245;1196.9581064662868;1198.8201769734435;1239.20690757915;1241.3731065811708;17934.64468583765;18344.724829127576;18560.25758969653;18726.90636546836;18736.718949215774;593373;605247;606313;609284;609865;42443.57556424458;42814.357784633256;42833;42917;42953.14093718108;1442.2932762946082;1442.3941944383384;1453.2152637575591;1465.0623600895435;1480.208088672555;31875;34709.47935781016;34826.651733483355;34968.65031349756;35046.649533505355;57729.71135144297;57733.711331443075;58030;58055.419445805004;58155.127673085786;513246;513702;514625;515184;518343;31259.687403125678;31310.121392716508;32147.67852321447;32149.839250804533;32168.83915580407;53771.731141345605;54080.72959635177;54119.188212176065;54652.72673636765;54854;46253.76873115748;47436;47529.524704753894;48133.278000830716;48545.5145448541;47024.29463558118;47129.52870471252;47340;47408;48304.516954830004;45917.77041114773;46107.53892461032;46927.29609055935;47513.762431189;47583.286250705576;39274;41335.1732965345;41817;41918;42327.788361057996;30935.416916137932;30952.53571196479;31013.68986310108;31142.377152457277;31176.844115780183 15:43:36 INFO - PROCESS | 5596 | |2;jquery.html;420.7181188603635;422.79060889482736;429.3195285472526;432.7230572433641;437.96277316428115;18986.670933034675;20921.163153473863;21358.46603834903;21425;22168.002439890202;19948.501287467785;20743.896280518577;20755.481112972182;20764.896175519138;20813.687794683094;5884.058550631899;6086.726097325609;6092.055731361646;6096.177016102836;6108.725107370156;5878.118282257674;6010.939890601104;6029.155918171459;6051.818445446622;6065.029595264737;5777.162311464856;5942.435468630495;5992.820215393545;6005.909911351333;6031.396860313977;5894.17481552583;5908;5910;5923.963306421359;5933.643981361132;5235.371755389339;5281.735913204325;5300;5323.707196104213;5346.545543628797;24957.50084998308;25003.12489062874;25030.624540631907;25194.118205862706;25268.747312526822;2311.3643747969277;2478.0583378316123;2537.967739212884;2543.211604402641;3163.098516922689;11119.555217791278;11252.324860508395;11260.155488338407;11461.598844040502;11549.13381496391;2073.38835043661;2105.0737675422765;2106.557622899193;2160.9783902160934;2218.1460137847043;90559;91682;92684.53657731735;94525;94824;11672.649820505398;11745.29528228309;11887.28676279426;11902.940485297519;11986.400679965967;16826;16877.32490700358;16895.155242237837;16929.068901210307;16935.830641693672;8592;8752.343574231958;8837.646494140163;8847.69033083839;8928.776780580538;8458.74623761288;8573.056963733985;8584.098669639723;8722.389432739647;8862.556872156367;5021.799128034838;5026.849418885825;5089.541941225308;5136.280920671109;5176.611754118456;1962.8920409377336;2023.352527191314;2094.1414020251623;2120.7561130469885;2125.6705210692367;984.2175470500969;999.7800483893532;1036.7200855769051;1045.1586472889396;1102.1568500097433;20587.4853128673;21534.892325538272;21558;21594.244201452875;21729.67405488919;1045.6444808765057;1078.3691540448926;1079.6599071292674;1089.7711480589007;1093.792179485911;11262;11648.475818588015;11894;11968.700782480508;11997.700057498632;519394;524326;532706;533617;552011;97519;101849.49075254577;102983;104953;105325;1036.5024788101603;1049.9107575855985;1108.9963582957437;1113.5323164271026;1145.7364806094645;18200.908995454938;18808.905955470134;18876.433706988813;19095.23619055278;19243.03784810726;43906;45436;45738.77130614326;46460.30309545427;47996.280055798496;55965.72017140051;56023;58656.41343586509;59245.40754592399;59805;8033.718819841278;8514.531700756517;9315.953420232856;9327.533623318943;9493.24054075686;13294.534691285759;13349.466021359036;14496.275186240857;14698.853011469748;14744.483943061941;12760.808587871375;12991;13015.869841301845;13123.54067607629;13172.275524846225;12826.422810973716;12974.156679815782;13138.737225255632;13146.737065258832;13286.933565332112;12725.55460558876;12906.225626462443;13151.34243287851;13285.468581256642;13362.198268103944;9272.211861991806;9369.203617692572;9518.143367096995;9531.142197202285;9549.809003819746;11018.283811552223;11893.345865977455;12638.304893230961;12904.677383065498;13020.674483137997 15:43:36 INFO - PROCESS | 5596 | |3;mootools.html;1557.8130624325083;1560.586444592183;1758.78015248094;1808.376110241966;1858.4238885945358;8386.832263354729;9009.189172974431;9117.133872282138;9718.65984690536;9723.46520941348;9182;9407.294452916041;9445.527723613826;9501.80996380072;9502.667406640769;2501.062101711858;2523.4574566468204;2525.8863351149153;2536.201096654557;2552.642630031797;2458.2625212436196;2522.407234299938;2538.796896248305;2539.7206307306274;2555.4505781257026;2522.5711629023017;2529.355014471307;2533.4173140177772;2543.071778800743;2548.3119557719497;2455.5702752018415;2457.1891275878916;2463.4087818923417;2492.8628925409093;2506.385935445809;2458.7418321076207;2470.6911636045493;2475.232677869848;2476.9009239630395;2487.5273697997322;9273.58268877902;9421.104995025462;9631.470269135194;9716.514174291256;9721.076497732774;5612.242347283146;5696.003199440122;5736.4550367715;5739.081746920473;5786.971065144689;3551.485034669984;3666.3767159582935;3785.9432108518395;3822.0827001519433;3845.115623406632;1144.0551063192606;1211.454845319601;1219.6035539307443;2386.940326491834;2408.397900524869;13320.333983300796;13367.465301387932;13416.731665366735;13460.730785384238;13490.325483725774;4695.199764405628;4759.333693282943;4806.327114204014;4896.706197628154;4937.728424936663;10546.103581195532;10549.894501055045;10557.683269501927;10562.471876406149;10590;5576.9163462548095;5637.49262566371;5641.80253691127;5656.547476201894;5664.546836253172;4569.725816450957;5162.277281180638;5261.684298941999;5269.683818970874;5309.33633295838;4140.3168477201525;4211.431456753299;4267;4276.508201556799;4297.39836422901;1213.769383817072;1279.2644229568036;1290.393515047926;1294.5080869269618;1301.8633043530292;942.5569982108398;995.5918073589794;1000.7197984564334;1024.08856118055;1049.122071492036;6265.4361107500545;6333.081703153109;6458.418742313214;6533.379328963741;6618.669066546653;471.2718849377651;476.102546699474;479.2691146002374;480.1261703699234;484.2639188433632;4195.811188496525;4450.421445212101;4452.154090722753;4492.5507449255465;4514.841980530666;11343.432828358715;11641.59254426091;11909.285442873455;11909.404529773477;12051.096167787451;11718.765624687458;12013.699657508632;12094.879051209551;12144.939275303566;12158;8842.425242359355;8990.865137022949;9043.32175086871;9083.13710197517;9093;6018.668973206516;6146.692665366624;6314.305426403183;6355.459785918064;6444.967775161094;10358.689239322832;10438.63464778729;10478.318909271178;10522.947385263025;10601.946990265307;10903.2367734261;10976.231663783778;11197.72005699864;11237.943810280896;11314;9066.818663626822;9218.815623687355;9236.445813251226;9246.537673116452;9309.394889332443;9242.260619150318;9251.213646839824;9259.35184537103;9305.953470232605;9346.15884570392;8233.876491852507;8448.40861139739;8509.787255318666;8515.8722619162;8603.698870539502;8020.318272946864;8035.799105022421;8197.426180167331;8277.95861020691;8541.359398045048;7700.3454706350585;7733.188015258542;7787.792892101734;7809.92190078092;7849.372050235853;5514.751836167302;5539.196816461671;5558.972205138948;5651.15232715096;5730.369659337553;5352.866178345573;5358.142697168434;5408.053590621704;5441.21102440136;5452.345718513804 15:43:36 INFO - PROCESS | 5596 | |4;prototype.html;346.2244572158364;351.6307876729434;356.0990693545331;359.4177432559254;361.93666108431034;5645.943540564593;5773.3937936516695;5882.794102206423;5916.225132460261;5948.375420580836;5710.7430165642545;5761.884762304751;5774.942250577493;5783.681897495636;5814.215080964069;4522.299043648231;4556.407667003285;4563.589276965073;4568.314752787075;4594.724316541018;4488.483824360192;4539.387182730338;4540.273556231004;4562.041971186055;4591.44902611687;4479.596836284733;4487.439070116236;4493.46078470584;4507.076049409863;4509.684322097438;4499.325101234808;4514.683972121953;4531.77341132942;4534.7052441591195;4562.133194692998;3862.8454861805494;3980.4626375439525;3992.461017762594;3994.8002599870183;4035.5584871152823;5597.80407685729;5640.210370548127;5652.5195358394585;5706.9429305707245;5714.457096583899;5154.226865970097;5172;5221;5269.104252277122;5286.762095705664;5847.502962248172;6055.183444966492;6072.483838873657;6089.969550152266;6162.198914141178;4313.331433627793;4378.343248512717;4392.758398288093;4394.6923715339935;4396.824127034914;6193.690315484253;6334.936650633481;6349.619022858643;6388.201474815648;6407.782521320934;4447.911041779146;4504.144212599595;4512.81948722054;4513.413256276663;4521.909561808746;4591.931121033187;4592.586667199968;4598.540145985375;4606.401167848158;4620.422447194101;5126.4617215191865;5256.08018596744;5262;5262.8947421052135;5275.920861187085;5938.435848594377;6132.945463269854;6133.172021777093;6134.478569321657;6136.263648362135;1515.7044376346507;1547.9860691247252;1556.400785697492;1570.5680937742213;1577.1877483096214;950.6862735297474;984.6061575369766;991.980160396788;1008.9254943485165;1011.2365164300905;5215.530602245816;5219.086659834514;5226.503482169188;5235.685858848481;5288.629795914249;5448.618596698193;5503.669779813224;5517.36550296713;5521.861953451115;5531.502164805187;4882.267659851051;5180.637355385087;5247.2129180623215;5270;5311.256424100629;2946.6758656547763;2947.292649764041;2952.247176969902;2962.09656054901;2969.7726704971274;5655.547556195576;5683.744231509592;5685.3177618685195;5692.800751973661;5694.800681976111;6016.308124565643;6398.776042838478;6413.4869210463985;6446.516511261674;6453.161089058486;6529.542931994714;6534.444572211415;6557.704903279364;6569.37590928861;6625.072489851521;6131.448169664752;6258.280297765815;6276.968615156895;6350.904736428864;6393.456556192776;6203.131561581473;6243.188385509855;6264.561480696308;6266.27937787142;6272;6330.841728956813;6481.125048118443;6545.443637290884;6554.279029306677;6566.9014964776525;4437.733735975723;4460.843870464518;4487.977560112178;4498.77506124699;4511;6113.14415981754;6209.882221200227;6370.968145159244;6423.807285781247;6426.710798014195;6096;6118.877622447615;6123.693815309306;6138.508919286357;6146.78486252979;6013.609115407485;6054.455099041107;6087.026075827846;6093.238345206849;6187.84530386726;6026.365348399261;6050.42520960508;6070.423309785563;6071.635701857903;6076.665783381956;6112.847178820565;6126.816195514141;6142.2629284484365;6143.907841382294;6149.385061493815;5812.622179558315;5993.190919225849;6023.186869772525;6026.819195424145;6060.454559089703 15:43:36 INFO - PROCESS | 5596 | |5;yui.html;819.6188772220916;867.9566021698918;898.712412028151;920.7513971227769;950.9904900950988;15753.527394178178;16497.505074847744;16554.420595279138;16573.585660358498;16623.83376166238;15089.245537723125;15469;15645;15713.371465141408;15790.526284211463;883.6377085394973;887.3788348156285;892.8794612727264;895.4582477601056;896.4442045931531;872.7818045488627;898.7348732124007;899;899.7660608241839;900.4327273817486;946.7207173883686;947.9526023698822;951.9381240219399;953.1945506047379;954.5561313988994;938.249400479617;939.6241503398627;940.0787228516024;942.3215284994793;944.0465130218495;694.8575542013875;698.3819319901872;699.1819571101823;700.9719611215596;701.1656129206228;16930.492085237463;16942.915285423616;16952;17109.914450427794;17149.056801875893;13703.588892333246;13746.106503077368;13830.446782128703;14247.28763561828;14475.276236188254;14628.561143165722;14647.853521464756;14851.257437128208;14974;15124.621884452978;4865;4939.110960027194;4954.058728841508;4960.70235785854;5030.522100400456;90131.54934225352;90433.54783226107;90977.54511227467;91284.54357728235;92103;12127.878721212675;12288.508459661693;12520.373981300898;12521.499140034297;12554.372281386077;21746.891265543887;21864;22048;22070.33788986333;22360.105595776313;8880.689175878813;9110.134537218953;9267.443953362685;9327.440353578808;9391.107844754737;5053.0904437200925;5140.177571588528;5212.166053431432;5238.8166414176085;5260.44765299638;3585.3367127081574;3668.6514781095752;3673.1368128489785;3683.1344634010984;4127.33962565988;740.7814694665087;741.6996116572689;754.4643303254641;755.0486387152118;755.7392699518767;656.7208936202095;773.3387953299961;788.755485799404;791.8376732769768;813.276184196066;10702.304350217211;10807.135429165804;11032.50353734084;11144.442777861075;11257.324560526395;689.4381079420257;754.7962050246402;761.824780300534;772.3666593393476;778.4550814429922;4258.339957306623;4453.955460445419;4620.768961551909;4626.167289887785;4781.306710526954;128763.35618321848;130054;132615.33692331475;133738.33130834284;138063;113897;117278.41360793312;117278.41360793312;119152;122150;97340;101845;102319;102802.48598757108;103812;8907.777305567413;8996.241235334392;9012.954935225544;9039.59321830506;9089.454632722058;49219.50780492293;54559.72720136374;55385.72307138438;55858.44141558695;57508.137377938525;81123.18876811156;86269;88166;89019.55490222508;91816;13184.868151318364;13364.198148111145;13404.664883377993;13429.731405372033;13581;14815.18516481604;14946.402143914556;15000.549983500512;15336;16072;13261.54746146724;13357.32714266537;13758.243296618382;13806.86193138096;13954.302284885918;13999.51001714935;14121.576352709435;14242.501512447014;14438;15118.697626047637;11869.643910682693;13153.53962611304;14048.2975851205;14403.495877644233;15029.248537573296;12011;12039.09706771978;12066.517339306329;12154.696132596402;12705.745885082431;11657.242279251821;12203.75592488163;12676.492940282285;12677.80983285233;12823.679408014874 15:43:36 INFO - PROCESS | 5596 | __end_tp_report 15:43:36 INFO - PROCESS | 5596 | __start_cc_report 15:43:36 INFO - PROCESS | 5596 | _x_x_mozilla_cycle_collect,321 15:43:36 INFO - PROCESS | 5596 | __end_cc_report 15:43:36 INFO - PROCESS | 5596 | __startTimestamp1472165016153__endTimestamp 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | ------- Summary: start ------- 15:43:36 INFO - PROCESS | 5596 | Number of tests: 6 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | [#0] dojo.html Cycles:165 Average:5786.50 Median:6056.00 stddev:662.75 (10.9%) stddev-sans-first:636.70 15:43:36 INFO - PROCESS | 5596 | Values: 3353.2 3383.0 3388.7 3402.8 3413.9 5787.0 5849.9 5860.0 5868.3 5884.1 5765.5 5832.6 5837.4 5843.7 5853.8 5240.6 5311.2 5329.2 5364.9 5366.5 5164.2 5165.6 5224.2 5231.3 5281.4 5284.2 5289.2 5313.2 5321.6 5384.4 5362.2 5367.8 5383.0 5383.2 5404.6 5007.0 5132.9 5169.4 5272.1 5293.5 5760.7 5788.7 5814.7 5823.3 5850.9 6208.2 6254.1 6263.0 6265.6 6270.2 6105.2 6155.0 6184.0 6308.1 6315.8 5853.2 5854.0 5870.3 5873.0 5894.0 6334.8 6348.9 6387.6 6394.0 6406.9 5948.3 6078.4 6085.6 6145.5 6181.5 6225.1 6272.6 6276.4 6280.1 6283.2 6235.0 6246.6 6255.6 6258.0 6283.7 6073.5 6078.9 6108.3 6219.4 6246.4 4730.3 4731.2 4732.9 4758.6 4779.2 4224.7 4234.9 4237.2 4239.3 4262.4 5753.9 5787.0 5861.0 5916.2 5965.8 6203.5 6226.4 6250.9 6257.0 6268.5 5813.8 5822.9 5836.1 5843.6 5857.4 5193.5 5257.9 5266.3 5327.2 5383.8 6311.7 6419.4 6422.6 6433.4 6438.3 6189.1 6201.8 6221.7 6223.0 6241.2 6208.7 6382.6 6417.3 6418.0 6441.9 6097.4 6195.4 6216.8 6240.7 6275.0 6355.0 6361.6 6363.9 6368.6 6376.3 5770.5 6090.9 6143.5 6167.1 6178.6 6072.6 6091.7 6140.8 6187.3 6202.3 6069.7 6121.8 6123.8 6137.2 6152.0 5947.4 6019.8 6131.9 6138.7 6187.9 5923.3 6028.8 6037.7 6056.0 6068.2 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | [#1] ext.html Cycles:180 Average:66000.26 Median:45198.04 stddev:134427.17 (297.4%) stddev-sans-first:134714.52 15:43:36 INFO - PROCESS | 5596 | Values: 576.4 650.2 661.8 671.7 726.7 40642.6 45509.1 45567.0 45581.3 45691.3 46109.5 46619.0 46623.5 46643.3 46704.3 9109.4 9193.3 9224.8 9239.3 9249.1 9233.8 9286.8 9288.1 9320.5 9342.3 9245.4 9288.7 9333.8 9338.6 9340.3 9179.3 9226.4 9256.4 9274.6 9307.4 9168.2 9246.6 9247.9 9253.7 9258.5 44339.6 44519.1 44806.6 44837.3 44887.0 3688.7 3843.7 3903.7 4058.5 4070.1 35671.0 35803.6 36001.6 36232.0 36736.0 4814.4 4844.9 4850.5 4962.7 5118.0 366442.0 369170.0 369452.0 370086.0 373110.0 62905.7 63426.0 63435.0 63467.7 63496.4 41442.8 41805.8 42432.4 42504.4 42542.0 16935.8 17016.3 17041.8 17093.3 17104.9 14575.7 14741.6 14793.0 14796.9 14836.0 20699.3 21081.6 21088.6 21141.7 21191.6 7637.6 7730.7 7787.9 7808.0 7814.8 1077.8 1168.7 1177.2 1199.0 1231.5 34008.0 35137.1 35321.8 35336.8 35853.3 1182.7 1197.0 1198.8 1239.2 1241.4 17934.6 18344.7 18560.3 18726.9 18736.7 593373.0 605247.0 606313.0 609284.0 609865.0 42443.6 42814.4 42833.0 42917.0 42953.1 1442.3 1442.4 1453.2 1465.1 1480.2 31875.0 34709.5 34826.7 34968.7 35046.6 57729.7 57733.7 58030.0 58055.4 58155.1 513246.0 513702.0 514625.0 515184.0 518343.0 31259.7 31310.1 32147.7 32149.8 32168.8 53771.7 54080.7 54119.2 54652.7 54854.0 46253.8 47436.0 47529.5 48133.3 48545.5 47024.3 47129.5 47340.0 47408.0 48304.5 45917.8 46107.5 46927.3 47513.8 47583.3 39274.0 41335.2 41817.0 41918.0 42327.8 30935.4 30952.5 31013.7 31142.4 31176.8 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | [#2] jquery.html Cycles:180 Average:31569.89 Median:12193.07 stddev:87918.26 (721.1%) stddev-sans-first:88133.78 15:43:36 INFO - PROCESS | 5596 | Values: 420.7 422.8 429.3 432.7 438.0 18986.7 20921.2 21358.5 21425.0 22168.0 19948.5 20743.9 20755.5 20764.9 20813.7 5884.1 6086.7 6092.1 6096.2 6108.7 5878.1 6010.9 6029.2 6051.8 6065.0 5777.2 5942.4 5992.8 6005.9 6031.4 5894.2 5908.0 5910.0 5924.0 5933.6 5235.4 5281.7 5300.0 5323.7 5346.5 24957.5 25003.1 25030.6 25194.1 25268.7 2311.4 2478.1 2538.0 2543.2 3163.1 11119.6 11252.3 11260.2 11461.6 11549.1 2073.4 2105.1 2106.6 2161.0 2218.1 90559.0 91682.0 92684.5 94525.0 94824.0 11672.6 11745.3 11887.3 11902.9 11986.4 16826.0 16877.3 16895.2 16929.1 16935.8 8592.0 8752.3 8837.6 8847.7 8928.8 8458.7 8573.1 8584.1 8722.4 8862.6 5021.8 5026.8 5089.5 5136.3 5176.6 1962.9 2023.4 2094.1 2120.8 2125.7 984.2 999.8 1036.7 1045.2 1102.2 20587.5 21534.9 21558.0 21594.2 21729.7 1045.6 1078.4 1079.7 1089.8 1093.8 11262.0 11648.5 11894.0 11968.7 11997.7 519394.0 524326.0 532706.0 533617.0 552011.0 97519.0 101849.5 102983.0 104953.0 105325.0 1036.5 1049.9 1109.0 1113.5 1145.7 18200.9 18808.9 18876.4 19095.2 19243.0 43906.0 45436.0 45738.8 46460.3 47996.3 55965.7 56023.0 58656.4 59245.4 59805.0 8033.7 8514.5 9316.0 9327.5 9493.2 13294.5 13349.5 14496.3 14698.9 14744.5 12760.8 12991.0 13015.9 13123.5 13172.3 12826.4 12974.2 13138.7 13146.7 13286.9 12725.6 12906.2 13151.3 13285.5 13362.2 9272.2 9369.2 9518.1 9531.1 9549.8 11018.3 11893.3 12638.3 12904.7 13020.7 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | [#3] mootools.html Cycles:180 Average:6264.94 Median:2615.30 stddev:3579.59 (136.9%) stddev-sans-first:3572.15 15:43:36 INFO - PROCESS | 5596 | Values: 1557.8 1560.6 1758.8 1808.4 1858.4 8386.8 9009.2 9117.1 9718.7 9723.5 9182.0 9407.3 9445.5 9501.8 9502.7 2501.1 2523.5 2525.9 2536.2 2552.6 2458.3 2522.4 2538.8 2539.7 2555.5 2522.6 2529.4 2533.4 2543.1 2548.3 2455.6 2457.2 2463.4 2492.9 2506.4 2458.7 2470.7 2475.2 2476.9 2487.5 9273.6 9421.1 9631.5 9716.5 9721.1 5612.2 5696.0 5736.5 5739.1 5787.0 3551.5 3666.4 3785.9 3822.1 3845.1 1144.1 1211.5 1219.6 2386.9 2408.4 13320.3 13367.5 13416.7 13460.7 13490.3 4695.2 4759.3 4806.3 4896.7 4937.7 10546.1 10549.9 10557.7 10562.5 10590.0 5576.9 5637.5 5641.8 5656.5 5664.5 4569.7 5162.3 5261.7 5269.7 5309.3 4140.3 4211.4 4267.0 4276.5 4297.4 1213.8 1279.3 1290.4 1294.5 1301.9 942.6 995.6 1000.7 1024.1 1049.1 6265.4 6333.1 6458.4 6533.4 6618.7 471.3 476.1 479.3 480.1 484.3 4195.8 4450.4 4452.2 4492.6 4514.8 11343.4 11641.6 11909.3 11909.4 12051.1 11718.8 12013.7 12094.9 12144.9 12158.0 8842.4 8990.9 9043.3 9083.1 9093.0 6018.7 6146.7 6314.3 6355.5 6445.0 10358.7 10438.6 10478.3 10522.9 10601.9 10903.2 10976.2 11197.7 11237.9 11314.0 9066.8 9218.8 9236.4 9246.5 9309.4 9242.3 9251.2 9259.4 9306.0 9346.2 8233.9 8448.4 8509.8 8515.9 8603.7 8020.3 8035.8 8197.4 8278.0 8541.4 7700.3 7733.2 7787.8 7809.9 7849.4 5514.8 5539.2 5559.0 5651.2 5730.4 5352.9 5358.1 5408.1 5441.2 5452.3 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | [#4] prototype.html Cycles:180 Average:5065.21 Median:5654.03 stddev:1501.06 (26.5%) stddev-sans-first:1462.88 15:43:36 INFO - PROCESS | 5596 | Values: 346.2 351.6 356.1 359.4 361.9 5645.9 5773.4 5882.8 5916.2 5948.4 5710.7 5761.9 5774.9 5783.7 5814.2 4522.3 4556.4 4563.6 4568.3 4594.7 4488.5 4539.4 4540.3 4562.0 4591.4 4479.6 4487.4 4493.5 4507.1 4509.7 4499.3 4514.7 4531.8 4534.7 4562.1 3862.8 3980.5 3992.5 3994.8 4035.6 5597.8 5640.2 5652.5 5706.9 5714.5 5154.2 5172.0 5221.0 5269.1 5286.8 5847.5 6055.2 6072.5 6090.0 6162.2 4313.3 4378.3 4392.8 4394.7 4396.8 6193.7 6334.9 6349.6 6388.2 6407.8 4447.9 4504.1 4512.8 4513.4 4521.9 4591.9 4592.6 4598.5 4606.4 4620.4 5126.5 5256.1 5262.0 5262.9 5275.9 5938.4 6132.9 6133.2 6134.5 6136.3 1515.7 1548.0 1556.4 1570.6 1577.2 950.7 984.6 992.0 1008.9 1011.2 5215.5 5219.1 5226.5 5235.7 5288.6 5448.6 5503.7 5517.4 5521.9 5531.5 4882.3 5180.6 5247.2 5270.0 5311.3 2946.7 2947.3 2952.2 2962.1 2969.8 5655.5 5683.7 5685.3 5692.8 5694.8 6016.3 6398.8 6413.5 6446.5 6453.2 6529.5 6534.4 6557.7 6569.4 6625.1 6131.4 6258.3 6277.0 6350.9 6393.5 6203.1 6243.2 6264.6 6266.3 6272.0 6330.8 6481.1 6545.4 6554.3 6566.9 4437.7 4460.8 4488.0 4498.8 4511.0 6113.1 6209.9 6371.0 6423.8 6426.7 6096.0 6118.9 6123.7 6138.5 6146.8 6013.6 6054.5 6087.0 6093.2 6187.8 6026.4 6050.4 6070.4 6071.6 6076.7 6112.8 6126.8 6142.3 6143.9 6149.4 5812.6 5993.2 6023.2 6026.8 6060.5 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - PROCESS | 5596 | [#5] yui.html Cycles:180 Average:23536.49 Median:3670.89 stddev:35190.60 (958.6%) stddev-sans-first:35247.98 15:43:36 INFO - PROCESS | 5596 | Values: 819.6 868.0 898.7 920.8 951.0 15753.5 16497.5 16554.4 16573.6 16623.8 15089.2 15469.0 15645.0 15713.4 15790.5 883.6 887.4 892.9 895.5 896.4 872.8 898.7 899.0 899.8 900.4 946.7 948.0 951.9 953.2 954.6 938.2 939.6 940.1 942.3 944.0 694.9 698.4 699.2 701.0 701.2 16930.5 16942.9 16952.0 17109.9 17149.1 13703.6 13746.1 13830.4 14247.3 14475.3 14628.6 14647.9 14851.3 14974.0 15124.6 4865.0 4939.1 4954.1 4960.7 5030.5 90131.5 90433.5 90977.5 91284.5 92103.0 12127.9 12288.5 12520.4 12521.5 12554.4 21746.9 21864.0 22048.0 22070.3 22360.1 8880.7 9110.1 9267.4 9327.4 9391.1 5053.1 5140.2 5212.2 5238.8 5260.4 3585.3 3668.7 3673.1 3683.1 4127.3 740.8 741.7 754.5 755.0 755.7 656.7 773.3 788.8 791.8 813.3 10702.3 10807.1 11032.5 11144.4 11257.3 689.4 754.8 761.8 772.4 778.5 4258.3 4454.0 4620.8 4626.2 4781.3 128763.4 130054.0 132615.3 133738.3 138063.0 113897.0 117278.4 117278.4 119152.0 122150.0 97340.0 101845.0 102319.0 102802.5 103812.0 8907.8 8996.2 9013.0 9039.6 9089.5 49219.5 54559.7 55385.7 55858.4 57508.1 81123.2 86269.0 88166.0 89019.6 91816.0 13184.9 13364.2 13404.7 13429.7 13581.0 14815.2 14946.4 15000.5 15336.0 16072.0 13261.5 13357.3 13758.2 13806.9 13954.3 13999.5 14121.6 14242.5 14438.0 15118.7 11869.6 13153.5 14048.3 14403.5 15029.2 12011.0 12039.1 12066.5 12154.7 12705.7 11657.2 12203.8 12676.5 12677.8 12823.7 15:43:36 INFO - PROCESS | 5596 | -------- Summary: end -------- 15:43:36 INFO - PROCESS | 5596 | 15:43:36 INFO - TEST-INFO | 5596: exit 0 15:43:36 INFO - TEST-OK | dromaeo_css | took 1110313ms 15:43:36 INFO - TEST-START | kraken 15:43:36 INFO - operating with platform_type : linux_ 15:43:36 INFO - Initialising browser for kraken test... 15:43:36 INFO - TEST-INFO | started process 5858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hSc8n/profile http://localhost:40653/getInfo.html) 15:43:40 INFO - PROCESS | 5858 | __metrics Screen width/height:1600/1200 15:43:40 INFO - PROCESS | 5858 | colorDepth:24 15:43:40 INFO - PROCESS | 5858 | Browser inner width/height: 1024/697 15:43:40 INFO - PROCESS | 5858 | __metrics 15:43:41 ERROR - PROCESS | 5858 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:43:42 INFO - TEST-INFO | 5858: exit 0 15:43:42 INFO - Browser initialized. 15:43:42 INFO - Running cycle 1/1 for kraken test... 15:43:42 INFO - TEST-INFO | started process 5986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hSc8n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:53 INFO - PROCESS | 5986 | RSS: Main: 152961024 15:43:53 INFO - PROCESS | 5986 | 15:43:56 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40653/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:57 INFO - PROCESS | 5986 | RSS: Main: 158326784 15:43:57 INFO - PROCESS | 5986 | 15:43:59 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40653/tests/kraken/driver.html?testName=audio-dft) 15:44:00 INFO - PROCESS | 5986 | RSS: Main: 156868608 15:44:00 INFO - PROCESS | 5986 | 15:44:03 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40653/tests/kraken/driver.html?testName=audio-fft) 15:44:03 INFO - PROCESS | 5986 | RSS: Main: 157900800 15:44:03 INFO - PROCESS | 5986 | 15:44:06 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40653/tests/kraken/driver.html?testName=audio-oscillator) 15:44:06 INFO - PROCESS | 5986 | RSS: Main: 157507584 15:44:06 INFO - PROCESS | 5986 | 15:44:08 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40653/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:09 INFO - PROCESS | 5986 | RSS: Main: 157302784 15:44:09 INFO - PROCESS | 5986 | 15:44:12 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40653/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:13 INFO - PROCESS | 5986 | RSS: Main: 157040640 15:44:13 INFO - PROCESS | 5986 | 15:44:16 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40653/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:17 INFO - PROCESS | 5986 | RSS: Main: 155418624 15:44:17 INFO - PROCESS | 5986 | 15:44:20 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40653/tests/kraken/driver.html?testName=json-parse-financial) 15:44:20 INFO - PROCESS | 5986 | RSS: Main: 156418048 15:44:20 INFO - PROCESS | 5986 | 15:44:22 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40653/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:22 INFO - PROCESS | 5986 | RSS: Main: 156372992 15:44:22 INFO - PROCESS | 5986 | 15:44:24 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:25 INFO - PROCESS | 5986 | RSS: Main: 156749824 15:44:25 INFO - PROCESS | 5986 | 15:44:27 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:27 INFO - PROCESS | 5986 | RSS: Main: 158240768 15:44:27 INFO - PROCESS | 5986 | 15:44:30 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:31 INFO - PROCESS | 5986 | RSS: Main: 157229056 15:44:31 INFO - PROCESS | 5986 | 15:44:33 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:34 INFO - PROCESS | 5986 | RSS: Main: 157757440 15:44:34 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | Cycle 1(1): loaded http://localhost:40653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40653/tests/kraken/driver.html?testName=ai-astar) 15:44:36 INFO - PROCESS | 5986 | RSS: Main: 158646272 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | __start_tp_report 15:44:36 INFO - PROCESS | 5986 | _x_x_mozilla_page_load 15:44:36 INFO - PROCESS | 5986 | _x_x_mozilla_page_load_details 15:44:36 INFO - PROCESS | 5986 | |i|pagename|runs| 15:44:36 INFO - PROCESS | 5986 | |0;ai-astar;99;111;105;111;113;112;111;111;110;110 15:44:36 INFO - PROCESS | 5986 | |1;audio-beat-detection;147;116;142;172;119;149;145;120;164;116 15:44:36 INFO - PROCESS | 5986 | |2;audio-dft;163;163;164;163;164;162;161;161;165;159 15:44:36 INFO - PROCESS | 5986 | |3;audio-fft;76;75;76;185;75;77;76;77;177;76 15:44:36 INFO - PROCESS | 5986 | |4;audio-oscillator;83;84;139;85;85;85;142;85;83;140 15:44:36 INFO - PROCESS | 5986 | |5;imaging-gaussian-blur;117;118;117;119;117;118;118;118;117;118 15:44:36 INFO - PROCESS | 5986 | |6;imaging-darkroom;148;147;147;148;146;146;147;148;147;146 15:44:36 INFO - PROCESS | 5986 | |7;imaging-desaturate;96;95;96;95;95;95;96;95;95;95 15:44:36 INFO - PROCESS | 5986 | |8;json-parse-financial;51;52;53;52;53;52;52;51;51;52 15:44:36 INFO - PROCESS | 5986 | |9;json-stringify-tinderbox;62;60;60;59;60;62;60;60;59;59 15:44:36 INFO - PROCESS | 5986 | |10;stanford-crypto-aes;73;73;82;77;72;72;75;74;77;72 15:44:36 INFO - PROCESS | 5986 | |11;stanford-crypto-ccm;127;132;120;126;131;128;117;126;151;121 15:44:36 INFO - PROCESS | 5986 | |12;stanford-crypto-pbkdf2;153;153;155;154;150;155;156;158;154;152 15:44:36 INFO - PROCESS | 5986 | |13;stanford-crypto-sha256-iterative;63;65;63;62;62;62;62;63;62;64 15:44:36 INFO - PROCESS | 5986 | __end_tp_report 15:44:36 INFO - PROCESS | 5986 | __start_cc_report 15:44:36 INFO - PROCESS | 5986 | _x_x_mozilla_cycle_collect,860 15:44:36 INFO - PROCESS | 5986 | __end_cc_report 15:44:36 INFO - PROCESS | 5986 | __startTimestamp1472165076268__endTimestamp 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | ------- Summary: start ------- 15:44:36 INFO - PROCESS | 5986 | Number of tests: 14 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:4.19 (3.8%) stddev-sans-first:2.24 15:44:36 INFO - PROCESS | 5986 | Values: 99.0 111.0 105.0 111.0 113.0 112.0 111.0 111.0 110.0 110.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:146.00 stddev:20.39 (14.0%) stddev-sans-first:21.42 15:44:36 INFO - PROCESS | 5986 | Values: 147.0 116.0 142.0 172.0 119.0 149.0 145.0 120.0 164.0 116.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 15:44:36 INFO - PROCESS | 5986 | Values: 163.0 163.0 164.0 163.0 164.0 162.0 161.0 161.0 165.0 159.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#3] audio-fft Cycles:10 Average:97.00 Median:76.00 stddev:44.32 (58.3%) stddev-sans-first:46.35 15:44:36 INFO - PROCESS | 5986 | Values: 76.0 75.0 76.0 185.0 75.0 77.0 76.0 77.0 177.0 76.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:84.50 stddev:27.09 (32.1%) stddev-sans-first:27.93 15:44:36 INFO - PROCESS | 5986 | Values: 83.0 84.0 139.0 85.0 85.0 85.0 142.0 85.0 83.0 140.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 15:44:36 INFO - PROCESS | 5986 | Values: 117.0 118.0 117.0 119.0 117.0 118.0 118.0 118.0 117.0 118.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 15:44:36 INFO - PROCESS | 5986 | Values: 148.0 147.0 147.0 148.0 146.0 146.0 147.0 148.0 147.0 146.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:44:36 INFO - PROCESS | 5986 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 15:44:36 INFO - PROCESS | 5986 | Values: 51.0 52.0 53.0 52.0 53.0 52.0 52.0 51.0 51.0 52.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:0.93 15:44:36 INFO - PROCESS | 5986 | Values: 62.0 60.0 60.0 59.0 60.0 62.0 60.0 60.0 59.0 59.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:3.20 (4.3%) stddev-sans-first:3.33 15:44:36 INFO - PROCESS | 5986 | Values: 73.0 73.0 82.0 77.0 72.0 72.0 75.0 74.0 77.0 72.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:127.50 stddev:9.41 (7.4%) stddev-sans-first:9.97 15:44:36 INFO - PROCESS | 5986 | Values: 127.0 132.0 120.0 126.0 131.0 128.0 117.0 126.0 151.0 121.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.50 stddev:2.21 (1.4%) stddev-sans-first:2.32 15:44:36 INFO - PROCESS | 5986 | Values: 153.0 153.0 155.0 154.0 150.0 155.0 156.0 158.0 154.0 152.0 15:44:36 INFO - PROCESS | 5986 | 15:44:36 INFO - PROCESS | 5986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 15:44:36 INFO - PROCESS | 5986 | Values: 63.0 65.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 64.0 15:44:36 INFO - PROCESS | 5986 | -------- Summary: end -------- 15:44:36 INFO - PROCESS | 5986 | 15:44:37 INFO - TEST-INFO | 5986: exit 0 15:44:37 INFO - TEST-OK | kraken | took 60296ms 15:44:37 INFO - SUITE-END | took 1170s 15:44:37 INFO - Completed test suite (00:19:30) 15:44:37 INFO - javascript benchmark 15:44:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7828.167506458115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.211995181132, 3382.966170338296, 3388.695017448429, 3402.761806673531, 3413.9317213655727, 5787.045137552304, 5849.853753656161, 5860.003799354115, 5868.29580450346, 5884.117382392643, 5765.5099316558035, 5832.620879642831, 5837.416258374171, 5843.678597677126, 5853.7951171709, 5240.60695447841, 5311.176767601028, 5329.2006199070065, 5364.892702145955, 5366.490183432567, 5164.1995490699, 5165.612579056567, 5224.164133738603, 5231.293775340338, 5281.366236051679, 5284.2073688946775, 5289.206619007141, 5313.1764576490705, 5321.627486075976, 5384.3538775347015, 5362.168863826113, 5367.838964831042, 5383.0, 5383.16560933056, 5404.648697834628, 5006.974965125151, 5132.871678208075, 5169.353830771153, 5272.1300985337375, 5293.497117773805, 5760.74076666551, 5788.6816225107605, 5814.738336774855, 5823.301203855522, 5850.882982340329, 6208.161898143783, 6254.124422580842, 6263.029230469285, 6265.592736472115, 6270.153529273535, 6105.236845394325, 6155.0, 6184.041473571604, 6308.085327627468, 6315.842103947392, 5853.180554722342, 5854.0, 5870.295564532284, 5873.030949893263, 5893.970530147365, 6334.841628959313, 6348.904766428507, 6387.616742995435, 6394.0408938659575, 6406.8718625627225, 5948.315943666447, 6078.392160783975, 6085.6044357117535, 6145.539084568675, 6181.474574661204, 6225.097360882647, 6272.6236425814595, 6276.372362763778, 6280.120783090371, 6283.246010478681, 6235.033569796688, 6246.593971391936, 6255.562110652301, 6258.0, 6283.654399008007, 6073.4837538808815, 6078.878422431527, 6108.3280839107665, 6219.440250377488, 6246.437820596168, 4730.290456431494, 4731.219348807477, 4732.905341893143, 4758.595519380822, 4779.235322348408, 4224.746515209097, 4234.915301693949, 4237.216115018731, 4239.342901850218, 4262.42457268271, 5753.942460575425, 5787.0, 5861.032929566573, 5916.201312822714, 5965.821025369246, 6203.472704820141, 6226.377362263828, 6250.937490625127, 6256.968715156486, 6268.529860260499, 5813.79651712188, 5822.883542329129, 5836.124581312837, 5843.590948633555, 5857.355690874, 5193.532582067632, 5257.948410317952, 5266.315379000705, 5327.200919862052, 5383.757730902119, 6311.747530098836, 6419.390157934989, 6422.614643121427, 6433.356664333529, 6438.291787903327, 6189.133521306931, 6201.81394558164, 6221.720022599085, 6223.0354295084335, 6241.21984751906, 6208.689565521616, 6382.5532212744665, 6417.326180750954, 6418.005209192583, 6441.871162576816, 6097.359777223328, 6195.411435913581, 6216.813495595139, 6240.719167637377, 6275.0, 6355.0, 6361.61830290184, 6363.872722545616, 6368.554201205871, 6376.298607153117, 5770.538356931519, 6090.878182436238, 6143.508519318354, 6167.1366008759705, 6178.62928224308, 6072.635641861502, 6091.664958427329, 6140.815775526741, 6187.288461826947, 6202.317745048132, 6069.726862291296, 6121.816345509642, 6123.8162855114415, 6137.202163718866, 6151.96924015377, 5947.434993675594, 6019.819405417845, 6131.938680613137, 6138.723757431016, 6187.907181392373, 5923.348431672426, 6028.819135425944, 6037.728302226323, 6056.000759874748, 6068.241469816273], "value": 5741.540040871449, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.4350936082639, 650.193759737925, 661.8411581220505, 671.6742379945729, 726.6657337624692, 40642.59357406425, 45509.0898182037, 45567.0, 45581.31628025574, 45691.31463028053, 46109.53890461094, 46619.0, 46623.533764662345, 46643.30035049477, 46704.299435508496, 9109.362344635862, 9193.310501712398, 9224.769380765467, 9239.260859131287, 9249.12133347331, 9233.769155771091, 9286.814263714721, 9288.071192880692, 9320.487373194472, 9342.346035777498, 9245.44527328359, 9288.674896378629, 9333.813323733555, 9338.579763910606, 9340.252779777602, 9179.31155163362, 9226.446413215195, 9256.398334108295, 9274.629014839398, 9307.441553506744, 9168.220701240336, 9246.630134794601, 9247.861282080774, 9253.72238832836, 9258.490783006931, 44339.55660443386, 44519.109617807466, 44806.551934480565, 44837.327440088426, 44887.0, 3688.686461650763, 3843.673287770543, 3903.746256493319, 4058.472398588194, 4070.104576993057, 35671.0, 35803.64196358029, 36001.639983600355, 36232.0, 36736.0, 4814.398200224972, 4844.927326090112, 4850.49468852851, 4962.702237865739, 5118.0, 366442.0, 369170.0, 369452.0, 370086.0, 373110.0, 62905.685471572346, 63426.0, 63435.0, 63467.68266158732, 63496.36503634997, 41442.792786035876, 41805.79097104495, 42432.36351454731, 42504.3624345635, 42542.0, 16935.830641693672, 17016.31934722622, 17041.829581704023, 17093.316267349168, 17104.914475427544, 14575.708485830224, 14741.557753267205, 14793.038452500768, 14796.926015369854, 14835.961482696108, 20699.27552535654, 21081.578368432547, 21088.578228435654, 21141.68287475689, 21191.57616847685, 7637.579933103732, 7730.690772369155, 7787.883181752279, 7807.960960195276, 7814.765557033298, 1077.7575045614674, 1168.67861338131, 1177.1759768162322, 1199.0108160767402, 1231.4950870143198, 34008.0, 35137.12157196039, 35321.823390882884, 35336.82331588377, 35853.282934341165, 1182.7457096724245, 1196.9581064662868, 1198.8201769734435, 1239.20690757915, 1241.3731065811708, 17934.64468583765, 18344.724829127576, 18560.25758969653, 18726.90636546836, 18736.718949215774, 593373.0, 605247.0, 606313.0, 609284.0, 609865.0, 42443.57556424458, 42814.357784633256, 42833.0, 42917.0, 42953.14093718108, 1442.2932762946082, 1442.3941944383384, 1453.2152637575591, 1465.0623600895435, 1480.208088672555, 31875.0, 34709.47935781016, 34826.651733483355, 34968.65031349756, 35046.649533505355, 57729.71135144297, 57733.711331443075, 58030.0, 58055.419445805004, 58155.127673085786, 513246.0, 513702.0, 514625.0, 515184.0, 518343.0, 31259.687403125678, 31310.121392716508, 32147.67852321447, 32149.839250804533, 32168.83915580407, 53771.731141345605, 54080.72959635177, 54119.188212176065, 54652.72673636765, 54854.0, 46253.76873115748, 47436.0, 47529.524704753894, 48133.278000830716, 48545.5145448541, 47024.29463558118, 47129.52870471252, 47340.0, 47408.0, 48304.516954830004, 45917.77041114773, 46107.53892461032, 46927.29609055935, 47513.762431189, 47583.286250705576, 39274.0, 41335.1732965345, 41817.0, 41918.0, 42327.788361057996, 30935.416916137932, 30952.53571196479, 31013.68986310108, 31142.377152457277, 31176.844115780183], "value": 21527.53168614545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.7181188603635, 422.79060889482736, 429.3195285472526, 432.7230572433641, 437.96277316428115, 18986.670933034675, 20921.163153473863, 21358.46603834903, 21425.0, 22168.002439890202, 19948.501287467785, 20743.896280518577, 20755.481112972182, 20764.896175519138, 20813.687794683094, 5884.058550631899, 6086.726097325609, 6092.055731361646, 6096.177016102836, 6108.725107370156, 5878.118282257674, 6010.939890601104, 6029.155918171459, 6051.818445446622, 6065.029595264737, 5777.162311464856, 5942.435468630495, 5992.820215393545, 6005.909911351333, 6031.396860313977, 5894.17481552583, 5908.0, 5910.0, 5923.963306421359, 5933.643981361132, 5235.371755389339, 5281.735913204325, 5300.0, 5323.707196104213, 5346.545543628797, 24957.50084998308, 25003.12489062874, 25030.624540631907, 25194.118205862706, 25268.747312526822, 2311.3643747969277, 2478.0583378316123, 2537.967739212884, 2543.211604402641, 3163.098516922689, 11119.555217791278, 11252.324860508395, 11260.155488338407, 11461.598844040502, 11549.13381496391, 2073.38835043661, 2105.0737675422765, 2106.557622899193, 2160.9783902160934, 2218.1460137847043, 90559.0, 91682.0, 92684.53657731735, 94525.0, 94824.0, 11672.649820505398, 11745.29528228309, 11887.28676279426, 11902.940485297519, 11986.400679965967, 16826.0, 16877.32490700358, 16895.155242237837, 16929.068901210307, 16935.830641693672, 8592.0, 8752.343574231958, 8837.646494140163, 8847.69033083839, 8928.776780580538, 8458.74623761288, 8573.056963733985, 8584.098669639723, 8722.389432739647, 8862.556872156367, 5021.799128034838, 5026.849418885825, 5089.541941225308, 5136.280920671109, 5176.611754118456, 1962.8920409377336, 2023.352527191314, 2094.1414020251623, 2120.7561130469885, 2125.6705210692367, 984.2175470500969, 999.7800483893532, 1036.7200855769051, 1045.1586472889396, 1102.1568500097433, 20587.4853128673, 21534.892325538272, 21558.0, 21594.244201452875, 21729.67405488919, 1045.6444808765057, 1078.3691540448926, 1079.6599071292674, 1089.7711480589007, 1093.792179485911, 11262.0, 11648.475818588015, 11894.0, 11968.700782480508, 11997.700057498632, 519394.0, 524326.0, 532706.0, 533617.0, 552011.0, 97519.0, 101849.49075254577, 102983.0, 104953.0, 105325.0, 1036.5024788101603, 1049.9107575855985, 1108.9963582957437, 1113.5323164271026, 1145.7364806094645, 18200.908995454938, 18808.905955470134, 18876.433706988813, 19095.23619055278, 19243.03784810726, 43906.0, 45436.0, 45738.77130614326, 46460.30309545427, 47996.280055798496, 55965.72017140051, 56023.0, 58656.41343586509, 59245.40754592399, 59805.0, 8033.718819841278, 8514.531700756517, 9315.953420232856, 9327.533623318943, 9493.24054075686, 13294.534691285759, 13349.466021359036, 14496.275186240857, 14698.853011469748, 14744.483943061941, 12760.808587871375, 12991.0, 13015.869841301845, 13123.54067607629, 13172.275524846225, 12826.422810973716, 12974.156679815782, 13138.737225255632, 13146.737065258832, 13286.933565332112, 12725.55460558876, 12906.225626462443, 13151.34243287851, 13285.468581256642, 13362.198268103944, 9272.211861991806, 9369.203617692572, 9518.143367096995, 9531.142197202285, 9549.809003819746, 11018.283811552223, 11893.345865977455, 12638.304893230961, 12904.677383065498, 13020.674483137997], "value": 9940.707548048611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.8130624325083, 1560.586444592183, 1758.78015248094, 1808.376110241966, 1858.4238885945358, 8386.832263354729, 9009.189172974431, 9117.133872282138, 9718.65984690536, 9723.46520941348, 9182.0, 9407.294452916041, 9445.527723613826, 9501.80996380072, 9502.667406640769, 2501.062101711858, 2523.4574566468204, 2525.8863351149153, 2536.201096654557, 2552.642630031797, 2458.2625212436196, 2522.407234299938, 2538.796896248305, 2539.7206307306274, 2555.4505781257026, 2522.5711629023017, 2529.355014471307, 2533.4173140177772, 2543.071778800743, 2548.3119557719497, 2455.5702752018415, 2457.1891275878916, 2463.4087818923417, 2492.8628925409093, 2506.385935445809, 2458.7418321076207, 2470.6911636045493, 2475.232677869848, 2476.9009239630395, 2487.5273697997322, 9273.58268877902, 9421.104995025462, 9631.470269135194, 9716.514174291256, 9721.076497732774, 5612.242347283146, 5696.003199440122, 5736.4550367715, 5739.081746920473, 5786.971065144689, 3551.485034669984, 3666.3767159582935, 3785.9432108518395, 3822.0827001519433, 3845.115623406632, 1144.0551063192606, 1211.454845319601, 1219.6035539307443, 2386.940326491834, 2408.397900524869, 13320.333983300796, 13367.465301387932, 13416.731665366735, 13460.730785384238, 13490.325483725774, 4695.199764405628, 4759.333693282943, 4806.327114204014, 4896.706197628154, 4937.728424936663, 10546.103581195532, 10549.894501055045, 10557.683269501927, 10562.471876406149, 10590.0, 5576.9163462548095, 5637.49262566371, 5641.80253691127, 5656.547476201894, 5664.546836253172, 4569.725816450957, 5162.277281180638, 5261.684298941999, 5269.683818970874, 5309.33633295838, 4140.3168477201525, 4211.431456753299, 4267.0, 4276.508201556799, 4297.39836422901, 1213.769383817072, 1279.2644229568036, 1290.393515047926, 1294.5080869269618, 1301.8633043530292, 942.5569982108398, 995.5918073589794, 1000.7197984564334, 1024.08856118055, 1049.122071492036, 6265.4361107500545, 6333.081703153109, 6458.418742313214, 6533.379328963741, 6618.669066546653, 471.2718849377651, 476.102546699474, 479.2691146002374, 480.1261703699234, 484.2639188433632, 4195.811188496525, 4450.421445212101, 4452.154090722753, 4492.5507449255465, 4514.841980530666, 11343.432828358715, 11641.59254426091, 11909.285442873455, 11909.404529773477, 12051.096167787451, 11718.765624687458, 12013.699657508632, 12094.879051209551, 12144.939275303566, 12158.0, 8842.425242359355, 8990.865137022949, 9043.32175086871, 9083.13710197517, 9093.0, 6018.668973206516, 6146.692665366624, 6314.305426403183, 6355.459785918064, 6444.967775161094, 10358.689239322832, 10438.63464778729, 10478.318909271178, 10522.947385263025, 10601.946990265307, 10903.2367734261, 10976.231663783778, 11197.72005699864, 11237.943810280896, 11314.0, 9066.818663626822, 9218.815623687355, 9236.445813251226, 9246.537673116452, 9309.394889332443, 9242.260619150318, 9251.213646839824, 9259.35184537103, 9305.953470232605, 9346.15884570392, 8233.876491852507, 8448.40861139739, 8509.787255318666, 8515.8722619162, 8603.698870539502, 8020.318272946864, 8035.799105022421, 8197.426180167331, 8277.95861020691, 8541.359398045048, 7700.3454706350585, 7733.188015258542, 7787.792892101734, 7809.92190078092, 7849.372050235853, 5514.751836167302, 5539.196816461671, 5558.972205138948, 5651.15232715096, 5730.369659337553, 5352.866178345573, 5358.142697168434, 5408.053590621704, 5441.21102440136, 5452.345718513804], "value": 4940.651328631363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.2244572158364, 351.6307876729434, 356.0990693545331, 359.4177432559254, 361.93666108431034, 5645.943540564593, 5773.3937936516695, 5882.794102206423, 5916.225132460261, 5948.375420580836, 5710.7430165642545, 5761.884762304751, 5774.942250577493, 5783.681897495636, 5814.215080964069, 4522.299043648231, 4556.407667003285, 4563.589276965073, 4568.314752787075, 4594.724316541018, 4488.483824360192, 4539.387182730338, 4540.273556231004, 4562.041971186055, 4591.44902611687, 4479.596836284733, 4487.439070116236, 4493.46078470584, 4507.076049409863, 4509.684322097438, 4499.325101234808, 4514.683972121953, 4531.77341132942, 4534.7052441591195, 4562.133194692998, 3862.8454861805494, 3980.4626375439525, 3992.461017762594, 3994.8002599870183, 4035.5584871152823, 5597.80407685729, 5640.210370548127, 5652.5195358394585, 5706.9429305707245, 5714.457096583899, 5154.226865970097, 5172.0, 5221.0, 5269.104252277122, 5286.762095705664, 5847.502962248172, 6055.183444966492, 6072.483838873657, 6089.969550152266, 6162.198914141178, 4313.331433627793, 4378.343248512717, 4392.758398288093, 4394.6923715339935, 4396.824127034914, 6193.690315484253, 6334.936650633481, 6349.619022858643, 6388.201474815648, 6407.782521320934, 4447.911041779146, 4504.144212599595, 4512.81948722054, 4513.413256276663, 4521.909561808746, 4591.931121033187, 4592.586667199968, 4598.540145985375, 4606.401167848158, 4620.422447194101, 5126.4617215191865, 5256.08018596744, 5262.0, 5262.8947421052135, 5275.920861187085, 5938.435848594377, 6132.945463269854, 6133.172021777093, 6134.478569321657, 6136.263648362135, 1515.7044376346507, 1547.9860691247252, 1556.400785697492, 1570.5680937742213, 1577.1877483096214, 950.6862735297474, 984.6061575369766, 991.980160396788, 1008.9254943485165, 1011.2365164300905, 5215.530602245816, 5219.086659834514, 5226.503482169188, 5235.685858848481, 5288.629795914249, 5448.618596698193, 5503.669779813224, 5517.36550296713, 5521.861953451115, 5531.502164805187, 4882.267659851051, 5180.637355385087, 5247.2129180623215, 5270.0, 5311.256424100629, 2946.6758656547763, 2947.292649764041, 2952.247176969902, 2962.09656054901, 2969.7726704971274, 5655.547556195576, 5683.744231509592, 5685.3177618685195, 5692.800751973661, 5694.800681976111, 6016.308124565643, 6398.776042838478, 6413.4869210463985, 6446.516511261674, 6453.161089058486, 6529.542931994714, 6534.444572211415, 6557.704903279364, 6569.37590928861, 6625.072489851521, 6131.448169664752, 6258.280297765815, 6276.968615156895, 6350.904736428864, 6393.456556192776, 6203.131561581473, 6243.188385509855, 6264.561480696308, 6266.27937787142, 6272.0, 6330.841728956813, 6481.125048118443, 6545.443637290884, 6554.279029306677, 6566.9014964776525, 4437.733735975723, 4460.843870464518, 4487.977560112178, 4498.77506124699, 4511.0, 6113.14415981754, 6209.882221200227, 6370.968145159244, 6423.807285781247, 6426.710798014195, 6096.0, 6118.877622447615, 6123.693815309306, 6138.508919286357, 6146.78486252979, 6013.609115407485, 6054.455099041107, 6087.026075827846, 6093.238345206849, 6187.84530386726, 6026.365348399261, 6050.42520960508, 6070.423309785563, 6071.635701857903, 6076.665783381956, 6112.847178820565, 6126.816195514141, 6142.2629284484365, 6143.907841382294, 6149.385061493815, 5812.622179558315, 5993.190919225849, 6023.186869772525, 6026.819195424145, 6060.454559089703], "value": 4582.598393699997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.6188772220916, 867.9566021698918, 898.712412028151, 920.7513971227769, 950.9904900950988, 15753.527394178178, 16497.505074847744, 16554.420595279138, 16573.585660358498, 16623.83376166238, 15089.245537723125, 15469.0, 15645.0, 15713.371465141408, 15790.526284211463, 883.6377085394973, 887.3788348156285, 892.8794612727264, 895.4582477601056, 896.4442045931531, 872.7818045488627, 898.7348732124007, 899.0, 899.7660608241839, 900.4327273817486, 946.7207173883686, 947.9526023698822, 951.9381240219399, 953.1945506047379, 954.5561313988994, 938.249400479617, 939.6241503398627, 940.0787228516024, 942.3215284994793, 944.0465130218495, 694.8575542013875, 698.3819319901872, 699.1819571101823, 700.9719611215596, 701.1656129206228, 16930.492085237463, 16942.915285423616, 16952.0, 17109.914450427794, 17149.056801875893, 13703.588892333246, 13746.106503077368, 13830.446782128703, 14247.28763561828, 14475.276236188254, 14628.561143165722, 14647.853521464756, 14851.257437128208, 14974.0, 15124.621884452978, 4865.0, 4939.110960027194, 4954.058728841508, 4960.70235785854, 5030.522100400456, 90131.54934225352, 90433.54783226107, 90977.54511227467, 91284.54357728235, 92103.0, 12127.878721212675, 12288.508459661693, 12520.373981300898, 12521.499140034297, 12554.372281386077, 21746.891265543887, 21864.0, 22048.0, 22070.33788986333, 22360.105595776313, 8880.689175878813, 9110.134537218953, 9267.443953362685, 9327.440353578808, 9391.107844754737, 5053.0904437200925, 5140.177571588528, 5212.166053431432, 5238.8166414176085, 5260.44765299638, 3585.3367127081574, 3668.6514781095752, 3673.1368128489785, 3683.1344634010984, 4127.33962565988, 740.7814694665087, 741.6996116572689, 754.4643303254641, 755.0486387152118, 755.7392699518767, 656.7208936202095, 773.3387953299961, 788.755485799404, 791.8376732769768, 813.276184196066, 10702.304350217211, 10807.135429165804, 11032.50353734084, 11144.442777861075, 11257.324560526395, 689.4381079420257, 754.7962050246402, 761.824780300534, 772.3666593393476, 778.4550814429922, 4258.339957306623, 4453.955460445419, 4620.768961551909, 4626.167289887785, 4781.306710526954, 128763.35618321848, 130054.0, 132615.33692331475, 133738.33130834284, 138063.0, 113897.0, 117278.41360793312, 117278.41360793312, 119152.0, 122150.0, 97340.0, 101845.0, 102319.0, 102802.48598757108, 103812.0, 8907.777305567413, 8996.241235334392, 9012.954935225544, 9039.59321830506, 9089.454632722058, 49219.50780492293, 54559.72720136374, 55385.72307138438, 55858.44141558695, 57508.137377938525, 81123.18876811156, 86269.0, 88166.0, 89019.55490222508, 91816.0, 13184.868151318364, 13364.198148111145, 13404.664883377993, 13429.731405372033, 13581.0, 14815.18516481604, 14946.402143914556, 15000.549983500512, 15336.0, 16072.0, 13261.54746146724, 13357.32714266537, 13758.243296618382, 13806.86193138096, 13954.302284885918, 13999.51001714935, 14121.576352709435, 14242.501512447014, 14438.0, 15118.697626047637, 11869.643910682693, 13153.53962611304, 14048.2975851205, 14403.495877644233, 15029.248537573296, 12011.0, 12039.09706771978, 12066.517339306329, 12154.696132596402, 12705.745885082431, 11657.242279251821, 12203.75592488163, 12676.492940282285, 12677.80983285233, 12823.679408014874], "value": 8271.474284363368, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 105.0, 111.0, 113.0, 112.0, 111.0, 111.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 142.0, 172.0, 119.0, 149.0, 145.0, 120.0, 164.0, 116.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 164.0, 162.0, 161.0, 161.0, 165.0, 159.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 185.0, 75.0, 77.0, 76.0, 77.0, 177.0, 76.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 139.0, 85.0, 85.0, 85.0, 142.0, 85.0, 83.0, 140.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0, 51.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 59.0, 60.0, 62.0, 60.0, 60.0, 59.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 82.0, 77.0, 72.0, 72.0, 75.0, 74.0, 77.0, 72.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 120.0, 126.0, 131.0, 128.0, 117.0, 126.0, 151.0, 121.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 155.0, 154.0, 150.0, 155.0, 156.0, 158.0, 154.0, 152.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 64.0], "value": 62.8, "unit": "score"}]}]} 15:44:37 INFO - Return code: 0 15:44:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:37 ERROR - # TBPL SUCCESS # 15:44:37 INFO - Running post-action listener: _resource_record_post_action 15:44:37 INFO - [mozharness: 2016-08-25 22:44:37.593840Z] Finished run-tests step (success) 15:44:37 INFO - Running post-run listener: _resource_record_post_run 15:44:37 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 774144; Write bytes: 329875456; Read time: 300; Write time: 245328 15:44:37 INFO - TinderboxPrint: CPU usage
13.2% 15:44:37 INFO - TinderboxPrint: I/O read bytes / time
774,144 / 300 15:44:37 INFO - TinderboxPrint: I/O write bytes / time
329,875,456 / 245,328 15:44:37 INFO - TinderboxPrint: CPU idle
8,216.4 (86.7%) 15:44:37 INFO - TinderboxPrint: CPU user
1,200.0 (12.7%) 15:44:37 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78262272; Read time: 0; Write time: 44828 15:44:37 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 770048; Write bytes: 251187200; Read time: 284; Write time: 200456 15:44:38 INFO - Running post-run listener: _upload_blobber_files 15:44:38 INFO - Blob upload gear active. 15:44:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:44:38 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:39 INFO - (blobuploader) - INFO - Done attempting. 15:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:44 INFO - (blobuploader) - INFO - Done attempting. 15:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:45 INFO - (blobuploader) - INFO - Done attempting. 15:44:45 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:45 INFO - Return code: 0 15:44:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad5a483f18fce5f19a00191a6822bb0067ba04ad56b467844cc5b82788f4889bdf1b565fc1ed39a011d709ee01ad90c209279dfcc3e1d1dcf3bb5d8191e8a849", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e4366dc4d2958ab13130656d3023bdcd702ceb8e4391e5417eaf8b6b6a3724c6675227d064f02590a26b84740d6758f4e19ceb60583b3e97023e90ef5b3ff9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f04368bfb7b6e839c98ebb928523a0d01955511bd883b63cfe6454ee030e3bce95106c63d551d1263e5cf0aff7cc565de678dd31be2cf37c63b64c1d905db8e"} 15:44:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:45 INFO - Contents: 15:44:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad5a483f18fce5f19a00191a6822bb0067ba04ad56b467844cc5b82788f4889bdf1b565fc1ed39a011d709ee01ad90c209279dfcc3e1d1dcf3bb5d8191e8a849", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e4366dc4d2958ab13130656d3023bdcd702ceb8e4391e5417eaf8b6b6a3724c6675227d064f02590a26b84740d6758f4e19ceb60583b3e97023e90ef5b3ff9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f04368bfb7b6e839c98ebb928523a0d01955511bd883b63cfe6454ee030e3bce95106c63d551d1263e5cf0aff7cc565de678dd31be2cf37c63b64c1d905db8e"} 15:44:45 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:45 INFO - Copying logs to upload dir... 15:44:45 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.658820 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-25 15:44:45.694610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 15:44:45.700411) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad5a483f18fce5f19a00191a6822bb0067ba04ad56b467844cc5b82788f4889bdf1b565fc1ed39a011d709ee01ad90c209279dfcc3e1d1dcf3bb5d8191e8a849", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e4366dc4d2958ab13130656d3023bdcd702ceb8e4391e5417eaf8b6b6a3724c6675227d064f02590a26b84740d6758f4e19ceb60583b3e97023e90ef5b3ff9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f04368bfb7b6e839c98ebb928523a0d01955511bd883b63cfe6454ee030e3bce95106c63d551d1263e5cf0aff7cc565de678dd31be2cf37c63b64c1d905db8e"} build_url:https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010129 build_url: 'https://queue.taskcluster.net/v1/task/LWJmc14eQXiMX34xS-YozA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad5a483f18fce5f19a00191a6822bb0067ba04ad56b467844cc5b82788f4889bdf1b565fc1ed39a011d709ee01ad90c209279dfcc3e1d1dcf3bb5d8191e8a849", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e4366dc4d2958ab13130656d3023bdcd702ceb8e4391e5417eaf8b6b6a3724c6675227d064f02590a26b84740d6758f4e19ceb60583b3e97023e90ef5b3ff9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f04368bfb7b6e839c98ebb928523a0d01955511bd883b63cfe6454ee030e3bce95106c63d551d1263e5cf0aff7cc565de678dd31be2cf37c63b64c1d905db8e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 15:44:45.724693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:44:45.725014) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472163407.830025-874338660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:44:46.019345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 15:44:46.019660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 15:44:46.023041) ========= ========= Total master_lag: 0.79 =========