builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1472212617.41 results: success (0) buildid: 20160826020018 builduid: c109b55f2e2e4a6595906f6ceee5953e revision: 2438f69a60b794a561afd38a2b7780396e06731c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.408422) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.409005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.409320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.424852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.425510) ========= 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=920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 04:56:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-08-26 04:56:58 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146416 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.587927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.588280) ========= 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=920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017381 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:57.637893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 04:56:57.638287) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2438f69a60b794a561afd38a2b7780396e06731c --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 2438f69a60b794a561afd38a2b7780396e06731c --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=920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 04:56:58,355 truncating revision to first 12 chars 2016-08-26 04:56:58,355 Setting DEBUG logging. 2016-08-26 04:56:58,356 attempt 1/10 2016-08-26 04:56:58,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2438f69a60b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 04:56:58,946 unpacking tar archive at: mozilla-aurora-2438f69a60b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.017111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 04:56:58.669853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:58.670226) ========= script_repo_revision: 2438f69a60b794a561afd38a2b7780396e06731c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:58.670678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:58.670982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 04:56:58.681982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-26 04:56:58.682294) ========= /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=920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:59 INFO - MultiFileLogger online at 20160826 04:56:59 in /builds/slave/test 04:56:59 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 04:56:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:59 INFO - {'append_to_log': False, 04:56:59 INFO - 'base_work_dir': '/builds/slave/test', 04:56:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:56:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:59 INFO - 'branch': 'Mozilla-Aurora', 04:56:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:59 INFO - 'config_files': ('talos/linux_config.py',), 04:56:59 INFO - 'default_actions': ('clobber', 04:56:59 INFO - 'read-buildbot-config', 04:56:59 INFO - 'download-and-extract', 04:56:59 INFO - 'populate-webroot', 04:56:59 INFO - 'create-virtualenv', 04:56:59 INFO - 'install', 04:56:59 INFO - 'run-tests'), 04:56:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:59 INFO - 'download_minidump_stackwalk': True, 04:56:59 INFO - 'download_symbols': 'ondemand', 04:56:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:59 INFO - 'installer_path': 'installer.exe', 04:56:59 INFO - 'log_level': 'info', 04:56:59 INFO - 'log_name': 'talos', 04:56:59 INFO - 'log_to_console': True, 04:56:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:59 INFO - 'opt_config_files': (), 04:56:59 INFO - 'pip_index': False, 04:56:59 INFO - 'sps_profile': False, 04:56:59 INFO - 'sps_profile_interval': 0, 04:56:59 INFO - 'suite': 'dromaeojs-e10s', 04:56:59 INFO - 'system_bits': '32', 04:56:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:59 INFO - 'title': 'talos-linux64-ix-053', 04:56:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:59 INFO - 'use_talos_json': True, 04:56:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:59 INFO - 'work_dir': 'build'} 04:56:59 INFO - [mozharness: 2016-08-26 11:56:59.495232Z] Running clobber step. 04:56:59 INFO - Running pre-action listener: _resource_record_pre_action 04:56:59 INFO - Running main action method: clobber 04:56:59 INFO - rmtree: /builds/slave/test/build 04:56:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:59 INFO - Running post-action listener: _resource_record_post_action 04:56:59 INFO - [mozharness: 2016-08-26 11:56:59.954655Z] Finished clobber step (success) 04:56:59 INFO - [mozharness: 2016-08-26 11:56:59.954756Z] Running read-buildbot-config step. 04:56:59 INFO - Running pre-action listener: _resource_record_pre_action 04:56:59 INFO - Running main action method: read_buildbot_config 04:56:59 INFO - Using buildbot properties: 04:56:59 INFO - { 04:56:59 INFO - "project": "", 04:56:59 INFO - "product": "firefox", 04:56:59 INFO - "script_repo_revision": "production", 04:56:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:56:59 INFO - "repository": "", 04:56:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:56:59 INFO - "buildid": "20160826020018", 04:56:59 INFO - "pgo_build": "True", 04:56:59 INFO - "basedir": "/builds/slave/test", 04:56:59 INFO - "buildnumber": 509, 04:56:59 INFO - "slavename": "talos-linux64-ix-053", 04:56:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:56:59 INFO - "platform": "ubuntu64_hw", 04:56:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:56:59 INFO - "branch": "mozilla-aurora", 04:56:59 INFO - "repo_path": "releases/mozilla-aurora", 04:56:59 INFO - "revision": "2438f69a60b794a561afd38a2b7780396e06731c", 04:56:59 INFO - "stage_platform": "linux64-pgo", 04:56:59 INFO - "builduid": "c109b55f2e2e4a6595906f6ceee5953e", 04:56:59 INFO - "slavebuilddir": "test" 04:56:59 INFO - } 04:56:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 04:56:59 INFO - Running post-action listener: _resource_record_post_action 04:56:59 INFO - [mozharness: 2016-08-26 11:56:59.957200Z] Finished read-buildbot-config step (success) 04:56:59 INFO - [mozharness: 2016-08-26 11:56:59.957287Z] Running download-and-extract step. 04:56:59 INFO - Running pre-action listener: _resource_record_pre_action 04:56:59 INFO - Running main action method: download_and_extract 04:56:59 INFO - mkdir: /builds/slave/test/build/tests 04:56:59 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')]} 04:56:59 INFO - https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:56:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:56:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:56:59 INFO - retry: Failed, sleeping 30 seconds before retrying 04:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:57:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:57:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:57:30 INFO - retry: Failed, sleeping 60 seconds before retrying 04:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:58:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:58:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:58:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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! 04:58:30 INFO - Caught exception: HTTP Error 404: Not Found 04:58:30 INFO - Caught exception: HTTP Error 404: Not Found 04:58:30 INFO - Caught exception: HTTP Error 404: Not Found 04:58:30 INFO - trying https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:58:30 INFO - Downloaded 1361 bytes. 04:58:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:58:30 INFO - Using the following test package requirements: 04:58:30 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:58:30 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:58:30 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:58:30 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'jsshell-linux-x86_64.zip'], 04:58:30 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:58:30 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:58:30 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:58:30 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:58:30 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:58:30 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:30 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:58:30 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:58:30 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')]} 04:58:30 INFO - https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:58:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:58:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:58:30 INFO - retry: Failed, sleeping 30 seconds before retrying 04:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 04:59:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:59:00 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:59:00 INFO - retry: Failed, sleeping 60 seconds before retrying 05:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:00:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:00:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:00:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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! 05:00:00 INFO - Caught exception: HTTP Error 404: Not Found 05:00:00 INFO - Caught exception: HTTP Error 404: Not Found 05:00:00 INFO - Caught exception: HTTP Error 404: Not Found 05:00:00 INFO - trying https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:00:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:00:01 INFO - Downloaded 21770798 bytes. 05:00:01 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'] 05:00:01 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 05:00:02 INFO - Return code: 0 05:00:02 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 05:00:02 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')]} 05:00:02 INFO - https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:00:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:00:02 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:00:02 INFO - retry: Failed, sleeping 30 seconds before retrying 05:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:00:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:00:32 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:00:32 INFO - retry: Failed, sleeping 60 seconds before retrying 05:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:01:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:01:32 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:01:32 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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! 05:01:32 INFO - Caught exception: HTTP Error 404: Not Found 05:01:32 INFO - Caught exception: HTTP Error 404: Not Found 05:01:32 INFO - Caught exception: HTTP Error 404: Not Found 05:01:32 INFO - trying https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:01:32 INFO - Downloading https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:01:33 INFO - Downloaded 21770798 bytes. 05:01:33 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'] 05:01:33 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 05:01:35 INFO - Return code: 0 05:01:35 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')]} 05:01:35 INFO - https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:01:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:01:35 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:01:35 INFO - retry: Failed, sleeping 30 seconds before retrying 05:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:02:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:02:05 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:02:05 INFO - retry: Failed, sleeping 60 seconds before retrying 05:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:03:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:03:05 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:03:05 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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! 05:03:05 INFO - Caught exception: HTTP Error 404: Not Found 05:03:05 INFO - Caught exception: HTTP Error 404: Not Found 05:03:05 INFO - Caught exception: HTTP Error 404: Not Found 05:03:05 INFO - trying https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:03:05 INFO - Downloading https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:03:05 INFO - Downloaded 14413723 bytes. 05:03:05 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'] 05:03:05 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 05:03:06 INFO - Return code: 0 05:03: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')]} 05:03:06 INFO - https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:03:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:03:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:03:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:03:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:03:06 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:03:06 INFO - retry: Failed, sleeping 30 seconds before retrying 05:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:03:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:03:36 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:03:36 INFO - retry: Failed, sleeping 60 seconds before retrying 05:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:04:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:04:36 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:04:36 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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! 05:04:36 INFO - Caught exception: HTTP Error 404: Not Found 05:04:36 INFO - Caught exception: HTTP Error 404: Not Found 05:04:36 INFO - Caught exception: HTTP Error 404: Not Found 05:04:36 INFO - trying https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:04:36 INFO - Downloading https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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 05:04:37 INFO - Downloaded 63756912 bytes. 05:04:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:04:37 INFO - mkdir: /builds/slave/test/properties 05:04:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:37 INFO - Contents: 05:04:37 INFO - build_url:https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:04:38 INFO - Running post-action listener: _resource_record_post_action 05:04:38 INFO - Running post-action listener: set_extra_try_arguments 05:04:38 INFO - [mozharness: 2016-08-26 12:04:38.375732Z] Finished download-and-extract step (success) 05:04:38 INFO - [mozharness: 2016-08-26 12:04:38.375965Z] Running populate-webroot step. 05:04:38 INFO - Running pre-action listener: _resource_record_pre_action 05:04:38 INFO - Running main action method: populate_webroot 05:04:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:38 INFO - '--tppagecycles', 05:04:38 INFO - '7'], 05:04:38 INFO - 'tests': ['tsvgm']}}, 05:04:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['damp', 'tps']}, 05:04:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'tests': ['damp', 'tps']}, 05:04:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['dromaeo_dom']}, 05:04:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['basic_compositor_video']}, 05:04:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:04:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['a11yr', 05:04:38 INFO - 'ts_paint', 05:04:38 INFO - 'tpaint', 05:04:38 INFO - 'sessionrestore', 05:04:38 INFO - 'sessionrestore_no_auto_restore', 05:04:38 INFO - 'tabpaint']}, 05:04:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:38 INFO - 'ts_paint', 05:04:38 INFO - 'tpaint', 05:04:38 INFO - 'sessionrestore', 05:04:38 INFO - 'sessionrestore_no_auto_restore', 05:04:38 INFO - 'tabpaint']}, 05:04:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:38 INFO - 'ts_paint', 05:04:38 INFO - 'tpaint', 05:04:38 INFO - 'sessionrestore', 05:04:38 INFO - 'sessionrestore_no_auto_restore', 05:04:38 INFO - 'tabpaint']}, 05:04:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:38 INFO - 'ts_paint', 05:04:38 INFO - 'tpaint', 05:04:38 INFO - 'sessionrestore', 05:04:38 INFO - 'sessionrestore_no_auto_restore', 05:04:38 INFO - 'tabpaint']}, 05:04:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['a11yr', 05:04:38 INFO - 'ts_paint', 05:04:38 INFO - 'tpaint', 05:04:38 INFO - 'sessionrestore', 05:04:38 INFO - 'sessionrestore_no_auto_restore', 05:04:38 INFO - 'tabpaint']}, 05:04:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['a11yr', 05:04:38 INFO - 'ts_paint', 05:04:38 INFO - 'tpaint', 05:04:38 INFO - 'sessionrestore', 05:04:38 INFO - 'sessionrestore_no_auto_restore', 05:04:38 INFO - 'tabpaint']}, 05:04:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['tsvgx', 05:04:38 INFO - 'tsvgr_opacity', 05:04:38 INFO - 'tart', 05:04:38 INFO - 'tscrollx', 05:04:38 INFO - 'cart']}, 05:04:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:38 INFO - 'tsvgr_opacity', 05:04:38 INFO - 'tart', 05:04:38 INFO - 'tscrollx', 05:04:38 INFO - 'cart']}, 05:04:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'talos_options': ['--disable-e10s'], 05:04:38 INFO - 'tests': ['tp5o']}, 05:04:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'tests': ['tp5o']}, 05:04:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'talos_options': ['--disable-e10s', 05:04:38 INFO - '--xperf_path', 05:04:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:38 INFO - 'tests': ['tp5n']}, 05:04:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:38 INFO - 'talos_options': ['--xperf_path', 05:04:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:38 INFO - 'tests': ['tp5n']}}, 05:04:38 INFO - 'talos.zip': {'path': '', 05:04:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:38 INFO - Running post-action listener: _resource_record_post_action 05:04:38 INFO - [mozharness: 2016-08-26 12:04:38.395904Z] Finished populate-webroot step (success) 05:04:38 INFO - [mozharness: 2016-08-26 12:04:38.395993Z] Running create-virtualenv step. 05:04:38 INFO - Running pre-action listener: _resource_record_pre_action 05:04:38 INFO - Running main action method: create_virtualenv 05:04:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:38 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 05:04:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:38 INFO - Using real prefix '/usr' 05:04:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:40 INFO - Installing pip.................done. 05:04:40 INFO - Return code: 0 05:04:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04:40 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')]} 05:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:40 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')]} 05:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:40 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:40 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 05:04:40 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 05:04:40 INFO - Using env: {'DISPLAY': ':0', 05:04:40 INFO - 'HOME': '/home/cltbld', 05:04:40 INFO - 'LANG': 'en_US.UTF-8', 05:04:40 INFO - 'LANGUAGE': 'en_US:en', 05:04:40 INFO - 'LOGNAME': 'cltbld', 05:04:40 INFO - 'MAIL': '/var/mail/cltbld', 05:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:40 INFO - 'MOZ_NO_REMOTE': '1', 05:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:40 INFO - 'NO_EM_RESTART': '1', 05:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:40 INFO - 'PWD': '/builds/slave/test', 05:04:40 INFO - 'SHELL': '/bin/bash', 05:04:40 INFO - 'SHLVL': '1', 05:04:40 INFO - 'TERM': 'linux', 05:04:40 INFO - 'TMOUT': '86400', 05:04:40 INFO - 'USER': 'cltbld', 05:04:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:40 INFO - '_': '/tools/buildbot/bin/python'} 05:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:41 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 05:04:41 INFO - Cleaning up... 05:04:41 INFO - Return code: 0 05:04:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:41 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:41 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 05:04:41 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 05:04:41 INFO - Using env: {'DISPLAY': ':0', 05:04:41 INFO - 'HOME': '/home/cltbld', 05:04:41 INFO - 'LANG': 'en_US.UTF-8', 05:04:41 INFO - 'LANGUAGE': 'en_US:en', 05:04:41 INFO - 'LOGNAME': 'cltbld', 05:04:41 INFO - 'MAIL': '/var/mail/cltbld', 05:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:41 INFO - 'MOZ_NO_REMOTE': '1', 05:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:41 INFO - 'NO_EM_RESTART': '1', 05:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:41 INFO - 'PWD': '/builds/slave/test', 05:04:41 INFO - 'SHELL': '/bin/bash', 05:04:41 INFO - 'SHLVL': '1', 05:04:41 INFO - 'TERM': 'linux', 05:04:41 INFO - 'TMOUT': '86400', 05:04:41 INFO - 'USER': 'cltbld', 05:04:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:41 INFO - '_': '/tools/buildbot/bin/python'} 05:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:41 INFO - Downloading/unpacking psutil>=3.1.1 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:43 INFO - Installing collected packages: psutil 05:04:43 INFO - Running setup.py install for psutil 05:04:43 INFO - building 'psutil._psutil_linux' extension 05:04:43 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 05:04:43 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 05:04:43 INFO - building 'psutil._psutil_posix' extension 05:04:43 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 05:04:43 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 05:04:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:43 INFO - Successfully installed psutil 05:04:43 INFO - Cleaning up... 05:04:43 INFO - Return code: 0 05:04:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:04:43 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')]} 05:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:43 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')]} 05:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:43 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:43 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 05:04:43 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 05:04:43 INFO - Using env: {'DISPLAY': ':0', 05:04:43 INFO - 'HOME': '/home/cltbld', 05:04:43 INFO - 'LANG': 'en_US.UTF-8', 05:04:43 INFO - 'LANGUAGE': 'en_US:en', 05:04:43 INFO - 'LOGNAME': 'cltbld', 05:04:43 INFO - 'MAIL': '/var/mail/cltbld', 05:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:43 INFO - 'MOZ_NO_REMOTE': '1', 05:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:43 INFO - 'NO_EM_RESTART': '1', 05:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:43 INFO - 'PWD': '/builds/slave/test', 05:04:43 INFO - 'SHELL': '/bin/bash', 05:04:43 INFO - 'SHLVL': '1', 05:04:43 INFO - 'TERM': 'linux', 05:04:43 INFO - 'TMOUT': '86400', 05:04:43 INFO - 'USER': 'cltbld', 05:04:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:43 INFO - '_': '/tools/buildbot/bin/python'} 05:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:04:46 INFO - Installing collected packages: mozsystemmonitor 05:04:46 INFO - Running setup.py install for mozsystemmonitor 05:04:46 INFO - Successfully installed mozsystemmonitor 05:04:46 INFO - Cleaning up... 05:04:46 INFO - Return code: 0 05:04:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:04:46 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')]} 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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')]} 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:46 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 05:04:46 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 05:04:46 INFO - Using env: {'DISPLAY': ':0', 05:04:46 INFO - 'HOME': '/home/cltbld', 05:04:46 INFO - 'LANG': 'en_US.UTF-8', 05:04:46 INFO - 'LANGUAGE': 'en_US:en', 05:04:46 INFO - 'LOGNAME': 'cltbld', 05:04:46 INFO - 'MAIL': '/var/mail/cltbld', 05:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:46 INFO - 'MOZ_NO_REMOTE': '1', 05:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:46 INFO - 'NO_EM_RESTART': '1', 05:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:46 INFO - 'PWD': '/builds/slave/test', 05:04:46 INFO - 'SHELL': '/bin/bash', 05:04:46 INFO - 'SHLVL': '1', 05:04:46 INFO - 'TERM': 'linux', 05:04:46 INFO - 'TMOUT': '86400', 05:04:46 INFO - 'USER': 'cltbld', 05:04:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:46 INFO - '_': '/tools/buildbot/bin/python'} 05:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:04:48 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 05:04:48 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 05:04:48 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 05:04:48 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 05:04:48 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 05:04:48 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 05:04:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:48 INFO - warning: no files found matching '*.txt' 05:04:48 INFO - no previously-included directories found matching 'build' 05:04:48 INFO - no previously-included directories found matching 'dist' 05:04:48 INFO - no previously-included directories found matching '.git*' 05:04:48 INFO - Installing collected packages: jsonschema, functools32 05:04:48 INFO - Running setup.py install for functools32 05:04:48 INFO - warning: no files found matching '*.txt' 05:04:48 INFO - no previously-included directories found matching 'build' 05:04:48 INFO - no previously-included directories found matching 'dist' 05:04:48 INFO - no previously-included directories found matching '.git*' 05:04:48 INFO - Successfully installed jsonschema functools32 05:04:48 INFO - Cleaning up... 05:04:49 INFO - Return code: 0 05:04:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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', '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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:04: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 functools32==3.2.3-2 05:04:49 INFO - Using env: {'DISPLAY': ':0', 05:04:49 INFO - 'HOME': '/home/cltbld', 05:04:49 INFO - 'LANG': 'en_US.UTF-8', 05:04:49 INFO - 'LANGUAGE': 'en_US:en', 05:04:49 INFO - 'LOGNAME': 'cltbld', 05:04:49 INFO - 'MAIL': '/var/mail/cltbld', 05:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:49 INFO - 'MOZ_NO_REMOTE': '1', 05:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:49 INFO - 'NO_EM_RESTART': '1', 05:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:49 INFO - 'PWD': '/builds/slave/test', 05:04:49 INFO - 'SHELL': '/bin/bash', 05:04:49 INFO - 'SHLVL': '1', 05:04:49 INFO - 'TERM': 'linux', 05:04:49 INFO - 'TMOUT': '86400', 05:04:49 INFO - 'USER': 'cltbld', 05:04:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:49 INFO - '_': '/tools/buildbot/bin/python'} 05:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:04:49 INFO - Cleaning up... 05:04:49 INFO - Return code: 0 05:04:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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', '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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:04: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 blobuploader==1.2.4 05:04:49 INFO - Using env: {'DISPLAY': ':0', 05:04:49 INFO - 'HOME': '/home/cltbld', 05:04:49 INFO - 'LANG': 'en_US.UTF-8', 05:04:49 INFO - 'LANGUAGE': 'en_US:en', 05:04:49 INFO - 'LOGNAME': 'cltbld', 05:04:49 INFO - 'MAIL': '/var/mail/cltbld', 05:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:49 INFO - 'MOZ_NO_REMOTE': '1', 05:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:49 INFO - 'NO_EM_RESTART': '1', 05:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:49 INFO - 'PWD': '/builds/slave/test', 05:04:49 INFO - 'SHELL': '/bin/bash', 05:04:49 INFO - 'SHLVL': '1', 05:04:49 INFO - 'TERM': 'linux', 05:04:49 INFO - 'TMOUT': '86400', 05:04:49 INFO - 'USER': 'cltbld', 05:04:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:49 INFO - '_': '/tools/buildbot/bin/python'} 05:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:52 INFO - Downloading docopt-0.6.1.tar.gz 05:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:52 INFO - Running setup.py install for blobuploader 05:04:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:52 INFO - Running setup.py install for requests 05:04:52 INFO - Running setup.py install for docopt 05:04:52 INFO - Successfully installed blobuploader requests docopt 05:04:52 INFO - Cleaning up... 05:04:52 INFO - Return code: 0 05:04:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:52 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:52 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 05:04:52 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 05:04:52 INFO - Using env: {'DISPLAY': ':0', 05:04:52 INFO - 'HOME': '/home/cltbld', 05:04:52 INFO - 'LANG': 'en_US.UTF-8', 05:04:52 INFO - 'LANGUAGE': 'en_US:en', 05:04:52 INFO - 'LOGNAME': 'cltbld', 05:04:52 INFO - 'MAIL': '/var/mail/cltbld', 05:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:52 INFO - 'MOZ_NO_REMOTE': '1', 05:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:52 INFO - 'NO_EM_RESTART': '1', 05:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:52 INFO - 'PWD': '/builds/slave/test', 05:04:52 INFO - 'SHELL': '/bin/bash', 05:04:52 INFO - 'SHLVL': '1', 05:04:52 INFO - 'TERM': 'linux', 05:04:52 INFO - 'TMOUT': '86400', 05:04:52 INFO - 'USER': 'cltbld', 05:04:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:52 INFO - '_': '/tools/buildbot/bin/python'} 05:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:52 INFO - Running setup.py (path:/tmp/pip-FD47YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:53 INFO - Running setup.py (path:/tmp/pip-pvvg4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:53 INFO - Running setup.py (path:/tmp/pip-XWE1yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:53 INFO - Running setup.py (path:/tmp/pip-XF1IkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:53 INFO - Running setup.py (path:/tmp/pip-A9YffQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:53 INFO - Running setup.py (path:/tmp/pip-wBNjuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:53 INFO - Running setup.py (path:/tmp/pip-NLl5Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:53 INFO - Running setup.py (path:/tmp/pip-0RbrJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:53 INFO - Running setup.py (path:/tmp/pip-p4xTzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:53 INFO - Running setup.py (path:/tmp/pip-5X5aQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:53 INFO - Running setup.py (path:/tmp/pip-6hJBLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:53 INFO - Running setup.py (path:/tmp/pip-7GdRgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:53 INFO - Running setup.py (path:/tmp/pip-sBZUij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:53 INFO - Running setup.py (path:/tmp/pip-MRy4J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:53 INFO - Running setup.py (path:/tmp/pip-s7qVjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:54 INFO - Running setup.py (path:/tmp/pip-PP2ADl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:54 INFO - Running setup.py (path:/tmp/pip-YbrAqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:54 INFO - Running setup.py install for manifestparser 05:04:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Running setup.py install for mozcrash 05:04:54 INFO - Running setup.py install for mozdebug 05:04:54 INFO - Running setup.py install for mozdevice 05:04:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Running setup.py install for mozfile 05:04:54 INFO - Running setup.py install for mozhttpd 05:04:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Running setup.py install for mozinfo 05:04:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Running setup.py install for mozInstall 05:04:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:54 INFO - Running setup.py install for mozleak 05:04:55 INFO - Running setup.py install for mozlog 05:04:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Running setup.py install for moznetwork 05:04:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Running setup.py install for mozprocess 05:04:55 INFO - Running setup.py install for mozprofile 05:04:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Running setup.py install for mozrunner 05:04:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Running setup.py install for mozscreenshot 05:04:55 INFO - Running setup.py install for moztest 05:04:55 INFO - Running setup.py install for mozversion 05:04:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:55 INFO - Cleaning up... 05:04:55 INFO - Return code: 0 05:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:55 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:55 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 05:04:55 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 05:04:55 INFO - Using env: {'DISPLAY': ':0', 05:04:55 INFO - 'HOME': '/home/cltbld', 05:04:55 INFO - 'LANG': 'en_US.UTF-8', 05:04:55 INFO - 'LANGUAGE': 'en_US:en', 05:04:55 INFO - 'LOGNAME': 'cltbld', 05:04:55 INFO - 'MAIL': '/var/mail/cltbld', 05:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:55 INFO - 'MOZ_NO_REMOTE': '1', 05:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:55 INFO - 'NO_EM_RESTART': '1', 05:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:55 INFO - 'PWD': '/builds/slave/test', 05:04:55 INFO - 'SHELL': '/bin/bash', 05:04:55 INFO - 'SHLVL': '1', 05:04:55 INFO - 'TERM': 'linux', 05:04:55 INFO - 'TMOUT': '86400', 05:04:55 INFO - 'USER': 'cltbld', 05:04:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:55 INFO - '_': '/tools/buildbot/bin/python'} 05:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:56 INFO - Running setup.py (path:/tmp/pip-9OvEwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:56 INFO - Running setup.py (path:/tmp/pip-k1XqqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:56 INFO - Running setup.py (path:/tmp/pip-XRo3zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:56 INFO - Running setup.py (path:/tmp/pip-AG9itp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:56 INFO - Running setup.py (path:/tmp/pip-FkPIVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:56 INFO - Running setup.py (path:/tmp/pip-lpcmHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:56 INFO - Running setup.py (path:/tmp/pip-0BzP7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:56 INFO - Running setup.py (path:/tmp/pip-qKVUDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:56 INFO - Running setup.py (path:/tmp/pip-V8UpaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:56 INFO - Running setup.py (path:/tmp/pip-JRODG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:56 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)) 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:56 INFO - Running setup.py (path:/tmp/pip-5OtUET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:57 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)) 05:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:57 INFO - Running setup.py (path:/tmp/pip-d44cG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:57 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)) 05:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:57 INFO - Running setup.py (path:/tmp/pip-GgvZRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:57 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)) 05:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:57 INFO - Running setup.py (path:/tmp/pip-fjqG2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:57 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)) 05:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:57 INFO - Running setup.py (path:/tmp/pip-e8iX7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:57 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)) 05:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:57 INFO - Running setup.py (path:/tmp/pip-Xhgsq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:57 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)) 05:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:57 INFO - Running setup.py (path:/tmp/pip-UfEMNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:57 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)) 05:04:57 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)) 05:04:57 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)) 05:04:57 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)) 05:04:57 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)) 05:04:57 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)) 05:04:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:57 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 05:04:57 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 05:04:57 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 05:04:57 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 05:04:57 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 05:04:57 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 05:04:59 INFO - Downloading blessings-1.6.tar.gz 05:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:59 INFO - Installing collected packages: blessings 05:04:59 INFO - Running setup.py install for blessings 05:04:59 INFO - Successfully installed blessings 05:04:59 INFO - Cleaning up... 05:04:59 INFO - Return code: 0 05:04:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:59 INFO - Reading from file tmpfile_stdout 05:04:59 INFO - Current package versions: 05:04:59 INFO - argparse == 1.2.1 05:04:59 INFO - blessings == 1.6 05:04:59 INFO - blobuploader == 1.2.4 05:04:59 INFO - docopt == 0.6.1 05:04:59 INFO - functools32 == 3.2.3-2 05:04:59 INFO - jsonschema == 2.5.1 05:04:59 INFO - manifestparser == 1.1 05:04:59 INFO - mozInstall == 1.12 05:04:59 INFO - mozcrash == 0.17 05:04:59 INFO - mozdebug == 0.1 05:04:59 INFO - mozdevice == 0.48 05:04:59 INFO - mozfile == 1.2 05:04:59 INFO - mozhttpd == 0.7 05:04:59 INFO - mozinfo == 0.9 05:04:59 INFO - mozleak == 0.1 05:04:59 INFO - mozlog == 3.3 05:04:59 INFO - moznetwork == 0.27 05:04:59 INFO - mozprocess == 0.23 05:04:59 INFO - mozprofile == 0.28 05:04:59 INFO - mozrunner == 6.12 05:04:59 INFO - mozscreenshot == 0.1 05:04:59 INFO - mozsystemmonitor == 0.3 05:04:59 INFO - moztest == 0.7 05:04:59 INFO - mozversion == 1.4 05:04:59 INFO - psutil == 3.1.1 05:04:59 INFO - requests == 1.2.3 05:04:59 INFO - wsgiref == 0.1.2 05:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:59 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')]} 05:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:59 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')]} 05:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:59 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 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:04:59 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 05:04:59 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 05:04:59 INFO - Using env: {'DISPLAY': ':0', 05:04:59 INFO - 'HOME': '/home/cltbld', 05:04:59 INFO - 'LANG': 'en_US.UTF-8', 05:04:59 INFO - 'LANGUAGE': 'en_US:en', 05:04:59 INFO - 'LOGNAME': 'cltbld', 05:04:59 INFO - 'MAIL': '/var/mail/cltbld', 05:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:59 INFO - 'MOZ_NO_REMOTE': '1', 05:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:59 INFO - 'NO_EM_RESTART': '1', 05:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:59 INFO - 'PWD': '/builds/slave/test', 05:04:59 INFO - 'SHELL': '/bin/bash', 05:04:59 INFO - 'SHLVL': '1', 05:04:59 INFO - 'TERM': 'linux', 05:04:59 INFO - 'TMOUT': '86400', 05:04:59 INFO - 'USER': 'cltbld', 05:04:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:59 INFO - '_': '/tools/buildbot/bin/python'} 05:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 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)) 05:05:00 INFO - Cleaning up... 05:05:00 INFO - Return code: 0 05:05:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, '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': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', '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 05:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:05:00 INFO - Using env: {'DISPLAY': ':0', 05:05:00 INFO - 'HOME': '/home/cltbld', 05:05:00 INFO - 'LANG': 'en_US.UTF-8', 05:05:00 INFO - 'LANGUAGE': 'en_US:en', 05:05:00 INFO - 'LOGNAME': 'cltbld', 05:05:00 INFO - 'MAIL': '/var/mail/cltbld', 05:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:00 INFO - 'MOZ_NO_REMOTE': '1', 05:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:00 INFO - 'NO_EM_RESTART': '1', 05:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:00 INFO - 'PWD': '/builds/slave/test', 05:05:00 INFO - 'SHELL': '/bin/bash', 05:05:00 INFO - 'SHLVL': '1', 05:05:00 INFO - 'TERM': 'linux', 05:05:00 INFO - 'TMOUT': '86400', 05:05:00 INFO - 'USER': 'cltbld', 05:05:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:00 INFO - '_': '/tools/buildbot/bin/python'} 05:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:00 INFO - Cleaning up... 05:05:00 INFO - Return code: 0 05:05:00 INFO - Running post-action listener: _resource_record_post_action 05:05:00 INFO - Running post-action listener: _start_resource_monitoring 05:05:00 INFO - Starting resource monitoring. 05:05:00 INFO - [mozharness: 2016-08-26 12:05:00.281658Z] Finished create-virtualenv step (success) 05:05:00 INFO - [mozharness: 2016-08-26 12:05:00.282089Z] Running install step. 05:05:00 INFO - Running pre-action listener: _resource_record_pre_action 05:05:00 INFO - Running main action method: install 05:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:00 INFO - Reading from file tmpfile_stdout 05:05:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:00 INFO - Reading from file tmpfile_stdout 05:05:00 INFO - Output received: 05:05:00 INFO - Usage: mozinstall [options] installer 05:05:00 INFO - Options: 05:05:00 INFO - -h, --help show this help message and exit 05:05:00 INFO - -d DEST, --destination=DEST 05:05:00 INFO - Directory to install application into. [default: 05:05:00 INFO - "/builds/slave/test"] 05:05:00 INFO - --app=APP Application being installed. [default: firefox] 05:05:00 INFO - mkdir: /builds/slave/test/build/application 05:05:00 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'] 05:05:00 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 05:05:17 INFO - Reading from file tmpfile_stdout 05:05:17 INFO - Output received: 05:05:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:17 INFO - Running post-action listener: _resource_record_post_action 05:05:17 INFO - [mozharness: 2016-08-26 12:05:17.009830Z] Finished install step (success) 05:05:17 INFO - [mozharness: 2016-08-26 12:05:17.010079Z] Running run-tests step. 05:05:17 INFO - Running pre-action listener: _resource_record_pre_action 05:05:17 INFO - Running main action method: run_tests 05:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:17 INFO - Python 2.7.3 05:05:17 INFO - Return code: 0 05:05:17 INFO - grabbing minidump binary from tooltool 05:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:17 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 0x1e53570>, '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 0x1e54470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:17 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 05:05:17 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 05:05:17 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 05:05:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:17 INFO - Return code: 0 05:05:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:17 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/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:05:17 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/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:05:17 INFO - Using env: {'DISPLAY': ':0', 05:05:17 INFO - 'HOME': '/home/cltbld', 05:05:17 INFO - 'LANG': 'en_US.UTF-8', 05:05:17 INFO - 'LANGUAGE': 'en_US:en', 05:05:17 INFO - 'LOGNAME': 'cltbld', 05:05:17 INFO - 'MAIL': '/var/mail/cltbld', 05:05:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:17 INFO - 'MOZ_NO_REMOTE': '1', 05:05:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:17 INFO - 'NO_EM_RESTART': '1', 05:05:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:17 INFO - 'PWD': '/builds/slave/test', 05:05:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:17 INFO - 'SHELL': '/bin/bash', 05:05:17 INFO - 'SHLVL': '1', 05:05:17 INFO - 'TERM': 'linux', 05:05:17 INFO - 'TMOUT': '86400', 05:05:17 INFO - 'USER': 'cltbld', 05:05:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289', 05:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:17 INFO - '_': '/tools/buildbot/bin/python'} 05:05:17 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/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:05:17 INFO - mozversion application_buildid: 20160826020018 05:05:17 INFO - mozversion application_changeset: 2438f69a60b794a561afd38a2b7780396e06731c 05:05:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:05:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:17 INFO - mozversion application_name: Firefox 05:05:17 INFO - mozversion application_remotingname: firefox-dev 05:05:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:05:17 INFO - mozversion application_vendor: Mozilla 05:05:17 INFO - mozversion application_version: 50.0a2 05:05:17 INFO - mozversion platform_buildid: 20160826020018 05:05:17 INFO - mozversion platform_changeset: 2438f69a60b794a561afd38a2b7780396e06731c 05:05:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:05:17 INFO - mozversion platform_version: 50.0a2 05:05:17 INFO - using testdate: 1472213117 05:05:17 INFO - actual date: 1472213117 05:05:17 INFO - starting webserver on 'localhost:43795' 05:05:17 INFO - SUITE-START | Running 2 tests 05:05:17 INFO - TEST-START | dromaeo_css 05:05:17 INFO - operating with platform_type : linux_ 05:05:17 INFO - Initialising browser for dromaeo_css test... 05:05:17 INFO - TEST-INFO | started process 6759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp204dmr/profile http://localhost:43795/getInfo.html) 05:05:21 INFO - PROCESS | 6759 | __metrics Screen width/height:1600/1200 05:05:21 INFO - PROCESS | 6759 | colorDepth:24 05:05:21 INFO - PROCESS | 6759 | Browser inner width/height: 1024/697 05:05:21 INFO - PROCESS | 6759 | __metrics 05:05:22 ERROR - PROCESS | 6759 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:05:23 INFO - TEST-INFO | 6759: exit 0 05:05:23 INFO - Browser initialized. 05:05:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:23 INFO - TEST-INFO | started process 6886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp204dmr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:35 INFO - PROCESS | 6886 | RSS: Main: 153059328 05:05:35 INFO - PROCESS | 6886 | 05:06:24 INFO - PROCESS | 6886 | 1472213184836 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] 05:08:33 INFO - PROCESS | 6886 | Cycle 1(1): loaded http://localhost:43795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43795/tests/dromaeo/cssquery-ext.html) 05:08:34 INFO - PROCESS | 6886 | RSS: Main: 157675520 05:08:34 INFO - PROCESS | 6886 | 05:11:36 INFO - PROCESS | 6886 | Cycle 1(1): loaded http://localhost:43795/tests/dromaeo/cssquery-ext.html (next: http://localhost:43795/tests/dromaeo/cssquery-jquery.html) 05:11:37 INFO - PROCESS | 6886 | RSS: Main: 154087424 05:11:37 INFO - PROCESS | 6886 | 05:14:38 INFO - PROCESS | 6886 | Cycle 1(1): loaded http://localhost:43795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43795/tests/dromaeo/cssquery-mootools.html) 05:14:39 INFO - PROCESS | 6886 | RSS: Main: 153956352 05:14:39 INFO - PROCESS | 6886 | 05:17:41 INFO - PROCESS | 6886 | Cycle 1(1): loaded http://localhost:43795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43795/tests/dromaeo/cssquery-prototype.html) 05:17:41 INFO - PROCESS | 6886 | RSS: Main: 153477120 05:17:41 INFO - PROCESS | 6886 | 05:20:44 INFO - PROCESS | 6886 | Cycle 1(1): loaded http://localhost:43795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43795/tests/dromaeo/cssquery-yui.html) 05:20:44 INFO - PROCESS | 6886 | RSS: Main: 156065792 05:20:44 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | Cycle 1(1): loaded http://localhost:43795/tests/dromaeo/cssquery-yui.html (next: http://localhost:43795/tests/dromaeo/cssquery-dojo.html) 05:23:47 INFO - PROCESS | 6886 | RSS: Main: 155758592 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | __start_tp_report 05:23:47 INFO - PROCESS | 6886 | _x_x_mozilla_page_load 05:23:47 INFO - PROCESS | 6886 | _x_x_mozilla_page_load_details 05:23:47 INFO - PROCESS | 6886 | |i|pagename|runs| 05:23:47 INFO - PROCESS | 6886 | |0;dojo.html;3320.335932813437;3347.246869454373;3351.6313205547385;3368.9663103368957;3379.915502112447;5710.628809127409;5826.388229235933;5827.1841942128085;5851.414858514152;5864.970675146618;5775.653460792355;5837.8832423351505;5839.240898683165;5849.766009359631;5852.414758524145;5268.894622107565;5284.048871203201;5297.337832770903;5332.520073193412;5348.973255133719;5167.48325167484;5175.404828444721;5188.740562971836;5219.686818790866;5265.236540701596;5213.791448342081;5222.817201397952;5254.238135470355;5254.605904557155;5313.096773548486;5282;5288.92066619001;5298.867528311785;5306.204069389584;5309.840704778863;5018.2974383586325;5057.039162559139;5145.639805213599;5203.479652034766;5230.555402790767;5707.229524014247;5765.769369225226;5769.740361683735;5774.249347584787;5817.825465236049;6153.384661533855;6184;6212.161358216673;6254.186955695731;6269.216347956505;5999.700014999233;6129.570930034899;6157.014877619559;6284.497240220771;6297.653629050446;5813.6221145625395;5828.475437210629;5838.941610583882;5865.0615901455985;5874;6331.176946996953;6378.266499352634;6395.552311338161;6398.9040164397575;6428;5836.8540786479825;5981.192539007266;6035.6076855004285;6132.325444201134;6157.291911430153;6180.783672571439;6195.845103872439;6224.688765561704;6232.065190221412;6233.594816336924;6136.846578835475;6182.887080325495;6184.752609895644;6189.164462797465;6198.2871969723155;5953.255843019622;6101.084837274444;6127.189528148541;6187.319394866561;6193.721282542297;4729.006908549243;4733.077049975291;4757.048590281957;4788;4802.6638135330195;4223.746575205498;4249.213895429355;4260.55264197261;4269.082147338338;4297.527272000078;5657.462541058593;5714.857128571819;5789.102689083199;5913.142594323885;5918.496927761103;6265.279492858289;6305.96847015762;6311.558190926683;6313.084602732578;6318.241810982711;5951.404859514014;5951.791687290924;5954.702264886739;5977.342492325841;5988.071848863433;4981.576565991859;5058.089543882136;5148.510891465305;5275.973620131952;5295;6387.977923532212;6388.329225431356;6396.9360306397275;6402.519811014193;6412.903806442907;6140.478059365004;6192.442680158807;6192.907106393318;6208.4722798562625;6215.9378406217165;6087.330393656783;6232.594881332699;6289.213848268966;6374.872502549831;6384.106225128578;6076.605020673642;6095.481884039729;6095.9390406097145;6104.725287361991;6127.3259941407305;6185.072239164161;6186.173901330612;6200.0389939557635;6222.875542489034;6229.127922091002;5834.27071616048;5928.970355148197;6006.669633170218;6054.152418661303;6055.617907469759;6016.578839481194;6035.547333949883;6050.2437195350585;6055.424734650377;6071.787487437919;5924.674142922181;5946.940530594638;5950.761969521343;5978.551608629283;5985.5810093294795;5850.414958504116;6002.279726432856;6037.0642550404755;6040.879182416239;6048.699529601156;5974;5995.490383317467;6026.789062382971;6028.367021462858;6042.184305118929 05:23:47 INFO - PROCESS | 6886 | |1;ext.html;586.2847326261959;628.4155735166294;630.7855329188076;658.5324419662038;684.6542496039499;43362.78318608407;47398.52601473989;47477;47580;47752;46051;46208.768956155174;46390.07219855601;46592.76703616477;46810.29784553235;9044.186023257922;9255.53722313885;9266.629334826599;9266.629334826632;9272.350935434522;9126.77183070422;9197.908020919805;9199.586018629145;9222.400543964653;9231;9220.953895230514;9245.352825302232;9258.444493330422;9263.21262692672;9316.394434361779;9219.492927888963;9254.953725231364;9258.027907069729;9258.490783006931;9259.398139121004;9230.123138301851;9247.815043699089;9250.90749092514;9279.675211367638;9328.48693321867;45239.54760452386;45402.54597454016;45494.31758523625;45668.314975275396;45695.54304456946;3797.7531460454984;3828.7319887607878;4037.7375470594316;4422.005048864012;4801.18379875422;34456.13859653529;35085;35169.64830351689;35400;35504.64495355039;4601;4602.355670206174;4667.066586682643;4701.811927522895;4775.044991001813;393801;397162;397958;398202;398284;64282;64353.356466434736;64555.677221613594;64674.41302347853;64718.029229561595;39221.80389098093;40200.597994019685;40317.59682403197;67818.32181678219;67907.32092679109;19371.322003730085;19400.805991940182;19448.611027779647;19450.5137371564;19491.610167796563;14548.781768273484;14605.707885842223;14627.488037918622;14679;14721.631959200891;21127.154913803584;21257.255996040065;21382.14471421157;21444.142234310766;21459.78540214609;7551.433642476726;7677.654505547263;7692.461527693008;7696.384289256846;7826;989.7327721515151;1053.083817079146;1056.2447849787286;1130.4573804573686;1141.8458508101467;34793;34862.30275394478;35116.64883351185;35426.46860297098;35432.82283588566;1155.7341811383428;1156.4969238381332;1174.653477224204;1191.3328536019856;1219.1222319929636;18334.266629334943;18342.449726508225;18468.168932398075;18595.721064184047;18657.253709851455;617951;618490;620779;621446;624144.8792756007;65643.34356656468;66487.33512664908;66630.66684666545;66743;66764.6661766688;1434.0965191929017;1443.6102252391795;1457.380613239369;1493.7236611226958;1501.129344979909;29114;30039.54940675848;30440.543391848696;30477.390452191277;30495;56588.43411565832;57107.71446142743;57164.14253786113;57172.42827571671;57219.71390143022;392420;392716;392813;392980;394227;30687.386252275275;30861.691383085883;30968.0709578713;31403.84298078495;31533.8423307882;52742;53010;53155;53306.40080797582;53655.46344536504;44024.55975440333;45511.77244113758;45570.772146139054;46660.766696166305;47120.7643961778;44628.77685611681;45265;45817.312740308254;45962;46692.7665361671;40434;44484.33273500836;44845.32732008957;44993;45826;37177;39242.2151556973;39248;39494;40252.3962140574;30660;30837;30910.22724431907;30972;31175.220619483785 05:23:47 INFO - PROCESS | 6886 | |2;jquery.html;413.7910355270586;414.28742562791984;424.33379594037365;432.84850302394165;435.80388825028723;18897;19929.402117936468;20562.588748225066;20623.896880515615;20706;18934.905325473388;18999.620007599875;19377.612447751035;19444.9027754861;19558.511037224078;5885.176075349444;6114.847128821771;6115.480184184327;6143.293521245047;6152.292486364081;4468.575485328888;6049.213602231704;6092.268927728656;6757.8849489834365;6820.658967051652;6819.352161544645;6858.862822743542;6893.4140598049225;6899.137607799025;6911.17065952084;6709.731610735565;6831.863362732743;6856.41720453762;6864.588124712508;6892.827679308008;5030.597552195815;5208.583313334924;5312.521873031407;6048.576599638027;6077.179580756586;13129.146605470614;13311.267880266581;13329.600111996655;21161;24983;2476.913308034228;2623.7507436793476;2676.745709157627;2685.1810197889636;3069.2480342316053;10649.414282214475;10849.728756781065;11140.164487663376;13679;14585.124892506483;1954.765428148617;1963.7348957890645;1979.1192919150983;1989.1049027937486;2053.2300387354744;80512.59743701303;84280;85764.57117714372;87155;87348.56325718331;10515.42165180907;10547.84178237327;10698.839517407245;10722.678319650424;10879.401632910107;14382.28088595587;14505.057171283834;14514.491992780202;14528.927355363156;14562.27188640585;8440.66237350499;8515.12667213212;8562.74311770648;8712.869306960401;8751.693690720795;8780.517071561126;8786.780330491789;8889.511076890833;8997.775055623662;9022.278217742565;4461.955380446154;4521.480029796616;4633.30500424939;4670.416197975253;5105.566026887756;1605.4541455904814;1650.092449152985;1687.417840844931;2003.1386503803212;2114.2177394364185;472.65496187782423;480.0902290160127;489.87263311539255;496.7913476339946;1040.0275742180934;12717;12968.80546791799;13100.803487947689;13159;13172.47310107604;503.09945198095;512.8692183493185;518.9143791274473;524.114246922707;529.0926061804024;6871.896921546181;6896.172459304916;6904.758333458305;6938.548994315353;6974.546654467444;499423;522001;546138;575818;590665;93438.53280733689;96320;96654;97931.51034244783;100253;506.1521950732582;517.5626595526774;517.7256054291232;519.2211682476286;519.9064168449715;17405.825941740928;18293.81706182921;18441.170147343135;19477.415677529698;19488.220471180994;43493.3475997854;44303.77848110739;44937;45116;45254.54745452635;52431.47568524266;59004.40995589989;59589;60439.093413597955;61411.38588614235;9101.362904596615;9133.497657628628;9307.906920930704;9422.670206543013;9529.809403812023;10100.898991009995;13435.12671676338;13917.72164556683;14026;14490.85509144895;11852.70368240801;12298.631041068782;12302.81545776832;12364.134510584532;12723.872761272269;12317;12401.317927514074;12440.626781196579;12487.562935297221;12729.681757956125;12456.626301210978;12585.181963172365;12653.481582210194;12830.67923301925;12948.546800861925;7460.104787425544;7807.882881756892;7918.129005809472;8206.138355472589;8595.312375009858;11975.28148311104;12060.276383417024;12433.12968092261;12806.551770687982;12824.615261542169 05:23:47 INFO - PROCESS | 6886 | |3;mootools.html;1516.2721893491123;1558.0495897502526;1725.3012529925377;1852.8980906050178;1871.279557370413;8206.794830129234;8982.640694372225;9201.21789647879;9698.369605975615;9733.51332433379;9256.490893000899;9679.370840895355;9686.709398718032;9687.951560242189;9697.030296970317;2473.789727873133;2533.961990570134;2540.479201763634;2546.2997675639162;2548.4775620997743;2478.6653801736716;2556.6292887531295;2565.089393265392;2578.664773579432;2579.432524844531;2529.4435224250637;2537.0612873236837;2540.5554028045017;2569.396191894903;2574.214864466337;2462.741412151725;2472.4066224106173;2495.1765917247358;2521.1932181701864;2537.695476542808;2456.6192240202795;2461.064795377763;2462.9261122166363;2468.7160976487753;2504.4239824840206;9546.331756777028;9589.90410095904;9602.135807777333;9653.420794752337;9660.468674222915;5724.284464441945;5894.145348924382;5898.557608179403;5900.409959004108;5902.055671092648;3382.543356646846;3497.1431999160113;3514.6836784689244;3563.1626567756557;3590.838412271428;1092.885355930192;1098.9340639561572;1101.9008289253925;1110.5113749949996;1116.7654792493586;13602.863971360259;13645.522406715718;13647.317634118353;13684.52104176349;13688.384022719001;4844.927326090112;4990.326305948723;5065.341505604248;5109.795608175706;5187.610929180327;11326.377049262204;11386.08911287095;11396;11419.942900285445;11460.598879039193;5824.184614153937;5842.415758424124;5842.970785146047;5865.266841644794;5867.794627188028;4636.884077898079;5156.845294641167;5273.446288139767;5285.656432331886;5339.0389729849;4265.893352666146;4318.719283246579;4380;4380.233459144701;4433.911321773547;1392.9622431288756;1403.6911879386519;1431.141315210886;1432.2337549411016;1442.61049516632;1016.3850870223556;1112.933224006562;1126.571902676994;1131.3042478875432;1131.9037881779975;6565.573237739532;6701.6314102723845;6720;6836.111305530249;6839.350261725128;468.4682884925634;476.39973633221695;482.39700374531833;487.24477060556706;488.46757034831495;4660.254359302563;4694.6244300456565;4731.313959475857;4769.260764581495;4776;11204.215704900578;11474.713132171595;11620.6513804586;12057.638270851889;12097.516099355928;11237.83143252852;11671.941640291745;11702.531898724126;11719.355435451133;11746.882531174579;8738.737837864874;9001.639934402681;9023.142801433853;9033.05152958943;9036.141566551167;6560.9343906562235;6575.210974683068;6588.670566471753;6597.60414375139;6804.795856124324;10818.729531761768;11151;11265.155113366367;11420.600278990196;11492.482838272465;10952.945235273774;11197.040517909496;11198.720031998939;11250.268732532359;11405.771884562428;7962.522248665098;8873.689420870238;9012.774680633036;9099.090090991112;9237.445753254826;9436.622535098793;9498.050194980447;9512.09635084666;9521.047895210424;9527.761805954906;8247.298979586802;8531.573421329032;8544.829103418022;8574.571271436527;8681.565921704016;7950.3639708822;7998.800029999296;8042.517448953082;8050.074241462306;8108.635111420118;7417.517861338995;7623.161452240138;7627;7631.580263085361;7806.41451891099;5668.492959292643;5854.268216472941;5909.320428150646;5924.200232968494;5994.880102398015;5998.25021872266;5998.7300571473515;6017.578769486269;6047.365026672136;6107.144999699956 05:23:47 INFO - PROCESS | 6886 | |4;prototype.html;340.80403767833496;345.2094703129833;349.81984278096786;352.5404824028524;361.95656521217455;5737.909797138546;5756.510696590784;5819.709014549271;5844.883102337951;5856.443637854402;5676.707509644407;5677.602567820254;5697.943020569793;5698.259226300585;5703.775527544261;4062.8014735652905;4401.679496151158;4445.355423463596;4478.261086920655;4499.820007199724;4466.419365482483;4478.97760511197;4490.57339552742;4510;4514.329698011724;4427.579379958899;4464.660601819457;4469.7541635210055;4490.775461226942;4500.437445319335;4310.633596144316;4392.86821395357;4417.977910110461;4433.756143412111;4437.7781110944325;3890.8832735017995;3891.2606604745292;3897.5907529709257;3900.980495097535;3904.902377440558;5604.635698679573;5623.971880140614;5639.71801409932;5652.547796176337;5654.773809047633;5035.546800787946;5057;5114.105031619489;5122.257272695439;5159.793608255665;5934.821955341346;5955.791547295824;5966.164736936832;5990.700464976778;5996.310424301174;4216.156768646252;4303.376010478463;4338.327559228324;4346.348047792856;4359.367891655692;6157.230346206724;6198.81403557894;6213.850437669001;6219.440250377443;6221.782237621662;4407.845725399596;4444.266695995189;4447.444069491314;4449.310356894686;4456.17560751262;4324.329728892027;4482.843100491467;4490.281554951257;4502.324651302265;4529.365888775574;5049.6465247432325;5065.341505604248;5123.974380128076;5132.769025393866;5146.897062058738;6021.2473440819895;6074.726637301332;6085.36103709113;6107.572469927151;6150.7232174552255;1441.322578388177;1541.368039103962;1559.337281655292;1561.8203906550664;1584.9207539622973;966.6713317472094;976.272676855747;1013.807376598444;1033.607229252879;1043.2123746571442;5729.656220626775;5766.106253530709;5788.594798364074;5829.329627092939;5882.735276912549;6114.48026917717;6167.273163514224;6188.783392581238;6203.96898015516;6226.62640241587;5644.943550564524;5766.3368712598585;5768.192453056576;5785.190073389729;5786.94213057864;3258.951115733266;3318.386098571724;3322.0532148338093;3343.9331213375594;3346.548215990859;6074.969625151846;6274.372562743781;6370;6373.745050198033;6466.547341686037;6249;6299.96850015747;6337.397947195009;6338.556301058974;6346.174997250328;6254.405831446005;6407.519436042316;6431.196100487346;6431.456450451858;6461.578452740389;6153.861535615925;6160.784372546939;6165.969170154121;6171.3828617139725;6180;6078.817635470943;6094.268687757498;6098.634081955097;6098.939010609837;6119.84700382494;6109.816705498843;6238.500919926304;6303.495720342454;6342.746290148342;6366.808995730135;4354.716943398669;4404.383386325853;4412.294032954712;4431.518349724165;4432.711873728197;5891.440313170242;6075.301340345917;6185.907211391743;6265.091561723616;6282.246130464374;5923.851903702442;5981.641101533922;5985.670788106696;5991.430814072656;5994.550408719277;5947.910781338197;6023.951856368855;6048.818535443944;6054.788082417094;6095;5751.434110851299;5886.676232807236;5997.280326360865;6004.189434426471;6049.243844519435;6129.448349648553;6143.447089761943;6159.860425821237;6165.784197553064;6169.876602467836;5787.160861675117;5962.032529265245;6003.8198854034445;6011.519078473624;6031.668258245839 05:23:47 INFO - PROCESS | 6886 | |5;yui.html;805.7341077444444;858.8196478739468;877.8990416102147;918.3855436010225;923.4459324405353;16542.421015264466;17961.461156165304;18098.27606895726;18112.4566263012;18115.818841811593;15239.771403428957;15301.158436286;15432.305546250418;15464.304106315214;15488.070715757063;849.6983570832358;861.5261606116626;880.4365206267994;900.3157600223844;906.4651855405309;906.7914379692675;907.3648446087765;908.0465511213233;908.0510866144895;909.2089881802841;945.4658118163215;946.5125460387906;950.235060776075;950.3775027357058;952.4285428742768;940.0834186668012;945.9101385368414;947.924166066713;948.5778828421355;949.2832911152105;687.9759208427681;688.2944981394061;691.4122995453874;692.705600119952;694.4617921111129;15946.28241729125;15999.52001439947;16093.839061609468;16104;16148.192590370434;15873;16335.591610209722;16487.69172315877;16580.502584922473;16886.915565422216;13392.531261405804;13462.730745385037;13534.59396218115;13588.59234222975;13643.727125457435;4183.569225275995;4207.768572728499;4214.957850421487;4220.134872351191;4285.550017248175;72337.6383118081;75124.62437687776;89440.55279723625;90024.54987725084;90124;12872.613821585368;12900.161489503153;13066.803997940038;13067.281299528428;13275.867241327656;23054.769452305598;23179.3046208614;23266.53466930652;23327;23347.182848600216;9331.953340233254;9341.346105772667;9377.718668439958;9463.006384329685;9732.854007189897;5200.92198617021;5256.316678831728;5258.973705131526;5289.920651190158;5328.120860058047;3932.9606703932595;4083.3262511685834;4086.652634526039;4087.6321131097748;4089.8364065437645;684.1482354468718;691.920429150644;693.8681650486392;707.2043950555625;709.4820780830023;717.1179449277314;777.1878387085509;811.1320886651226;811.5333683132104;848.804774901776;10491.16070714341;10993.780124397466;11347.489362978686;11401.201915865975;11540.24988375753;729.919708832028;740.5334639177391;795.7572940253278;820.729159377404;845.3701992015865;5063.367079115111;5273.604479664041;5363.704996225167;5452.890942181134;5471.972640136853;106477;136855;138656;138714;144593;114885.4255728716;119896;120817;121727;124321;59901.40098598958;61121.38878611157;78744.99999999885;81488.59255703684;85225;10462.843057354297;10776.568937242422;11042.841344699455;11278.887211127783;11318.207725459139;57715.422845772686;59091.70454147702;59250.407495926214;60941.69529152326;60967.69516152391;87600.56199718961;92200;92664;93439.53280233828;93813;14976.850231497981;15075.24623768829;15291.694166116838;15418.691626167638;16092.517224483285;17014.404495842587;17122.914385428492;17303;17476.388326408516;17839.375621853174;15873.603159921095;15973.520794376187;16468.01191928488;16511.752323715395;16685.16574171311;15524;15694.372225111325;16033.851784080549;16237.837621623632;16698.833011670213;13435.798463023259;15490.148041857807;16000.599985000468;16031.038137711774;16101.838981610033;12850.35748212567;13159.210447373189;13216.405261763435;13318.267495287851;13331.533396331082;11840.940795296314;12335.938320308342;13043.673908152372;13372.197668139943;13452.260125693181 05:23:47 INFO - PROCESS | 6886 | __end_tp_report 05:23:47 INFO - PROCESS | 6886 | __start_cc_report 05:23:47 INFO - PROCESS | 6886 | _x_x_mozilla_cycle_collect,335 05:23:47 INFO - PROCESS | 6886 | __end_cc_report 05:23:47 INFO - PROCESS | 6886 | __startTimestamp1472214227596__endTimestamp 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | ------- Summary: start ------- 05:23:47 INFO - PROCESS | 6886 | Number of tests: 6 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | [#0] dojo.html Cycles:165 Average:5742.52 Median:5977.34 stddev:654.36 (10.9%) stddev-sans-first:628.18 05:23:47 INFO - PROCESS | 6886 | Values: 3320.3 3347.2 3351.6 3369.0 3379.9 5710.6 5826.4 5827.2 5851.4 5865.0 5775.7 5837.9 5839.2 5849.8 5852.4 5268.9 5284.0 5297.3 5332.5 5349.0 5167.5 5175.4 5188.7 5219.7 5265.2 5213.8 5222.8 5254.2 5254.6 5313.1 5282.0 5288.9 5298.9 5306.2 5309.8 5018.3 5057.0 5145.6 5203.5 5230.6 5707.2 5765.8 5769.7 5774.2 5817.8 6153.4 6184.0 6212.2 6254.2 6269.2 5999.7 6129.6 6157.0 6284.5 6297.7 5813.6 5828.5 5838.9 5865.1 5874.0 6331.2 6378.3 6395.6 6398.9 6428.0 5836.9 5981.2 6035.6 6132.3 6157.3 6180.8 6195.8 6224.7 6232.1 6233.6 6136.8 6182.9 6184.8 6189.2 6198.3 5953.3 6101.1 6127.2 6187.3 6193.7 4729.0 4733.1 4757.0 4788.0 4802.7 4223.7 4249.2 4260.6 4269.1 4297.5 5657.5 5714.9 5789.1 5913.1 5918.5 6265.3 6306.0 6311.6 6313.1 6318.2 5951.4 5951.8 5954.7 5977.3 5988.1 4981.6 5058.1 5148.5 5276.0 5295.0 6388.0 6388.3 6396.9 6402.5 6412.9 6140.5 6192.4 6192.9 6208.5 6215.9 6087.3 6232.6 6289.2 6374.9 6384.1 6076.6 6095.5 6095.9 6104.7 6127.3 6185.1 6186.2 6200.0 6222.9 6229.1 5834.3 5929.0 6006.7 6054.2 6055.6 6016.6 6035.5 6050.2 6055.4 6071.8 5924.7 5946.9 5950.8 5978.6 5985.6 5850.4 6002.3 6037.1 6040.9 6048.7 5974.0 5995.5 6026.8 6028.4 6042.2 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | [#1] ext.html Cycles:180 Average:64432.58 Median:45448.43 stddev:127999.53 (281.6%) stddev-sans-first:128268.84 05:23:47 INFO - PROCESS | 6886 | Values: 586.3 628.4 630.8 658.5 684.7 43362.8 47398.5 47477.0 47580.0 47752.0 46051.0 46208.8 46390.1 46592.8 46810.3 9044.2 9255.5 9266.6 9266.6 9272.4 9126.8 9197.9 9199.6 9222.4 9231.0 9221.0 9245.4 9258.4 9263.2 9316.4 9219.5 9255.0 9258.0 9258.5 9259.4 9230.1 9247.8 9250.9 9279.7 9328.5 45239.5 45402.5 45494.3 45668.3 45695.5 3797.8 3828.7 4037.7 4422.0 4801.2 34456.1 35085.0 35169.6 35400.0 35504.6 4601.0 4602.4 4667.1 4701.8 4775.0 393801.0 397162.0 397958.0 398202.0 398284.0 64282.0 64353.4 64555.7 64674.4 64718.0 39221.8 40200.6 40317.6 67818.3 67907.3 19371.3 19400.8 19448.6 19450.5 19491.6 14548.8 14605.7 14627.5 14679.0 14721.6 21127.2 21257.3 21382.1 21444.1 21459.8 7551.4 7677.7 7692.5 7696.4 7826.0 989.7 1053.1 1056.2 1130.5 1141.8 34793.0 34862.3 35116.6 35426.5 35432.8 1155.7 1156.5 1174.7 1191.3 1219.1 18334.3 18342.4 18468.2 18595.7 18657.3 617951.0 618490.0 620779.0 621446.0 624144.9 65643.3 66487.3 66630.7 66743.0 66764.7 1434.1 1443.6 1457.4 1493.7 1501.1 29114.0 30039.5 30440.5 30477.4 30495.0 56588.4 57107.7 57164.1 57172.4 57219.7 392420.0 392716.0 392813.0 392980.0 394227.0 30687.4 30861.7 30968.1 31403.8 31533.8 52742.0 53010.0 53155.0 53306.4 53655.5 44024.6 45511.8 45570.8 46660.8 47120.8 44628.8 45265.0 45817.3 45962.0 46692.8 40434.0 44484.3 44845.3 44993.0 45826.0 37177.0 39242.2 39248.0 39494.0 40252.4 30660.0 30837.0 30910.2 30972.0 31175.2 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | [#2] jquery.html Cycles:180 Average:30747.87 Median:24702.79 stddev:90255.84 (365.4%) stddev-sans-first:90480.29 05:23:47 INFO - PROCESS | 6886 | Values: 413.8 414.3 424.3 432.8 435.8 18897.0 19929.4 20562.6 20623.9 20706.0 18934.9 18999.6 19377.6 19444.9 19558.5 5885.2 6114.8 6115.5 6143.3 6152.3 4468.6 6049.2 6092.3 6757.9 6820.7 6819.4 6858.9 6893.4 6899.1 6911.2 6709.7 6831.9 6856.4 6864.6 6892.8 5030.6 5208.6 5312.5 6048.6 6077.2 13129.1 13311.3 13329.6 21161.0 24983.0 2476.9 2623.8 2676.7 2685.2 3069.2 10649.4 10849.7 11140.2 13679.0 14585.1 1954.8 1963.7 1979.1 1989.1 2053.2 80512.6 84280.0 85764.6 87155.0 87348.6 10515.4 10547.8 10698.8 10722.7 10879.4 14382.3 14505.1 14514.5 14528.9 14562.3 8440.7 8515.1 8562.7 8712.9 8751.7 8780.5 8786.8 8889.5 8997.8 9022.3 4462.0 4521.5 4633.3 4670.4 5105.6 1605.5 1650.1 1687.4 2003.1 2114.2 472.7 480.1 489.9 496.8 1040.0 12717.0 12968.8 13100.8 13159.0 13172.5 503.1 512.9 518.9 524.1 529.1 6871.9 6896.2 6904.8 6938.5 6974.5 499423.0 522001.0 546138.0 575818.0 590665.0 93438.5 96320.0 96654.0 97931.5 100253.0 506.2 517.6 517.7 519.2 519.9 17405.8 18293.8 18441.2 19477.4 19488.2 43493.3 44303.8 44937.0 45116.0 45254.5 52431.5 59004.4 59589.0 60439.1 61411.4 9101.4 9133.5 9307.9 9422.7 9529.8 10100.9 13435.1 13917.7 14026.0 14490.9 11852.7 12298.6 12302.8 12364.1 12723.9 12317.0 12401.3 12440.6 12487.6 12729.7 12456.6 12585.2 12653.5 12830.7 12948.5 7460.1 7807.9 7918.1 8206.1 8595.3 11975.3 12060.3 12433.1 12806.6 12824.6 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | [#3] mootools.html Cycles:180 Average:6355.34 Median:2622.83 stddev:3631.97 (138.5%) stddev-sans-first:3623.95 05:23:47 INFO - PROCESS | 6886 | Values: 1516.3 1558.0 1725.3 1852.9 1871.3 8206.8 8982.6 9201.2 9698.4 9733.5 9256.5 9679.4 9686.7 9688.0 9697.0 2473.8 2534.0 2540.5 2546.3 2548.5 2478.7 2556.6 2565.1 2578.7 2579.4 2529.4 2537.1 2540.6 2569.4 2574.2 2462.7 2472.4 2495.2 2521.2 2537.7 2456.6 2461.1 2462.9 2468.7 2504.4 9546.3 9589.9 9602.1 9653.4 9660.5 5724.3 5894.1 5898.6 5900.4 5902.1 3382.5 3497.1 3514.7 3563.2 3590.8 1092.9 1098.9 1101.9 1110.5 1116.8 13602.9 13645.5 13647.3 13684.5 13688.4 4844.9 4990.3 5065.3 5109.8 5187.6 11326.4 11386.1 11396.0 11419.9 11460.6 5824.2 5842.4 5843.0 5865.3 5867.8 4636.9 5156.8 5273.4 5285.7 5339.0 4265.9 4318.7 4380.0 4380.2 4433.9 1393.0 1403.7 1431.1 1432.2 1442.6 1016.4 1112.9 1126.6 1131.3 1131.9 6565.6 6701.6 6720.0 6836.1 6839.4 468.5 476.4 482.4 487.2 488.5 4660.3 4694.6 4731.3 4769.3 4776.0 11204.2 11474.7 11620.7 12057.6 12097.5 11237.8 11671.9 11702.5 11719.4 11746.9 8738.7 9001.6 9023.1 9033.1 9036.1 6560.9 6575.2 6588.7 6597.6 6804.8 10818.7 11151.0 11265.2 11420.6 11492.5 10952.9 11197.0 11198.7 11250.3 11405.8 7962.5 8873.7 9012.8 9099.1 9237.4 9436.6 9498.1 9512.1 9521.0 9527.8 8247.3 8531.6 8544.8 8574.6 8681.6 7950.4 7998.8 8042.5 8050.1 8108.6 7417.5 7623.2 7627.0 7631.6 7806.4 5668.5 5854.3 5909.3 5924.2 5994.9 5998.3 5998.7 6017.6 6047.4 6107.1 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | [#4] prototype.html Cycles:180 Average:5070.97 Median:5776.69 stddev:1494.95 (25.9%) stddev-sans-first:1456.38 05:23:47 INFO - PROCESS | 6886 | Values: 340.8 345.2 349.8 352.5 362.0 5737.9 5756.5 5819.7 5844.9 5856.4 5676.7 5677.6 5697.9 5698.3 5703.8 4062.8 4401.7 4445.4 4478.3 4499.8 4466.4 4479.0 4490.6 4510.0 4514.3 4427.6 4464.7 4469.8 4490.8 4500.4 4310.6 4392.9 4418.0 4433.8 4437.8 3890.9 3891.3 3897.6 3901.0 3904.9 5604.6 5624.0 5639.7 5652.5 5654.8 5035.5 5057.0 5114.1 5122.3 5159.8 5934.8 5955.8 5966.2 5990.7 5996.3 4216.2 4303.4 4338.3 4346.3 4359.4 6157.2 6198.8 6213.9 6219.4 6221.8 4407.8 4444.3 4447.4 4449.3 4456.2 4324.3 4482.8 4490.3 4502.3 4529.4 5049.6 5065.3 5124.0 5132.8 5146.9 6021.2 6074.7 6085.4 6107.6 6150.7 1441.3 1541.4 1559.3 1561.8 1584.9 966.7 976.3 1013.8 1033.6 1043.2 5729.7 5766.1 5788.6 5829.3 5882.7 6114.5 6167.3 6188.8 6204.0 6226.6 5644.9 5766.3 5768.2 5785.2 5786.9 3259.0 3318.4 3322.1 3343.9 3346.5 6075.0 6274.4 6370.0 6373.7 6466.5 6249.0 6300.0 6337.4 6338.6 6346.2 6254.4 6407.5 6431.2 6431.5 6461.6 6153.9 6160.8 6166.0 6171.4 6180.0 6078.8 6094.3 6098.6 6098.9 6119.8 6109.8 6238.5 6303.5 6342.7 6366.8 4354.7 4404.4 4412.3 4431.5 4432.7 5891.4 6075.3 6185.9 6265.1 6282.2 5923.9 5981.6 5985.7 5991.4 5994.6 5947.9 6024.0 6048.8 6054.8 6095.0 5751.4 5886.7 5997.3 6004.2 6049.2 6129.4 6143.4 6159.9 6165.8 6169.9 5787.2 5962.0 6003.8 6011.5 6031.7 05:23:47 INFO - PROCESS | 6886 | 05:23:47 INFO - PROCESS | 6886 | [#5] yui.html Cycles:180 Average:23375.18 Median:4008.14 stddev:33951.37 (847.1%) stddev-sans-first:34004.32 05:23:47 INFO - PROCESS | 6886 | Values: 805.7 858.8 877.9 918.4 923.4 16542.4 17961.5 18098.3 18112.5 18115.8 15239.8 15301.2 15432.3 15464.3 15488.1 849.7 861.5 880.4 900.3 906.5 906.8 907.4 908.0 908.1 909.2 945.5 946.5 950.2 950.4 952.4 940.1 945.9 947.9 948.6 949.3 688.0 688.3 691.4 692.7 694.5 15946.3 15999.5 16093.8 16104.0 16148.2 15873.0 16335.6 16487.7 16580.5 16886.9 13392.5 13462.7 13534.6 13588.6 13643.7 4183.6 4207.8 4215.0 4220.1 4285.6 72337.6 75124.6 89440.6 90024.5 90124.0 12872.6 12900.2 13066.8 13067.3 13275.9 23054.8 23179.3 23266.5 23327.0 23347.2 9332.0 9341.3 9377.7 9463.0 9732.9 5200.9 5256.3 5259.0 5289.9 5328.1 3933.0 4083.3 4086.7 4087.6 4089.8 684.1 691.9 693.9 707.2 709.5 717.1 777.2 811.1 811.5 848.8 10491.2 10993.8 11347.5 11401.2 11540.2 729.9 740.5 795.8 820.7 845.4 5063.4 5273.6 5363.7 5452.9 5472.0 106477.0 136855.0 138656.0 138714.0 144593.0 114885.4 119896.0 120817.0 121727.0 124321.0 59901.4 61121.4 78745.0 81488.6 85225.0 10462.8 10776.6 11042.8 11278.9 11318.2 57715.4 59091.7 59250.4 60941.7 60967.7 87600.6 92200.0 92664.0 93439.5 93813.0 14976.9 15075.2 15291.7 15418.7 16092.5 17014.4 17122.9 17303.0 17476.4 17839.4 15873.6 15973.5 16468.0 16511.8 16685.2 15524.0 15694.4 16033.9 16237.8 16698.8 13435.8 15490.1 16000.6 16031.0 16101.8 12850.4 13159.2 13216.4 13318.3 13331.5 11840.9 12335.9 13043.7 13372.2 13452.3 05:23:47 INFO - PROCESS | 6886 | -------- Summary: end -------- 05:23:47 INFO - PROCESS | 6886 | 05:23:48 INFO - TEST-INFO | 6886: exit 0 05:23:48 INFO - TEST-OK | dromaeo_css | took 1111073ms 05:23:48 INFO - TEST-START | kraken 05:23:48 INFO - operating with platform_type : linux_ 05:23:48 INFO - Initialising browser for kraken test... 05:23:48 INFO - TEST-INFO | started process 7158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3OpZ9Y/profile http://localhost:43795/getInfo.html) 05:23:52 INFO - PROCESS | 7158 | __metrics Screen width/height:1600/1200 05:23:52 INFO - PROCESS | 7158 | colorDepth:24 05:23:52 INFO - PROCESS | 7158 | Browser inner width/height: 1024/697 05:23:52 INFO - PROCESS | 7158 | __metrics 05:23:53 ERROR - PROCESS | 7158 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:23:54 INFO - TEST-INFO | 7158: exit 0 05:23:54 INFO - Browser initialized. 05:23:54 INFO - Running cycle 1/1 for kraken test... 05:23:54 INFO - TEST-INFO | started process 7284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3OpZ9Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:06 INFO - PROCESS | 7284 | RSS: Main: 152907776 05:24:06 INFO - PROCESS | 7284 | 05:24:08 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43795/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:09 INFO - PROCESS | 7284 | RSS: Main: 158183424 05:24:09 INFO - PROCESS | 7284 | 05:24:12 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43795/tests/kraken/driver.html?testName=audio-dft) 05:24:12 INFO - PROCESS | 7284 | RSS: Main: 156733440 05:24:12 INFO - PROCESS | 7284 | 05:24:15 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43795/tests/kraken/driver.html?testName=audio-fft) 05:24:16 INFO - PROCESS | 7284 | RSS: Main: 157229056 05:24:16 INFO - PROCESS | 7284 | 05:24:18 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43795/tests/kraken/driver.html?testName=audio-oscillator) 05:24:19 INFO - PROCESS | 7284 | RSS: Main: 157229056 05:24:19 INFO - PROCESS | 7284 | 05:24:21 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:21 INFO - PROCESS | 7284 | RSS: Main: 156786688 05:24:21 INFO - PROCESS | 7284 | 05:24:24 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43795/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:25 INFO - PROCESS | 7284 | RSS: Main: 156467200 05:24:25 INFO - PROCESS | 7284 | 05:24:29 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43795/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:29 INFO - PROCESS | 7284 | RSS: Main: 156364800 05:24:29 INFO - PROCESS | 7284 | 05:24:32 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43795/tests/kraken/driver.html?testName=json-parse-financial) 05:24:33 INFO - PROCESS | 7284 | RSS: Main: 157511680 05:24:33 INFO - PROCESS | 7284 | 05:24:34 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:35 INFO - PROCESS | 7284 | RSS: Main: 157024256 05:24:35 INFO - PROCESS | 7284 | 05:24:36 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:37 INFO - PROCESS | 7284 | RSS: Main: 156635136 05:24:37 INFO - PROCESS | 7284 | 05:24:39 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:40 INFO - PROCESS | 7284 | RSS: Main: 157163520 05:24:40 INFO - PROCESS | 7284 | 05:24:42 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:43 INFO - PROCESS | 7284 | RSS: Main: 157634560 05:24:43 INFO - PROCESS | 7284 | 05:24:46 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:46 INFO - PROCESS | 7284 | RSS: Main: 158064640 05:24:46 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:43795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43795/tests/kraken/driver.html?testName=ai-astar) 05:24:48 INFO - PROCESS | 7284 | RSS: Main: 158961664 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | __start_tp_report 05:24:48 INFO - PROCESS | 7284 | _x_x_mozilla_page_load 05:24:48 INFO - PROCESS | 7284 | _x_x_mozilla_page_load_details 05:24:48 INFO - PROCESS | 7284 | |i|pagename|runs| 05:24:48 INFO - PROCESS | 7284 | |0;ai-astar;105;114;105;112;113;112;112;111;112;110 05:24:48 INFO - PROCESS | 7284 | |1;audio-beat-detection;144;117;145;178;117;154;138;120;175;115 05:24:48 INFO - PROCESS | 7284 | |2;audio-dft;163;164;163;164;164;161;163;163;162;162 05:24:48 INFO - PROCESS | 7284 | |3;audio-fft;75;75;75;167;75;81;76;76;164;79 05:24:48 INFO - PROCESS | 7284 | |4;audio-oscillator;83;84;143;85;85;83;142;83;83;154 05:24:48 INFO - PROCESS | 7284 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;117 05:24:48 INFO - PROCESS | 7284 | |6;imaging-darkroom;147;147;147;148;152;147;150;147;147;147 05:24:48 INFO - PROCESS | 7284 | |7;imaging-desaturate;95;95;96;96;95;96;96;95;95;95 05:24:48 INFO - PROCESS | 7284 | |8;json-parse-financial;51;51;63;52;51;51;56;54;50;54 05:24:48 INFO - PROCESS | 7284 | |9;json-stringify-tinderbox;60;59;59;60;59;60;60;59;59;61 05:24:48 INFO - PROCESS | 7284 | |10;stanford-crypto-aes;73;73;73;81;76;77;73;80;74;77 05:24:48 INFO - PROCESS | 7284 | |11;stanford-crypto-ccm;130;118;131;117;123;121;127;127;154;128 05:24:48 INFO - PROCESS | 7284 | |12;stanford-crypto-pbkdf2;158;154;160;156;152;154;155;155;154;152 05:24:48 INFO - PROCESS | 7284 | |13;stanford-crypto-sha256-iterative;64;63;63;65;67;61;62;62;63;67 05:24:48 INFO - PROCESS | 7284 | __end_tp_report 05:24:48 INFO - PROCESS | 7284 | __start_cc_report 05:24:48 INFO - PROCESS | 7284 | _x_x_mozilla_cycle_collect,803 05:24:48 INFO - PROCESS | 7284 | __end_cc_report 05:24:48 INFO - PROCESS | 7284 | __startTimestamp1472214288677__endTimestamp 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | ------- Summary: start ------- 05:24:48 INFO - PROCESS | 7284 | Number of tests: 14 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.13 (2.8%) stddev-sans-first:2.59 05:24:48 INFO - PROCESS | 7284 | Values: 105.0 114.0 105.0 112.0 113.0 112.0 112.0 111.0 112.0 110.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:144.50 stddev:23.55 (16.3%) stddev-sans-first:24.94 05:24:48 INFO - PROCESS | 7284 | Values: 144.0 117.0 145.0 178.0 117.0 154.0 138.0 120.0 175.0 115.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 05:24:48 INFO - PROCESS | 7284 | Values: 163.0 164.0 163.0 164.0 164.0 161.0 163.0 163.0 162.0 162.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:37.59 (49.8%) stddev-sans-first:39.21 05:24:48 INFO - PROCESS | 7284 | Values: 75.0 75.0 75.0 167.0 75.0 81.0 76.0 76.0 164.0 79.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:83.00 stddev:30.42 (36.7%) stddev-sans-first:31.44 05:24:48 INFO - PROCESS | 7284 | Values: 83.0 84.0 143.0 85.0 85.0 83.0 142.0 83.0 83.0 154.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:24:48 INFO - PROCESS | 7284 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.00 stddev:1.73 (1.2%) stddev-sans-first:1.80 05:24:48 INFO - PROCESS | 7284 | Values: 147.0 147.0 147.0 148.0 152.0 147.0 150.0 147.0 147.0 147.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:24:48 INFO - PROCESS | 7284 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:3.89 (7.3%) stddev-sans-first:4.03 05:24:48 INFO - PROCESS | 7284 | Values: 51.0 51.0 63.0 52.0 51.0 51.0 56.0 54.0 50.0 54.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 05:24:48 INFO - PROCESS | 7284 | Values: 60.0 59.0 59.0 60.0 59.0 60.0 60.0 59.0 59.0 61.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.50 stddev:3.02 (3.9%) stddev-sans-first:3.04 05:24:48 INFO - PROCESS | 7284 | Values: 73.0 73.0 73.0 81.0 76.0 77.0 73.0 80.0 74.0 77.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:10.46 (8.2%) stddev-sans-first:11.06 05:24:48 INFO - PROCESS | 7284 | Values: 130.0 118.0 131.0 117.0 123.0 121.0 127.0 127.0 154.0 128.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.00 stddev:2.49 (1.6%) stddev-sans-first:2.40 05:24:48 INFO - PROCESS | 7284 | Values: 158.0 154.0 160.0 156.0 152.0 154.0 155.0 155.0 154.0 152.0 05:24:48 INFO - PROCESS | 7284 | 05:24:48 INFO - PROCESS | 7284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.06 (3.2%) stddev-sans-first:2.18 05:24:48 INFO - PROCESS | 7284 | Values: 64.0 63.0 63.0 65.0 67.0 61.0 62.0 62.0 63.0 67.0 05:24:48 INFO - PROCESS | 7284 | -------- Summary: end -------- 05:24:48 INFO - PROCESS | 7284 | 05:24:49 INFO - TEST-INFO | 7284: exit 0 05:24:49 INFO - TEST-OK | kraken | took 61270ms 05:24:49 INFO - SUITE-END | took 1172s 05:24:49 INFO - Completed test suite (00:19:32) 05:24:49 INFO - javascript benchmark 05:24:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7725.816177138752, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.335932813437, 3347.246869454373, 3351.6313205547385, 3368.9663103368957, 3379.915502112447, 5710.628809127409, 5826.388229235933, 5827.1841942128085, 5851.414858514152, 5864.970675146618, 5775.653460792355, 5837.8832423351505, 5839.240898683165, 5849.766009359631, 5852.414758524145, 5268.894622107565, 5284.048871203201, 5297.337832770903, 5332.520073193412, 5348.973255133719, 5167.48325167484, 5175.404828444721, 5188.740562971836, 5219.686818790866, 5265.236540701596, 5213.791448342081, 5222.817201397952, 5254.238135470355, 5254.605904557155, 5313.096773548486, 5282.0, 5288.92066619001, 5298.867528311785, 5306.204069389584, 5309.840704778863, 5018.2974383586325, 5057.039162559139, 5145.639805213599, 5203.479652034766, 5230.555402790767, 5707.229524014247, 5765.769369225226, 5769.740361683735, 5774.249347584787, 5817.825465236049, 6153.384661533855, 6184.0, 6212.161358216673, 6254.186955695731, 6269.216347956505, 5999.700014999233, 6129.570930034899, 6157.014877619559, 6284.497240220771, 6297.653629050446, 5813.6221145625395, 5828.475437210629, 5838.941610583882, 5865.0615901455985, 5874.0, 6331.176946996953, 6378.266499352634, 6395.552311338161, 6398.9040164397575, 6428.0, 5836.8540786479825, 5981.192539007266, 6035.6076855004285, 6132.325444201134, 6157.291911430153, 6180.783672571439, 6195.845103872439, 6224.688765561704, 6232.065190221412, 6233.594816336924, 6136.846578835475, 6182.887080325495, 6184.752609895644, 6189.164462797465, 6198.2871969723155, 5953.255843019622, 6101.084837274444, 6127.189528148541, 6187.319394866561, 6193.721282542297, 4729.006908549243, 4733.077049975291, 4757.048590281957, 4788.0, 4802.6638135330195, 4223.746575205498, 4249.213895429355, 4260.55264197261, 4269.082147338338, 4297.527272000078, 5657.462541058593, 5714.857128571819, 5789.102689083199, 5913.142594323885, 5918.496927761103, 6265.279492858289, 6305.96847015762, 6311.558190926683, 6313.084602732578, 6318.241810982711, 5951.404859514014, 5951.791687290924, 5954.702264886739, 5977.342492325841, 5988.071848863433, 4981.576565991859, 5058.089543882136, 5148.510891465305, 5275.973620131952, 5295.0, 6387.977923532212, 6388.329225431356, 6396.9360306397275, 6402.519811014193, 6412.903806442907, 6140.478059365004, 6192.442680158807, 6192.907106393318, 6208.4722798562625, 6215.9378406217165, 6087.330393656783, 6232.594881332699, 6289.213848268966, 6374.872502549831, 6384.106225128578, 6076.605020673642, 6095.481884039729, 6095.9390406097145, 6104.725287361991, 6127.3259941407305, 6185.072239164161, 6186.173901330612, 6200.0389939557635, 6222.875542489034, 6229.127922091002, 5834.27071616048, 5928.970355148197, 6006.669633170218, 6054.152418661303, 6055.617907469759, 6016.578839481194, 6035.547333949883, 6050.2437195350585, 6055.424734650377, 6071.787487437919, 5924.674142922181, 5946.940530594638, 5950.761969521343, 5978.551608629283, 5985.5810093294795, 5850.414958504116, 6002.279726432856, 6037.0642550404755, 6040.879182416239, 6048.699529601156, 5974.0, 5995.490383317467, 6026.789062382971, 6028.367021462858, 6042.184305118929], "value": 5698.3934786272785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2847326261959, 628.4155735166294, 630.7855329188076, 658.5324419662038, 684.6542496039499, 43362.78318608407, 47398.52601473989, 47477.0, 47580.0, 47752.0, 46051.0, 46208.768956155174, 46390.07219855601, 46592.76703616477, 46810.29784553235, 9044.186023257922, 9255.53722313885, 9266.629334826599, 9266.629334826632, 9272.350935434522, 9126.77183070422, 9197.908020919805, 9199.586018629145, 9222.400543964653, 9231.0, 9220.953895230514, 9245.352825302232, 9258.444493330422, 9263.21262692672, 9316.394434361779, 9219.492927888963, 9254.953725231364, 9258.027907069729, 9258.490783006931, 9259.398139121004, 9230.123138301851, 9247.815043699089, 9250.90749092514, 9279.675211367638, 9328.48693321867, 45239.54760452386, 45402.54597454016, 45494.31758523625, 45668.314975275396, 45695.54304456946, 3797.7531460454984, 3828.7319887607878, 4037.7375470594316, 4422.005048864012, 4801.18379875422, 34456.13859653529, 35085.0, 35169.64830351689, 35400.0, 35504.64495355039, 4601.0, 4602.355670206174, 4667.066586682643, 4701.811927522895, 4775.044991001813, 393801.0, 397162.0, 397958.0, 398202.0, 398284.0, 64282.0, 64353.356466434736, 64555.677221613594, 64674.41302347853, 64718.029229561595, 39221.80389098093, 40200.597994019685, 40317.59682403197, 67818.32181678219, 67907.32092679109, 19371.322003730085, 19400.805991940182, 19448.611027779647, 19450.5137371564, 19491.610167796563, 14548.781768273484, 14605.707885842223, 14627.488037918622, 14679.0, 14721.631959200891, 21127.154913803584, 21257.255996040065, 21382.14471421157, 21444.142234310766, 21459.78540214609, 7551.433642476726, 7677.654505547263, 7692.461527693008, 7696.384289256846, 7826.0, 989.7327721515151, 1053.083817079146, 1056.2447849787286, 1130.4573804573686, 1141.8458508101467, 34793.0, 34862.30275394478, 35116.64883351185, 35426.46860297098, 35432.82283588566, 1155.7341811383428, 1156.4969238381332, 1174.653477224204, 1191.3328536019856, 1219.1222319929636, 18334.266629334943, 18342.449726508225, 18468.168932398075, 18595.721064184047, 18657.253709851455, 617951.0, 618490.0, 620779.0, 621446.0, 624144.8792756007, 65643.34356656468, 66487.33512664908, 66630.66684666545, 66743.0, 66764.6661766688, 1434.0965191929017, 1443.6102252391795, 1457.380613239369, 1493.7236611226958, 1501.129344979909, 29114.0, 30039.54940675848, 30440.543391848696, 30477.390452191277, 30495.0, 56588.43411565832, 57107.71446142743, 57164.14253786113, 57172.42827571671, 57219.71390143022, 392420.0, 392716.0, 392813.0, 392980.0, 394227.0, 30687.386252275275, 30861.691383085883, 30968.0709578713, 31403.84298078495, 31533.8423307882, 52742.0, 53010.0, 53155.0, 53306.40080797582, 53655.46344536504, 44024.55975440333, 45511.77244113758, 45570.772146139054, 46660.766696166305, 47120.7643961778, 44628.77685611681, 45265.0, 45817.312740308254, 45962.0, 46692.7665361671, 40434.0, 44484.33273500836, 44845.32732008957, 44993.0, 45826.0, 37177.0, 39242.2151556973, 39248.0, 39494.0, 40252.3962140574, 30660.0, 30837.0, 30910.22724431907, 30972.0, 31175.220619483785], "value": 21601.68145338415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7910355270586, 414.28742562791984, 424.33379594037365, 432.84850302394165, 435.80388825028723, 18897.0, 19929.402117936468, 20562.588748225066, 20623.896880515615, 20706.0, 18934.905325473388, 18999.620007599875, 19377.612447751035, 19444.9027754861, 19558.511037224078, 5885.176075349444, 6114.847128821771, 6115.480184184327, 6143.293521245047, 6152.292486364081, 4468.575485328888, 6049.213602231704, 6092.268927728656, 6757.8849489834365, 6820.658967051652, 6819.352161544645, 6858.862822743542, 6893.4140598049225, 6899.137607799025, 6911.17065952084, 6709.731610735565, 6831.863362732743, 6856.41720453762, 6864.588124712508, 6892.827679308008, 5030.597552195815, 5208.583313334924, 5312.521873031407, 6048.576599638027, 6077.179580756586, 13129.146605470614, 13311.267880266581, 13329.600111996655, 21161.0, 24983.0, 2476.913308034228, 2623.7507436793476, 2676.745709157627, 2685.1810197889636, 3069.2480342316053, 10649.414282214475, 10849.728756781065, 11140.164487663376, 13679.0, 14585.124892506483, 1954.765428148617, 1963.7348957890645, 1979.1192919150983, 1989.1049027937486, 2053.2300387354744, 80512.59743701303, 84280.0, 85764.57117714372, 87155.0, 87348.56325718331, 10515.42165180907, 10547.84178237327, 10698.839517407245, 10722.678319650424, 10879.401632910107, 14382.28088595587, 14505.057171283834, 14514.491992780202, 14528.927355363156, 14562.27188640585, 8440.66237350499, 8515.12667213212, 8562.74311770648, 8712.869306960401, 8751.693690720795, 8780.517071561126, 8786.780330491789, 8889.511076890833, 8997.775055623662, 9022.278217742565, 4461.955380446154, 4521.480029796616, 4633.30500424939, 4670.416197975253, 5105.566026887756, 1605.4541455904814, 1650.092449152985, 1687.417840844931, 2003.1386503803212, 2114.2177394364185, 472.65496187782423, 480.0902290160127, 489.87263311539255, 496.7913476339946, 1040.0275742180934, 12717.0, 12968.80546791799, 13100.803487947689, 13159.0, 13172.47310107604, 503.09945198095, 512.8692183493185, 518.9143791274473, 524.114246922707, 529.0926061804024, 6871.896921546181, 6896.172459304916, 6904.758333458305, 6938.548994315353, 6974.546654467444, 499423.0, 522001.0, 546138.0, 575818.0, 590665.0, 93438.53280733689, 96320.0, 96654.0, 97931.51034244783, 100253.0, 506.1521950732582, 517.5626595526774, 517.7256054291232, 519.2211682476286, 519.9064168449715, 17405.825941740928, 18293.81706182921, 18441.170147343135, 19477.415677529698, 19488.220471180994, 43493.3475997854, 44303.77848110739, 44937.0, 45116.0, 45254.54745452635, 52431.47568524266, 59004.40995589989, 59589.0, 60439.093413597955, 61411.38588614235, 9101.362904596615, 9133.497657628628, 9307.906920930704, 9422.670206543013, 9529.809403812023, 10100.898991009995, 13435.12671676338, 13917.72164556683, 14026.0, 14490.85509144895, 11852.70368240801, 12298.631041068782, 12302.81545776832, 12364.134510584532, 12723.872761272269, 12317.0, 12401.317927514074, 12440.626781196579, 12487.562935297221, 12729.681757956125, 12456.626301210978, 12585.181963172365, 12653.481582210194, 12830.67923301925, 12948.546800861925, 7460.104787425544, 7807.882881756892, 7918.129005809472, 8206.138355472589, 8595.312375009858, 11975.28148311104, 12060.276383417024, 12433.12968092261, 12806.551770687982, 12824.615261542169], "value": 8870.486491548483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.2721893491123, 1558.0495897502526, 1725.3012529925377, 1852.8980906050178, 1871.279557370413, 8206.794830129234, 8982.640694372225, 9201.21789647879, 9698.369605975615, 9733.51332433379, 9256.490893000899, 9679.370840895355, 9686.709398718032, 9687.951560242189, 9697.030296970317, 2473.789727873133, 2533.961990570134, 2540.479201763634, 2546.2997675639162, 2548.4775620997743, 2478.6653801736716, 2556.6292887531295, 2565.089393265392, 2578.664773579432, 2579.432524844531, 2529.4435224250637, 2537.0612873236837, 2540.5554028045017, 2569.396191894903, 2574.214864466337, 2462.741412151725, 2472.4066224106173, 2495.1765917247358, 2521.1932181701864, 2537.695476542808, 2456.6192240202795, 2461.064795377763, 2462.9261122166363, 2468.7160976487753, 2504.4239824840206, 9546.331756777028, 9589.90410095904, 9602.135807777333, 9653.420794752337, 9660.468674222915, 5724.284464441945, 5894.145348924382, 5898.557608179403, 5900.409959004108, 5902.055671092648, 3382.543356646846, 3497.1431999160113, 3514.6836784689244, 3563.1626567756557, 3590.838412271428, 1092.885355930192, 1098.9340639561572, 1101.9008289253925, 1110.5113749949996, 1116.7654792493586, 13602.863971360259, 13645.522406715718, 13647.317634118353, 13684.52104176349, 13688.384022719001, 4844.927326090112, 4990.326305948723, 5065.341505604248, 5109.795608175706, 5187.610929180327, 11326.377049262204, 11386.08911287095, 11396.0, 11419.942900285445, 11460.598879039193, 5824.184614153937, 5842.415758424124, 5842.970785146047, 5865.266841644794, 5867.794627188028, 4636.884077898079, 5156.845294641167, 5273.446288139767, 5285.656432331886, 5339.0389729849, 4265.893352666146, 4318.719283246579, 4380.0, 4380.233459144701, 4433.911321773547, 1392.9622431288756, 1403.6911879386519, 1431.141315210886, 1432.2337549411016, 1442.61049516632, 1016.3850870223556, 1112.933224006562, 1126.571902676994, 1131.3042478875432, 1131.9037881779975, 6565.573237739532, 6701.6314102723845, 6720.0, 6836.111305530249, 6839.350261725128, 468.4682884925634, 476.39973633221695, 482.39700374531833, 487.24477060556706, 488.46757034831495, 4660.254359302563, 4694.6244300456565, 4731.313959475857, 4769.260764581495, 4776.0, 11204.215704900578, 11474.713132171595, 11620.6513804586, 12057.638270851889, 12097.516099355928, 11237.83143252852, 11671.941640291745, 11702.531898724126, 11719.355435451133, 11746.882531174579, 8738.737837864874, 9001.639934402681, 9023.142801433853, 9033.05152958943, 9036.141566551167, 6560.9343906562235, 6575.210974683068, 6588.670566471753, 6597.60414375139, 6804.795856124324, 10818.729531761768, 11151.0, 11265.155113366367, 11420.600278990196, 11492.482838272465, 10952.945235273774, 11197.040517909496, 11198.720031998939, 11250.268732532359, 11405.771884562428, 7962.522248665098, 8873.689420870238, 9012.774680633036, 9099.090090991112, 9237.445753254826, 9436.622535098793, 9498.050194980447, 9512.09635084666, 9521.047895210424, 9527.761805954906, 8247.298979586802, 8531.573421329032, 8544.829103418022, 8574.571271436527, 8681.565921704016, 7950.3639708822, 7998.800029999296, 8042.517448953082, 8050.074241462306, 8108.635111420118, 7417.517861338995, 7623.161452240138, 7627.0, 7631.580263085361, 7806.41451891099, 5668.492959292643, 5854.268216472941, 5909.320428150646, 5924.200232968494, 5994.880102398015, 5998.25021872266, 5998.7300571473515, 6017.578769486269, 6047.365026672136, 6107.144999699956], "value": 4983.541180490826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.80403767833496, 345.2094703129833, 349.81984278096786, 352.5404824028524, 361.95656521217455, 5737.909797138546, 5756.510696590784, 5819.709014549271, 5844.883102337951, 5856.443637854402, 5676.707509644407, 5677.602567820254, 5697.943020569793, 5698.259226300585, 5703.775527544261, 4062.8014735652905, 4401.679496151158, 4445.355423463596, 4478.261086920655, 4499.820007199724, 4466.419365482483, 4478.97760511197, 4490.57339552742, 4510.0, 4514.329698011724, 4427.579379958899, 4464.660601819457, 4469.7541635210055, 4490.775461226942, 4500.437445319335, 4310.633596144316, 4392.86821395357, 4417.977910110461, 4433.756143412111, 4437.7781110944325, 3890.8832735017995, 3891.2606604745292, 3897.5907529709257, 3900.980495097535, 3904.902377440558, 5604.635698679573, 5623.971880140614, 5639.71801409932, 5652.547796176337, 5654.773809047633, 5035.546800787946, 5057.0, 5114.105031619489, 5122.257272695439, 5159.793608255665, 5934.821955341346, 5955.791547295824, 5966.164736936832, 5990.700464976778, 5996.310424301174, 4216.156768646252, 4303.376010478463, 4338.327559228324, 4346.348047792856, 4359.367891655692, 6157.230346206724, 6198.81403557894, 6213.850437669001, 6219.440250377443, 6221.782237621662, 4407.845725399596, 4444.266695995189, 4447.444069491314, 4449.310356894686, 4456.17560751262, 4324.329728892027, 4482.843100491467, 4490.281554951257, 4502.324651302265, 4529.365888775574, 5049.6465247432325, 5065.341505604248, 5123.974380128076, 5132.769025393866, 5146.897062058738, 6021.2473440819895, 6074.726637301332, 6085.36103709113, 6107.572469927151, 6150.7232174552255, 1441.322578388177, 1541.368039103962, 1559.337281655292, 1561.8203906550664, 1584.9207539622973, 966.6713317472094, 976.272676855747, 1013.807376598444, 1033.607229252879, 1043.2123746571442, 5729.656220626775, 5766.106253530709, 5788.594798364074, 5829.329627092939, 5882.735276912549, 6114.48026917717, 6167.273163514224, 6188.783392581238, 6203.96898015516, 6226.62640241587, 5644.943550564524, 5766.3368712598585, 5768.192453056576, 5785.190073389729, 5786.94213057864, 3258.951115733266, 3318.386098571724, 3322.0532148338093, 3343.9331213375594, 3346.548215990859, 6074.969625151846, 6274.372562743781, 6370.0, 6373.745050198033, 6466.547341686037, 6249.0, 6299.96850015747, 6337.397947195009, 6338.556301058974, 6346.174997250328, 6254.405831446005, 6407.519436042316, 6431.196100487346, 6431.456450451858, 6461.578452740389, 6153.861535615925, 6160.784372546939, 6165.969170154121, 6171.3828617139725, 6180.0, 6078.817635470943, 6094.268687757498, 6098.634081955097, 6098.939010609837, 6119.84700382494, 6109.816705498843, 6238.500919926304, 6303.495720342454, 6342.746290148342, 6366.808995730135, 4354.716943398669, 4404.383386325853, 4412.294032954712, 4431.518349724165, 4432.711873728197, 5891.440313170242, 6075.301340345917, 6185.907211391743, 6265.091561723616, 6282.246130464374, 5923.851903702442, 5981.641101533922, 5985.670788106696, 5991.430814072656, 5994.550408719277, 5947.910781338197, 6023.951856368855, 6048.818535443944, 6054.788082417094, 6095.0, 5751.434110851299, 5886.676232807236, 5997.280326360865, 6004.189434426471, 6049.243844519435, 6129.448349648553, 6143.447089761943, 6159.860425821237, 6165.784197553064, 6169.876602467836, 5787.160861675117, 5962.032529265245, 6003.8198854034445, 6011.519078473624, 6031.668258245839], "value": 4589.828298631846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.7341077444444, 858.8196478739468, 877.8990416102147, 918.3855436010225, 923.4459324405353, 16542.421015264466, 17961.461156165304, 18098.27606895726, 18112.4566263012, 18115.818841811593, 15239.771403428957, 15301.158436286, 15432.305546250418, 15464.304106315214, 15488.070715757063, 849.6983570832358, 861.5261606116626, 880.4365206267994, 900.3157600223844, 906.4651855405309, 906.7914379692675, 907.3648446087765, 908.0465511213233, 908.0510866144895, 909.2089881802841, 945.4658118163215, 946.5125460387906, 950.235060776075, 950.3775027357058, 952.4285428742768, 940.0834186668012, 945.9101385368414, 947.924166066713, 948.5778828421355, 949.2832911152105, 687.9759208427681, 688.2944981394061, 691.4122995453874, 692.705600119952, 694.4617921111129, 15946.28241729125, 15999.52001439947, 16093.839061609468, 16104.0, 16148.192590370434, 15873.0, 16335.591610209722, 16487.69172315877, 16580.502584922473, 16886.915565422216, 13392.531261405804, 13462.730745385037, 13534.59396218115, 13588.59234222975, 13643.727125457435, 4183.569225275995, 4207.768572728499, 4214.957850421487, 4220.134872351191, 4285.550017248175, 72337.6383118081, 75124.62437687776, 89440.55279723625, 90024.54987725084, 90124.0, 12872.613821585368, 12900.161489503153, 13066.803997940038, 13067.281299528428, 13275.867241327656, 23054.769452305598, 23179.3046208614, 23266.53466930652, 23327.0, 23347.182848600216, 9331.953340233254, 9341.346105772667, 9377.718668439958, 9463.006384329685, 9732.854007189897, 5200.92198617021, 5256.316678831728, 5258.973705131526, 5289.920651190158, 5328.120860058047, 3932.9606703932595, 4083.3262511685834, 4086.652634526039, 4087.6321131097748, 4089.8364065437645, 684.1482354468718, 691.920429150644, 693.8681650486392, 707.2043950555625, 709.4820780830023, 717.1179449277314, 777.1878387085509, 811.1320886651226, 811.5333683132104, 848.804774901776, 10491.16070714341, 10993.780124397466, 11347.489362978686, 11401.201915865975, 11540.24988375753, 729.919708832028, 740.5334639177391, 795.7572940253278, 820.729159377404, 845.3701992015865, 5063.367079115111, 5273.604479664041, 5363.704996225167, 5452.890942181134, 5471.972640136853, 106477.0, 136855.0, 138656.0, 138714.0, 144593.0, 114885.4255728716, 119896.0, 120817.0, 121727.0, 124321.0, 59901.40098598958, 61121.38878611157, 78744.99999999885, 81488.59255703684, 85225.0, 10462.843057354297, 10776.568937242422, 11042.841344699455, 11278.887211127783, 11318.207725459139, 57715.422845772686, 59091.70454147702, 59250.407495926214, 60941.69529152326, 60967.69516152391, 87600.56199718961, 92200.0, 92664.0, 93439.53280233828, 93813.0, 14976.850231497981, 15075.24623768829, 15291.694166116838, 15418.691626167638, 16092.517224483285, 17014.404495842587, 17122.914385428492, 17303.0, 17476.388326408516, 17839.375621853174, 15873.603159921095, 15973.520794376187, 16468.01191928488, 16511.752323715395, 16685.16574171311, 15524.0, 15694.372225111325, 16033.851784080549, 16237.837621623632, 16698.833011670213, 13435.798463023259, 15490.148041857807, 16000.599985000468, 16031.038137711774, 16101.838981610033, 12850.35748212567, 13159.210447373189, 13216.405261763435, 13318.267495287851, 13331.533396331082, 11840.940795296314, 12335.938320308342, 13043.673908152372, 13372.197668139943, 13452.260125693181], "value": 8513.40973239032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 105.0, 112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 145.0, 178.0, 117.0, 154.0, 138.0, 120.0, 175.0, 115.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 164.0, 161.0, 163.0, 163.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 167.0, 75.0, 81.0, 76.0, 76.0, 164.0, 79.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 143.0, 85.0, 85.0, 83.0, 142.0, 83.0, 83.0, 154.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 152.0, 147.0, 150.0, 147.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 63.0, 52.0, 51.0, 51.0, 56.0, 54.0, 50.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 81.0, 76.0, 77.0, 73.0, 80.0, 74.0, 77.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 131.0, 117.0, 123.0, 121.0, 127.0, 127.0, 154.0, 128.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 160.0, 156.0, 152.0, 154.0, 155.0, 155.0, 154.0, 152.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 65.0, 67.0, 61.0, 62.0, 62.0, 63.0, 67.0], "value": 63.7, "unit": "score"}]}]} 05:24:49 INFO - Return code: 0 05:24:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:49 ERROR - # TBPL SUCCESS # 05:24:49 INFO - Running post-action listener: _resource_record_post_action 05:24:49 INFO - [mozharness: 2016-08-26 12:24:49.983603Z] Finished run-tests step (success) 05:24:49 INFO - Running post-run listener: _resource_record_post_run 05:24:50 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 326098944; Read time: 36; Write time: 254428 05:24:50 INFO - TinderboxPrint: CPU usage
13.2% 05:24:50 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 05:24:50 INFO - TinderboxPrint: I/O write bytes / time
326,098,944 / 254,428 05:24:50 INFO - TinderboxPrint: CPU idle
8,231.6 (86.8%) 05:24:50 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 05:24:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:24:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78348288; Read time: 0; Write time: 97208 05:24:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246853632; Read time: 36; Write time: 157200 05:24:50 INFO - Running post-run listener: _upload_blobber_files 05:24:50 INFO - Blob upload gear active. 05:24:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:50 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 05:24:50 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'] 05:24:50 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 05:24:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:24:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:51 INFO - (blobuploader) - INFO - Done attempting. 05:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:24:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:52 INFO - (blobuploader) - INFO - Done attempting. 05:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:56 INFO - (blobuploader) - INFO - Done attempting. 05:24:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:56 INFO - Return code: 0 05:24:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6a2f65d2d8341ae7e22947caf9a1bfcc8c1a65e60c64d9d9051f55727c86430c7d99ac7fb087c756017648a42e2f2fb2aae6235af834283e832a37811a0cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14326a1f168f555c8bfa45ee38f46effdbcc0be4589f504ce4137e4eeaa220e47d6fa09c629194d0ee9f2e4aa3c6e7a4018d7cff3cd5f648744ec83c07e56a2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fc605986f8c9ca76f0ae80635fc2d54a1e31ed2f963aa29b0189bd99e9b0818895ab34faf4cc73949cddeca6662ab69288fd2770b7eab0262ee1bbf3a7fb76"} 05:24:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:56 INFO - Contents: 05:24:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6a2f65d2d8341ae7e22947caf9a1bfcc8c1a65e60c64d9d9051f55727c86430c7d99ac7fb087c756017648a42e2f2fb2aae6235af834283e832a37811a0cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14326a1f168f555c8bfa45ee38f46effdbcc0be4589f504ce4137e4eeaa220e47d6fa09c629194d0ee9f2e4aa3c6e7a4018d7cff3cd5f648744ec83c07e56a2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fc605986f8c9ca76f0ae80635fc2d54a1e31ed2f963aa29b0189bd99e9b0818895ab34faf4cc73949cddeca6662ab69288fd2770b7eab0262ee1bbf3a7fb76"} 05:24:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:56 INFO - Copying logs to upload dir... 05:24:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.276956 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-26 05:24:55.958449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 05:24:55.962079) ========= 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=920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289 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/b6a2f65d2d8341ae7e22947caf9a1bfcc8c1a65e60c64d9d9051f55727c86430c7d99ac7fb087c756017648a42e2f2fb2aae6235af834283e832a37811a0cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14326a1f168f555c8bfa45ee38f46effdbcc0be4589f504ce4137e4eeaa220e47d6fa09c629194d0ee9f2e4aa3c6e7a4018d7cff3cd5f648744ec83c07e56a2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fc605986f8c9ca76f0ae80635fc2d54a1e31ed2f963aa29b0189bd99e9b0818895ab34faf4cc73949cddeca6662ab69288fd2770b7eab0262ee1bbf3a7fb76"} build_url:https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/JF7PBdkWRAuMNgz0FKLOyA/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/b6a2f65d2d8341ae7e22947caf9a1bfcc8c1a65e60c64d9d9051f55727c86430c7d99ac7fb087c756017648a42e2f2fb2aae6235af834283e832a37811a0cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14326a1f168f555c8bfa45ee38f46effdbcc0be4589f504ce4137e4eeaa220e47d6fa09c629194d0ee9f2e4aa3c6e7a4018d7cff3cd5f648744ec83c07e56a2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fc605986f8c9ca76f0ae80635fc2d54a1e31ed2f963aa29b0189bd99e9b0818895ab34faf4cc73949cddeca6662ab69288fd2770b7eab0262ee1bbf3a7fb76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 05:24:55.987543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 05:24:55.987876) ========= 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=920470bf432669ad7e3a5387000001ca-1472212617.349168-960378289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 05:24:56.072415) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 05:24:56.072853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 05:24:56.073339) ========= ========= Total master_lag: 0.16 =========