builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1474196048.15 results: success (0) buildid: 20160918004006 builduid: 3e120c6eed8d49f994f01a24d9abcf4f revision: 6f821fb94ace0320f05f06378ab90d87706f40d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.147785) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.148223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.148491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.261487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.261794) ========= 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=0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-18 03:54:08-- 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% 38.1M=0s 2016-09-18 03:54:08 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.361620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.645632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.645943) ========= 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=0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023245 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.701124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:08.701894) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6f821fb94ace0320f05f06378ab90d87706f40d5 --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 6f821fb94ace0320f05f06378ab90d87706f40d5 --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=0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-18 03:54:08,886 truncating revision to first 12 chars 2016-09-18 03:54:08,887 Setting DEBUG logging. 2016-09-18 03:54:08,887 attempt 1/10 2016-09-18 03:54:08,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6f821fb94ace?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-18 03:54:09,195 unpacking tar archive at: mozilla-aurora-6f821fb94ace/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:09.384094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:09.384377) ========= script_repo_revision: 6f821fb94ace0320f05f06378ab90d87706f40d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:09.384736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:09.385129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 03:54:09.394662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-18 03:54:09.394928) ========= /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=0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:54:09 INFO - MultiFileLogger online at 20160918 03:54:09 in /builds/slave/test 03:54:09 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 03:54:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:54:09 INFO - {'append_to_log': False, 03:54:09 INFO - 'base_work_dir': '/builds/slave/test', 03:54:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:54:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:54:09 INFO - 'branch': 'Mozilla-Aurora', 03:54:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:54:09 INFO - 'config_files': ('talos/linux_config.py',), 03:54:09 INFO - 'default_actions': ('clobber', 03:54:09 INFO - 'read-buildbot-config', 03:54:09 INFO - 'download-and-extract', 03:54:09 INFO - 'populate-webroot', 03:54:09 INFO - 'create-virtualenv', 03:54:09 INFO - 'install', 03:54:09 INFO - 'run-tests'), 03:54:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:54:09 INFO - 'download_minidump_stackwalk': True, 03:54:09 INFO - 'download_symbols': 'ondemand', 03:54:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:54:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:54:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:54:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:54:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:54:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:54:09 INFO - 'installer_path': 'installer.exe', 03:54:09 INFO - 'log_level': 'info', 03:54:09 INFO - 'log_name': 'talos', 03:54:09 INFO - 'log_to_console': True, 03:54:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:54:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:54:09 INFO - 'opt_config_files': (), 03:54:09 INFO - 'pip_index': False, 03:54:09 INFO - 'sps_profile': False, 03:54:09 INFO - 'sps_profile_interval': 0, 03:54:09 INFO - 'suite': 'dromaeojs-e10s', 03:54:09 INFO - 'system_bits': '32', 03:54:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:54:09 INFO - 'title': 'talos-linux64-ix-058', 03:54:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:54:09 INFO - 'use_talos_json': True, 03:54:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:54:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:54:09 INFO - 'work_dir': 'build'} 03:54:09 INFO - [mozharness: 2016-09-18 10:54:09.673408Z] Running clobber step. 03:54:09 INFO - Running pre-action listener: _resource_record_pre_action 03:54:09 INFO - Running main action method: clobber 03:54:09 INFO - rmtree: /builds/slave/test/build 03:54:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:54:10 INFO - Running post-action listener: _resource_record_post_action 03:54:10 INFO - [mozharness: 2016-09-18 10:54:10.127340Z] Finished clobber step (success) 03:54:10 INFO - [mozharness: 2016-09-18 10:54:10.127441Z] Running read-buildbot-config step. 03:54:10 INFO - Running pre-action listener: _resource_record_pre_action 03:54:10 INFO - Running main action method: read_buildbot_config 03:54:10 INFO - Using buildbot properties: 03:54:10 INFO - { 03:54:10 INFO - "project": "", 03:54:10 INFO - "product": "firefox", 03:54:10 INFO - "script_repo_revision": "production", 03:54:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:54:10 INFO - "repository": "", 03:54:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:54:10 INFO - "buildid": "20160918004006", 03:54:10 INFO - "stage_platform": "linux64-pgo", 03:54:10 INFO - "basedir": "/builds/slave/test", 03:54:10 INFO - "nightly_build": "True", 03:54:10 INFO - "buildnumber": 511, 03:54:10 INFO - "slavename": "talos-linux64-ix-058", 03:54:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:54:10 INFO - "platform": "ubuntu64_hw", 03:54:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:54:10 INFO - "branch": "mozilla-aurora", 03:54:10 INFO - "repo_path": "releases/mozilla-aurora", 03:54:10 INFO - "revision": "6f821fb94ace0320f05f06378ab90d87706f40d5", 03:54:10 INFO - "pgo_build": "True", 03:54:10 INFO - "builduid": "3e120c6eed8d49f994f01a24d9abcf4f", 03:54:10 INFO - "slavebuilddir": "test" 03:54:10 INFO - } 03:54:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:54:10 INFO - Running post-action listener: _resource_record_post_action 03:54:10 INFO - [mozharness: 2016-09-18 10:54:10.130221Z] Finished read-buildbot-config step (success) 03:54:10 INFO - [mozharness: 2016-09-18 10:54:10.130308Z] Running download-and-extract step. 03:54:10 INFO - Running pre-action listener: _resource_record_pre_action 03:54:10 INFO - Running main action method: download_and_extract 03:54:10 INFO - mkdir: /builds/slave/test/build/tests 03:54:10 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')]} 03:54:10 INFO - https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:54:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:54:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:54:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:54:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:54:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:54:10 INFO - retry: Failed, sleeping 30 seconds before retrying 03:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:54:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:54:40 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:54:40 INFO - retry: Failed, sleeping 60 seconds before retrying 03:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:55:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:55:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:55:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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! 03:55:40 INFO - Caught exception: HTTP Error 404: Not Found 03:55:40 INFO - Caught exception: HTTP Error 404: Not Found 03:55:40 INFO - Caught exception: HTTP Error 404: Not Found 03:55:40 INFO - trying https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:55:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:55:40 INFO - Downloaded 1361 bytes. 03:55:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:55:40 INFO - Using the following test package requirements: 03:55:40 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:55:40 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:55:40 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:55:40 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'jsshell-linux-x86_64.zip'], 03:55:40 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:55:40 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:55:40 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:55:40 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:55:40 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:55:40 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:40 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:55:40 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:55: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')]} 03:55:40 INFO - https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:55:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:55:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:55:40 INFO - retry: Failed, sleeping 30 seconds before retrying 03:56:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:56:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:56:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:56:10 INFO - retry: Failed, sleeping 60 seconds before retrying 03:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:57:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:57:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:57:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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! 03:57:10 INFO - Caught exception: HTTP Error 404: Not Found 03:57:10 INFO - Caught exception: HTTP Error 404: Not Found 03:57:10 INFO - Caught exception: HTTP Error 404: Not Found 03:57:10 INFO - trying https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:57:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:57:12 INFO - Downloaded 21771332 bytes. 03:57:12 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'] 03:57:12 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 03:57:13 INFO - Return code: 0 03:57:13 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 03:57:13 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')]} 03:57:13 INFO - https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:57:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:57:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:57:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:57:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:57:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:57:13 INFO - retry: Failed, sleeping 30 seconds before retrying 03:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:57:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:57:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:57:43 INFO - retry: Failed, sleeping 60 seconds before retrying 03:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:58:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:58:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:58:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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! 03:58:43 INFO - Caught exception: HTTP Error 404: Not Found 03:58:43 INFO - Caught exception: HTTP Error 404: Not Found 03:58:43 INFO - Caught exception: HTTP Error 404: Not Found 03:58:43 INFO - trying https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:58:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:58:44 INFO - Downloaded 21771332 bytes. 03:58:44 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'] 03:58:44 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 03:58:46 INFO - Return code: 0 03:58: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')]} 03:58:46 INFO - https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:58:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:58:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:58:46 INFO - retry: Failed, sleeping 30 seconds before retrying 03:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 03:59:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:59:16 INFO - retry: Failed, sleeping 60 seconds before retrying 04:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:00:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:00:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:00:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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! 04:00:16 INFO - Caught exception: HTTP Error 404: Not Found 04:00:16 INFO - Caught exception: HTTP Error 404: Not Found 04:00:16 INFO - Caught exception: HTTP Error 404: Not Found 04:00:16 INFO - trying https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:00:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:00:17 INFO - Downloaded 14413740 bytes. 04:00:17 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'] 04:00:17 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 04:00:18 INFO - Return code: 0 04:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:18 INFO - https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:00:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:00:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:00:18 INFO - retry: Failed, sleeping 30 seconds before retrying 04:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:00:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:00:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:00:48 INFO - retry: Failed, sleeping 60 seconds before retrying 04:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:01:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:01:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:01:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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! 04:01:48 INFO - Caught exception: HTTP Error 404: Not Found 04:01:48 INFO - Caught exception: HTTP Error 404: Not Found 04:01:48 INFO - Caught exception: HTTP Error 404: Not Found 04:01:48 INFO - trying https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:01:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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 04:01:49 INFO - Downloaded 63902906 bytes. 04:01:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:01:49 INFO - mkdir: /builds/slave/test/properties 04:01:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:49 INFO - Contents: 04:01:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - Running post-action listener: set_extra_try_arguments 04:01:50 INFO - [mozharness: 2016-09-18 11:01:50.059152Z] Finished download-and-extract step (success) 04:01:50 INFO - [mozharness: 2016-09-18 11:01:50.059384Z] Running populate-webroot step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: populate_webroot 04:01:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:50 INFO - '--tppagecycles', 04:01:50 INFO - '7'], 04:01:50 INFO - 'tests': ['tsvgm']}}, 04:01:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['damp', 'tps']}, 04:01:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'tests': ['damp', 'tps']}, 04:01:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['dromaeo_dom']}, 04:01:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['basic_compositor_video']}, 04:01:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:01:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['tsvgx', 04:01:50 INFO - 'tsvgr_opacity', 04:01:50 INFO - 'tart', 04:01:50 INFO - 'tscrollx', 04:01:50 INFO - 'cart']}, 04:01:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:50 INFO - 'tsvgr_opacity', 04:01:50 INFO - 'tart', 04:01:50 INFO - 'tscrollx', 04:01:50 INFO - 'cart']}, 04:01:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-e10s'], 04:01:50 INFO - 'tests': ['tp5o']}, 04:01:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'tests': ['tp5o']}, 04:01:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-e10s', 04:01:50 INFO - '--xperf_path', 04:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:50 INFO - 'tests': ['tp5n']}, 04:01:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:50 INFO - 'talos_options': ['--xperf_path', 04:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:50 INFO - 'tests': ['tp5n']}}, 04:01:50 INFO - 'talos.zip': {'path': '', 04:01:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - [mozharness: 2016-09-18 11:01:50.081264Z] Finished populate-webroot step (success) 04:01:50 INFO - [mozharness: 2016-09-18 11:01:50.081354Z] Running create-virtualenv step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: create_virtualenv 04:01:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:01:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:50 INFO - Using real prefix '/usr' 04:01:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:52 INFO - Installing pip.................done. 04:01:52 INFO - Return code: 0 04:01:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:52 INFO - Using env: {'DISPLAY': ':0', 04:01:52 INFO - 'HOME': '/home/cltbld', 04:01:52 INFO - 'LANG': 'en_US.UTF-8', 04:01:52 INFO - 'LANGUAGE': 'en_US:en', 04:01:52 INFO - 'LOGNAME': 'cltbld', 04:01:52 INFO - 'MAIL': '/var/mail/cltbld', 04:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:52 INFO - 'MOZ_NO_REMOTE': '1', 04:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:52 INFO - 'NO_EM_RESTART': '1', 04:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:52 INFO - 'PWD': '/builds/slave/test', 04:01:52 INFO - 'SHELL': '/bin/bash', 04:01:52 INFO - 'SHLVL': '1', 04:01:52 INFO - 'TERM': 'linux', 04:01:52 INFO - 'TMOUT': '86400', 04:01:52 INFO - 'USER': 'cltbld', 04:01:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:52 INFO - '_': '/tools/buildbot/bin/python'} 04:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:01:52 INFO - Cleaning up... 04:01:52 INFO - Return code: 0 04:01:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:01:52 INFO - Using env: {'DISPLAY': ':0', 04:01:52 INFO - 'HOME': '/home/cltbld', 04:01:52 INFO - 'LANG': 'en_US.UTF-8', 04:01:52 INFO - 'LANGUAGE': 'en_US:en', 04:01:52 INFO - 'LOGNAME': 'cltbld', 04:01:52 INFO - 'MAIL': '/var/mail/cltbld', 04:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:52 INFO - 'MOZ_NO_REMOTE': '1', 04:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:52 INFO - 'NO_EM_RESTART': '1', 04:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:52 INFO - 'PWD': '/builds/slave/test', 04:01:52 INFO - 'SHELL': '/bin/bash', 04:01:52 INFO - 'SHLVL': '1', 04:01:52 INFO - 'TERM': 'linux', 04:01:52 INFO - 'TMOUT': '86400', 04:01:52 INFO - 'USER': 'cltbld', 04:01:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:52 INFO - '_': '/tools/buildbot/bin/python'} 04:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:53 INFO - Downloading/unpacking psutil>=3.1.1 04:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:55 INFO - Installing collected packages: psutil 04:01:55 INFO - Running setup.py install for psutil 04:01:55 INFO - building 'psutil._psutil_linux' extension 04:01:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:01:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:01:55 INFO - building 'psutil._psutil_posix' extension 04:01:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:01:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:55 INFO - Successfully installed psutil 04:01:55 INFO - Cleaning up... 04:01:55 INFO - Return code: 0 04:01:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:01:55 INFO - Using env: {'DISPLAY': ':0', 04:01:55 INFO - 'HOME': '/home/cltbld', 04:01:55 INFO - 'LANG': 'en_US.UTF-8', 04:01:55 INFO - 'LANGUAGE': 'en_US:en', 04:01:55 INFO - 'LOGNAME': 'cltbld', 04:01:55 INFO - 'MAIL': '/var/mail/cltbld', 04:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:55 INFO - 'MOZ_NO_REMOTE': '1', 04:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:55 INFO - 'NO_EM_RESTART': '1', 04:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:55 INFO - 'PWD': '/builds/slave/test', 04:01:55 INFO - 'SHELL': '/bin/bash', 04:01:55 INFO - 'SHLVL': '1', 04:01:55 INFO - 'TERM': 'linux', 04:01:55 INFO - 'TMOUT': '86400', 04:01:55 INFO - 'USER': 'cltbld', 04:01:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:55 INFO - '_': '/tools/buildbot/bin/python'} 04:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:01:57 INFO - Installing collected packages: mozsystemmonitor 04:01:57 INFO - Running setup.py install for mozsystemmonitor 04:01:57 INFO - Successfully installed mozsystemmonitor 04:01:57 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:01:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:58 INFO - 'LANG': 'en_US.UTF-8', 04:01:58 INFO - 'LANGUAGE': 'en_US:en', 04:01:58 INFO - 'LOGNAME': 'cltbld', 04:01:58 INFO - 'MAIL': '/var/mail/cltbld', 04:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:58 INFO - 'MOZ_NO_REMOTE': '1', 04:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:58 INFO - 'NO_EM_RESTART': '1', 04:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:58 INFO - 'PWD': '/builds/slave/test', 04:01:58 INFO - 'SHELL': '/bin/bash', 04:01:58 INFO - 'SHLVL': '1', 04:01:58 INFO - 'TERM': 'linux', 04:01:58 INFO - 'TMOUT': '86400', 04:01:58 INFO - 'USER': 'cltbld', 04:01:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:58 INFO - '_': '/tools/buildbot/bin/python'} 04:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:58 INFO - Downloading/unpacking jsonschema==2.5.1 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:00 INFO - warning: no files found matching '*.txt' 04:02:00 INFO - no previously-included directories found matching 'build' 04:02:00 INFO - no previously-included directories found matching 'dist' 04:02:00 INFO - no previously-included directories found matching '.git*' 04:02:00 INFO - Installing collected packages: jsonschema, functools32 04:02:00 INFO - Running setup.py install for functools32 04:02:00 INFO - warning: no files found matching '*.txt' 04:02:00 INFO - no previously-included directories found matching 'build' 04:02:00 INFO - no previously-included directories found matching 'dist' 04:02:00 INFO - no previously-included directories found matching '.git*' 04:02:00 INFO - Successfully installed jsonschema functools32 04:02:00 INFO - Cleaning up... 04:02:00 INFO - Return code: 0 04:02:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:02:00 INFO - Using env: {'DISPLAY': ':0', 04:02:00 INFO - 'HOME': '/home/cltbld', 04:02:00 INFO - 'LANG': 'en_US.UTF-8', 04:02:00 INFO - 'LANGUAGE': 'en_US:en', 04:02:00 INFO - 'LOGNAME': 'cltbld', 04:02:00 INFO - 'MAIL': '/var/mail/cltbld', 04:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:00 INFO - 'MOZ_NO_REMOTE': '1', 04:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:00 INFO - 'NO_EM_RESTART': '1', 04:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:00 INFO - 'PWD': '/builds/slave/test', 04:02:00 INFO - 'SHELL': '/bin/bash', 04:02:00 INFO - 'SHLVL': '1', 04:02:00 INFO - 'TERM': 'linux', 04:02:00 INFO - 'TMOUT': '86400', 04:02:00 INFO - 'USER': 'cltbld', 04:02:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:00 INFO - '_': '/tools/buildbot/bin/python'} 04:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:02:00 INFO - Cleaning up... 04:02:00 INFO - Return code: 0 04:02:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:02:00 INFO - Using env: {'DISPLAY': ':0', 04:02:00 INFO - 'HOME': '/home/cltbld', 04:02:00 INFO - 'LANG': 'en_US.UTF-8', 04:02:00 INFO - 'LANGUAGE': 'en_US:en', 04:02:00 INFO - 'LOGNAME': 'cltbld', 04:02:00 INFO - 'MAIL': '/var/mail/cltbld', 04:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:00 INFO - 'MOZ_NO_REMOTE': '1', 04:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:00 INFO - 'NO_EM_RESTART': '1', 04:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:00 INFO - 'PWD': '/builds/slave/test', 04:02:00 INFO - 'SHELL': '/bin/bash', 04:02:00 INFO - 'SHLVL': '1', 04:02:00 INFO - 'TERM': 'linux', 04:02:00 INFO - 'TMOUT': '86400', 04:02:00 INFO - 'USER': 'cltbld', 04:02:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:00 INFO - '_': '/tools/buildbot/bin/python'} 04:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - Downloading docopt-0.6.1.tar.gz 04:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:03 INFO - Running setup.py install for blobuploader 04:02:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:03 INFO - Running setup.py install for requests 04:02:04 INFO - Running setup.py install for docopt 04:02:04 INFO - Successfully installed blobuploader requests docopt 04:02:04 INFO - Cleaning up... 04:02:04 INFO - Return code: 0 04:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:02:04 INFO - Using env: {'DISPLAY': ':0', 04:02:04 INFO - 'HOME': '/home/cltbld', 04:02:04 INFO - 'LANG': 'en_US.UTF-8', 04:02:04 INFO - 'LANGUAGE': 'en_US:en', 04:02:04 INFO - 'LOGNAME': 'cltbld', 04:02:04 INFO - 'MAIL': '/var/mail/cltbld', 04:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:04 INFO - 'MOZ_NO_REMOTE': '1', 04:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:04 INFO - 'NO_EM_RESTART': '1', 04:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:04 INFO - 'PWD': '/builds/slave/test', 04:02:04 INFO - 'SHELL': '/bin/bash', 04:02:04 INFO - 'SHLVL': '1', 04:02:04 INFO - 'TERM': 'linux', 04:02:04 INFO - 'TMOUT': '86400', 04:02:04 INFO - 'USER': 'cltbld', 04:02:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:04 INFO - '_': '/tools/buildbot/bin/python'} 04:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:04 INFO - Running setup.py (path:/tmp/pip-vvgARr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:04 INFO - Running setup.py (path:/tmp/pip-O4W9Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:04 INFO - Running setup.py (path:/tmp/pip-F6vmzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:04 INFO - Running setup.py (path:/tmp/pip-e2PESL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:04 INFO - Running setup.py (path:/tmp/pip-Pyexx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:04 INFO - Running setup.py (path:/tmp/pip-iued7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:04 INFO - Running setup.py (path:/tmp/pip-BIezXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:04 INFO - Running setup.py (path:/tmp/pip-QOm8CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:05 INFO - Running setup.py (path:/tmp/pip-P_5JL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:05 INFO - Running setup.py (path:/tmp/pip-5nvPz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:05 INFO - Running setup.py (path:/tmp/pip-WxV38J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:05 INFO - Running setup.py (path:/tmp/pip-MzAIHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:05 INFO - Running setup.py (path:/tmp/pip-K1V1LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:05 INFO - Running setup.py (path:/tmp/pip-XBcjYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:05 INFO - Running setup.py (path:/tmp/pip-BI3tbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:05 INFO - Running setup.py (path:/tmp/pip-JFQS7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:05 INFO - Running setup.py (path:/tmp/pip-FXpdCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:05 INFO - Running setup.py install for manifestparser 04:02:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Running setup.py install for mozcrash 04:02:05 INFO - Running setup.py install for mozdebug 04:02:06 INFO - Running setup.py install for mozdevice 04:02:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Running setup.py install for mozfile 04:02:06 INFO - Running setup.py install for mozhttpd 04:02:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Running setup.py install for mozinfo 04:02:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Running setup.py install for mozInstall 04:02:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Running setup.py install for mozleak 04:02:06 INFO - Running setup.py install for mozlog 04:02:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Running setup.py install for moznetwork 04:02:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:06 INFO - Running setup.py install for mozprocess 04:02:06 INFO - Running setup.py install for mozprofile 04:02:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:07 INFO - Running setup.py install for mozrunner 04:02:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:07 INFO - Running setup.py install for mozscreenshot 04:02:07 INFO - Running setup.py install for moztest 04:02:07 INFO - Running setup.py install for mozversion 04:02:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:07 INFO - Cleaning up... 04:02:07 INFO - Return code: 0 04:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:02:07 INFO - Using env: {'DISPLAY': ':0', 04:02:07 INFO - 'HOME': '/home/cltbld', 04:02:07 INFO - 'LANG': 'en_US.UTF-8', 04:02:07 INFO - 'LANGUAGE': 'en_US:en', 04:02:07 INFO - 'LOGNAME': 'cltbld', 04:02:07 INFO - 'MAIL': '/var/mail/cltbld', 04:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:07 INFO - 'MOZ_NO_REMOTE': '1', 04:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:07 INFO - 'NO_EM_RESTART': '1', 04:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:07 INFO - 'PWD': '/builds/slave/test', 04:02:07 INFO - 'SHELL': '/bin/bash', 04:02:07 INFO - 'SHLVL': '1', 04:02:07 INFO - 'TERM': 'linux', 04:02:07 INFO - 'TMOUT': '86400', 04:02:07 INFO - 'USER': 'cltbld', 04:02:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:07 INFO - '_': '/tools/buildbot/bin/python'} 04:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:07 INFO - Running setup.py (path:/tmp/pip-VR5jom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:07 INFO - Running setup.py (path:/tmp/pip-P_JZP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:07 INFO - Running setup.py (path:/tmp/pip-Nj2PVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:07 INFO - Running setup.py (path:/tmp/pip-NAZt_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:08 INFO - Running setup.py (path:/tmp/pip-XlNEhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:08 INFO - Running setup.py (path:/tmp/pip-n7Xmpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:08 INFO - Running setup.py (path:/tmp/pip-ujL6u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:08 INFO - Running setup.py (path:/tmp/pip-Kk_gwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:08 INFO - Running setup.py (path:/tmp/pip-KRuRsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:08 INFO - Running setup.py (path:/tmp/pip-NmxY7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:08 INFO - Running setup.py (path:/tmp/pip-8Bu1QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:08 INFO - Running setup.py (path:/tmp/pip-0mambN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:08 INFO - Running setup.py (path:/tmp/pip-in68MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:08 INFO - Running setup.py (path:/tmp/pip-yvaUbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:08 INFO - Running setup.py (path:/tmp/pip-5knNAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:08 INFO - Running setup.py (path:/tmp/pip-X8UeJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:08 INFO - Running setup.py (path:/tmp/pip-kyo63K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:10 INFO - Downloading blessings-1.6.tar.gz 04:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:10 INFO - Installing collected packages: blessings 04:02:10 INFO - Running setup.py install for blessings 04:02:11 INFO - Successfully installed blessings 04:02:11 INFO - Cleaning up... 04:02:11 INFO - Return code: 0 04:02:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:11 INFO - Reading from file tmpfile_stdout 04:02:11 INFO - Current package versions: 04:02:11 INFO - argparse == 1.2.1 04:02:11 INFO - blessings == 1.6 04:02:11 INFO - blobuploader == 1.2.4 04:02:11 INFO - docopt == 0.6.1 04:02:11 INFO - functools32 == 3.2.3-2 04:02:11 INFO - jsonschema == 2.5.1 04:02:11 INFO - manifestparser == 1.1 04:02:11 INFO - mozInstall == 1.12 04:02:11 INFO - mozcrash == 0.17 04:02:11 INFO - mozdebug == 0.1 04:02:11 INFO - mozdevice == 0.48 04:02:11 INFO - mozfile == 1.2 04:02:11 INFO - mozhttpd == 0.7 04:02:11 INFO - mozinfo == 0.9 04:02:11 INFO - mozleak == 0.1 04:02:11 INFO - mozlog == 3.3 04:02:11 INFO - moznetwork == 0.27 04:02:11 INFO - mozprocess == 0.23 04:02:11 INFO - mozprofile == 0.28 04:02:11 INFO - mozrunner == 6.12 04:02:11 INFO - mozscreenshot == 0.1 04:02:11 INFO - mozsystemmonitor == 0.3 04:02:11 INFO - moztest == 0.7 04:02:11 INFO - mozversion == 1.4 04:02:11 INFO - psutil == 3.1.1 04:02:11 INFO - requests == 1.2.3 04:02:11 INFO - wsgiref == 0.1.2 04:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:02:11 INFO - Using env: {'DISPLAY': ':0', 04:02:11 INFO - 'HOME': '/home/cltbld', 04:02:11 INFO - 'LANG': 'en_US.UTF-8', 04:02:11 INFO - 'LANGUAGE': 'en_US:en', 04:02:11 INFO - 'LOGNAME': 'cltbld', 04:02:11 INFO - 'MAIL': '/var/mail/cltbld', 04:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:11 INFO - 'MOZ_NO_REMOTE': '1', 04:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:11 INFO - 'NO_EM_RESTART': '1', 04:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:11 INFO - 'PWD': '/builds/slave/test', 04:02:11 INFO - 'SHELL': '/bin/bash', 04:02:11 INFO - 'SHLVL': '1', 04:02:11 INFO - 'TERM': 'linux', 04:02:11 INFO - 'TMOUT': '86400', 04:02:11 INFO - 'USER': 'cltbld', 04:02:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:11 INFO - '_': '/tools/buildbot/bin/python'} 04:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:02:11 INFO - Cleaning up... 04:02:11 INFO - Return code: 0 04:02:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, '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': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', '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 04:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:02:11 INFO - Using env: {'DISPLAY': ':0', 04:02:11 INFO - 'HOME': '/home/cltbld', 04:02:11 INFO - 'LANG': 'en_US.UTF-8', 04:02:11 INFO - 'LANGUAGE': 'en_US:en', 04:02:11 INFO - 'LOGNAME': 'cltbld', 04:02:11 INFO - 'MAIL': '/var/mail/cltbld', 04:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:11 INFO - 'MOZ_NO_REMOTE': '1', 04:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:11 INFO - 'NO_EM_RESTART': '1', 04:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:11 INFO - 'PWD': '/builds/slave/test', 04:02:11 INFO - 'SHELL': '/bin/bash', 04:02:11 INFO - 'SHLVL': '1', 04:02:11 INFO - 'TERM': 'linux', 04:02:11 INFO - 'TMOUT': '86400', 04:02:11 INFO - 'USER': 'cltbld', 04:02:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:11 INFO - '_': '/tools/buildbot/bin/python'} 04:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:11 INFO - Cleaning up... 04:02:11 INFO - Return code: 0 04:02:11 INFO - Running post-action listener: _resource_record_post_action 04:02:11 INFO - Running post-action listener: _start_resource_monitoring 04:02:11 INFO - Starting resource monitoring. 04:02:11 INFO - [mozharness: 2016-09-18 11:02:11.809040Z] Finished create-virtualenv step (success) 04:02:11 INFO - [mozharness: 2016-09-18 11:02:11.809596Z] Running install step. 04:02:11 INFO - Running pre-action listener: _resource_record_pre_action 04:02:11 INFO - Running main action method: install 04:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:12 INFO - Reading from file tmpfile_stdout 04:02:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:12 INFO - Reading from file tmpfile_stdout 04:02:12 INFO - Output received: 04:02:12 INFO - Usage: mozinstall [options] installer 04:02:12 INFO - Options: 04:02:12 INFO - -h, --help show this help message and exit 04:02:12 INFO - -d DEST, --destination=DEST 04:02:12 INFO - Directory to install application into. [default: 04:02:12 INFO - "/builds/slave/test"] 04:02:12 INFO - --app=APP Application being installed. [default: firefox] 04:02:12 INFO - mkdir: /builds/slave/test/build/application 04:02:12 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'] 04:02:12 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 04:02:28 INFO - Reading from file tmpfile_stdout 04:02:28 INFO - Output received: 04:02:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - [mozharness: 2016-09-18 11:02:28.119395Z] Finished install step (success) 04:02:28 INFO - [mozharness: 2016-09-18 11:02:28.119732Z] Running run-tests step. 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: run_tests 04:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:28 INFO - Python 2.7.3 04:02:28 INFO - Return code: 0 04:02:28 INFO - grabbing minidump binary from tooltool 04:02:28 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:02:28 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 0x1d3e570>, '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 0x1d3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:28 INFO - Return code: 0 04:02:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:28 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/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 04:02:28 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/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 04:02:28 INFO - Using env: {'DISPLAY': ':0', 04:02:28 INFO - 'HOME': '/home/cltbld', 04:02:28 INFO - 'LANG': 'en_US.UTF-8', 04:02:28 INFO - 'LANGUAGE': 'en_US:en', 04:02:28 INFO - 'LOGNAME': 'cltbld', 04:02:28 INFO - 'MAIL': '/var/mail/cltbld', 04:02:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:28 INFO - 'MOZ_NO_REMOTE': '1', 04:02:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:28 INFO - 'NO_EM_RESTART': '1', 04:02:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:28 INFO - 'PWD': '/builds/slave/test', 04:02:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:28 INFO - 'SHELL': '/bin/bash', 04:02:28 INFO - 'SHLVL': '1', 04:02:28 INFO - 'TERM': 'linux', 04:02:28 INFO - 'TMOUT': '86400', 04:02:28 INFO - 'USER': 'cltbld', 04:02:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381', 04:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:28 INFO - '_': '/tools/buildbot/bin/python'} 04:02:28 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/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 04:02:28 INFO - mozversion application_buildid: 20160918004006 04:02:28 INFO - mozversion application_changeset: 6f821fb94ace0320f05f06378ab90d87706f40d5 04:02:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:02:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:28 INFO - mozversion application_name: Firefox 04:02:28 INFO - mozversion application_remotingname: firefox-dev 04:02:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:02:28 INFO - mozversion application_vendor: Mozilla 04:02:28 INFO - mozversion application_version: 50.0a2 04:02:28 INFO - mozversion platform_buildid: 20160918004006 04:02:28 INFO - mozversion platform_changeset: 6f821fb94ace0320f05f06378ab90d87706f40d5 04:02:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:02:28 INFO - mozversion platform_version: 50.0a2 04:02:28 INFO - using testdate: 1474196548 04:02:28 INFO - actual date: 1474196548 04:02:28 INFO - starting webserver on 'localhost:40658' 04:02:28 INFO - SUITE-START | Running 2 tests 04:02:28 INFO - TEST-START | dromaeo_css 04:02:28 INFO - operating with platform_type : linux_ 04:02:28 INFO - Initialising browser for dromaeo_css test... 04:02:28 INFO - TEST-INFO | started process 4053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgTu2y/profile http://localhost:40658/getInfo.html) 04:02:32 INFO - PROCESS | 4053 | __metrics Screen width/height:1600/1200 04:02:32 INFO - PROCESS | 4053 | colorDepth:24 04:02:32 INFO - PROCESS | 4053 | Browser inner width/height: 1024/697 04:02:32 INFO - PROCESS | 4053 | __metrics 04:02:33 ERROR - PROCESS | 4053 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:02:34 INFO - TEST-INFO | 4053: exit 0 04:02:34 INFO - Browser initialized. 04:02:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:34 INFO - TEST-INFO | started process 4184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgTu2y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:46 INFO - PROCESS | 4184 | RSS: Main: 153677824 04:02:46 INFO - PROCESS | 4184 | 04:03:35 INFO - PROCESS | 4184 | 1474196615769 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] 04:05:44 INFO - PROCESS | 4184 | Cycle 1(1): loaded http://localhost:40658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40658/tests/dromaeo/cssquery-ext.html) 04:05:45 INFO - PROCESS | 4184 | RSS: Main: 160280576 04:05:45 INFO - PROCESS | 4184 | 04:08:47 INFO - PROCESS | 4184 | Cycle 1(1): loaded http://localhost:40658/tests/dromaeo/cssquery-ext.html (next: http://localhost:40658/tests/dromaeo/cssquery-jquery.html) 04:08:47 INFO - PROCESS | 4184 | RSS: Main: 155762688 04:08:47 INFO - PROCESS | 4184 | 04:11:49 INFO - PROCESS | 4184 | Cycle 1(1): loaded http://localhost:40658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40658/tests/dromaeo/cssquery-mootools.html) 04:11:50 INFO - PROCESS | 4184 | RSS: Main: 155885568 04:11:50 INFO - PROCESS | 4184 | 04:14:52 INFO - PROCESS | 4184 | Cycle 1(1): loaded http://localhost:40658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40658/tests/dromaeo/cssquery-prototype.html) 04:14:52 INFO - PROCESS | 4184 | RSS: Main: 155099136 04:14:52 INFO - PROCESS | 4184 | 04:17:55 INFO - PROCESS | 4184 | Cycle 1(1): loaded http://localhost:40658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40658/tests/dromaeo/cssquery-yui.html) 04:17:55 INFO - PROCESS | 4184 | RSS: Main: 157958144 04:17:55 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | Cycle 1(1): loaded http://localhost:40658/tests/dromaeo/cssquery-yui.html (next: http://localhost:40658/tests/dromaeo/cssquery-dojo.html) 04:20:58 INFO - PROCESS | 4184 | RSS: Main: 157954048 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | __start_tp_report 04:20:58 INFO - PROCESS | 4184 | _x_x_mozilla_page_load 04:20:58 INFO - PROCESS | 4184 | _x_x_mozilla_page_load_details 04:20:58 INFO - PROCESS | 4184 | |i|pagename|runs| 04:20:58 INFO - PROCESS | 4184 | |0;dojo.html;3249.6750324967497;3252.2519820441285;3265.820379879107;3294.7364210863147;3305.6363799981996;5656.943430565693;5690.345610254822;5752.856178595537;5759.280089988752;5778.855528611776;5733.885322293562;5781.19063331134;5793.478586927186;5799.391063938289;5799.478046975772;5172.6379153459275;5209.843704688847;5223.477652234765;5262.315898933152;5309.973450132744;5093.567046801008;5094.083065048289;5131.179011358184;5140.357455318085;5140.563052140573;5172.8706782330555;5190.792368305263;5201.921971170416;5274.393444753864;5276.15581506959;5215.817446389358;5231.084560201987;5238.423773384925;5254.159334506479;5255.474452554714;4947.604191664658;4968.180250258703;5116.616253780981;5137.768800403954;5138.177891537336;5537.916931246034;5585.916211256835;5589.944100559023;5624.859378515529;5629.887402251973;6033.366496517846;6036.396360363972;6038.275406951194;6038.637681739066;6064;5901.468867801918;6002.189704389939;6108.144859719643;6112.022076467744;6120.540959428061;5618.269624948772;5702.8289151325525;5720.2849643794525;5724.627899186539;5763.1355296705415;6208.068789681584;6222.688865556704;6226.62640241587;6226.813195604139;6265.937340626627;5822.475977161991;5871.089981052944;5975.790847320323;6002.339742628307;6009.369016253318;5959.523238140939;6093.878122437615;6102.4507794298725;6116.724747386378;6129.448349648553;5995.580309378389;6022;6030.27636683592;6039.607425517327;6065;5854.5901786875365;5936.168936348915;6051.394860513913;6062.090686397076;6065.423784740443;4540.250858608359;4643.628509719214;4658;4667.183242932473;4676.95323046772;4134.131832315187;4141.171765646883;4142.627163555295;4161.2509748245;4163.8959026024595;5622.409646987089;5708.257926469532;5805.216295800097;5827.4172582741385;5828.213191219131;6095.085737139376;6168.753249870045;6170.382961703794;6196.10156527301;6199.070139479114;5892.351841297454;5894.2926848778425;5900.20347253124;5905.704714764244;5912.881742365129;5125.923111153335;5204.869878253074;5297.735113244399;5310.867228319323;5317.042932272228;6250.843728906813;6398.680065996681;6410.391012853772;6410.775622853178;6411.871762564816;6190.41191086846;6193.597416167935;6195.4424101831055;6195.721192546256;6197.628142311476;6063.969125248806;6225;6384.968075159594;6413.102165696713;6414.935850641434;5932.525397968238;6101.6644084574;6111.804454079419;6113.05926533857;6142.938570614416;6176.722047507783;6181.9690901547;6190.442860142609;6216.595921265103;6222.004479283293;5897.085951677497;5958.106284057253;6069.757209711739;6085.300190478151;6098.908516372347;5953.1070339449425;5965.313988891333;5976.8804623908145;5983.880322393615;6005.6396616203165;5863.091220860773;5899.557533184942;5918.23063001807;5941.1088336749835;5967.49276311501;5908.231929849264;5908.763649454146;5932.614380065282;5990.6705131218205;6005.249343832021;5816.272965879265;5909.438603332676;5941.673207973603;5950.077737950624;5967.134765459071 04:20:58 INFO - PROCESS | 4184 | |1;ext.html;581.1921429213394;619.9566030377873;650.5966300893443;654.486228310776;699.6536714326409;42154.57845421545;46313.7684311578;46378.68106594665;46429.535704642985;46555;45057.77471112648;45830;45872;45972.77013614935;46010;8958.507282099497;9001.639934402649;9043.683471078513;9055.501947392891;9077;8971.46171229725;8984.550772461384;9026.864597031017;9043.683471078513;9071.138241867013;9139.177474027336;9190.954045229764;9191.908080919173;9194.954025229865;9215.953920230422;9062.682806101788;9080.318976076787;9086.909570851474;9091.909080909238;9110.59002344896;8983.595738191732;9109.225715814164;9116.8632470513;9137.634494620208;9145.542722863831;43067.56932430698;43422;43422.348664770056;43461;43500.56499434997;3369.5451114099774;3763.5671897731836;3774.2640185163905;4152.563980782034;4601.723896566216;33091.172720681934;33288.50067248993;33478;33870.1532461688;33918.6608133918;4484.686071974963;4500.549945005506;4528.88677783058;4555.772211389417;4570.131674981742;321989;325150;325291;326666;327141.9999999976;37760.24479510394;37864.242715146094;37874;37901.43147852785;38050;39002.804985974886;39086.218275634325;39341.213175736324;39371;39435.60564394377;17169.227384767717;17733.822661773218;17894.642107158044;17957.371491997717;18041.729374059138;13156.342182891009;13172.868271317357;13198.27409492468;13218.60344189676;13251.536196233086;20965.580688386453;21021.05405256767;21041.527093103337;21159.576808463746;21174.78825211759;7648.235176482419;7731.5747633879555;7788.961055194801;7816.218378162138;7848.686052557834;1011.4841430870309;1013.3362647465922;1160.6169963911889;1174.8162479680163;1180.8819118088122;31861;33636.831815840764;33916.83041584826;34197.48703769445;34262;1222.0162768970886;1227.0919519555464;1232.186756740547;1242.7079636285466;1247.5945317771761;17115.315387384613;17542;17601.823981760273;17771;17979.73030404545;646474;648844;651851;652778;653285;64589.67705161444;64914;65849;65994;66013.66993165003;1445.927703614836;1452.6295794572527;1480.9407623695147;1482.2514630111941;1487.0631502153574;32849.34301314008;33223.66776332206;33512;33935.98192054144;34014.319713605095;55376.72311638577;56113.719431402584;56209.43790562042;56257.71871140782;56268.71865640809;545465;550806;552374;555497;557250;29873;30514.694853052075;30623.387532249675;30781.384372312878;30785.692143078282;51975.2203716937;52266.47733522768;52620.73689631528;52758;53458.73270633622;43498.34752478779;44372.33441498445;44569.55430445654;45369.54630453653;46436;44444.33333500065;46093.76953115347;46377;46475.86330863387;46708.299375510076;45544.31683524816;45604.315935261664;46107;46583.76708116573;49441.25838112503;38351.80824095861;38976;39808.60191398049;40381.39427908525;40786.1842763149;30247.243818903822;30835.69164308418;30878.691213087583;30968.53547196839;31574 04:20:58 INFO - PROCESS | 4184 | |2;jquery.html;397.906491974386;401.42796514966165;422.72945314998407;430.2019753357522;435.6819521749123;19784.40646780597;20356;20540.281090161847;21358.359249222547;22039.228626998058;18809.341673041446;19581.412557623295;20181.192752289928;20684.48288792781;20944.26695065673;6042.969785151079;6267.122602835607;6267.373262673742;6269.498440124779;6287.245530536342;6133.693315334238;6163.599366041193;6188.5358598105095;6192.907106393408;6203.658798766066;5995.190649262359;6084.878302433949;6128.938710612882;6163.1063495793305;6169.7532098716;6051.697415129248;6085.817425477243;6095.481884039862;6133.264008318985;6148.108524264001;5060.721660308682;5431;5443.074677304868;5516.834494965157;5544.390117087117;13112.934435327763;13727.45090196391;13739.313034348343;13761;17658.735118973098;2364.846284991487;2595.195489398274;2709.024751089606;2813.1138691312376;2899.1737354853767;9871.753206169831;10061.14480269178;10230.488475576265;10245.692629221136;10285.074343309063;1929.9207496386355;1959.4317647882096;1969.7734760502583;1972.763268407786;2017.314113201504;85678.57160714157;90535.09464905332;93176.53411732966;93678.53160734221;95673.52163239209;11842.526298947945;11900;11902.761944761056;12141.089418293486;12302.384880755926;17138.571535711457;17171.227294771765;17271.74092388615;17301.134943252786;17319.826801732073;7595.772126836204;8045.83908321842;8127.552984585786;8183.590820458953;8764.21122099014;7997.200279971957;8062.919370806334;8211.137830527829;8235.094139644634;8303.875441868377;5036.521530454601;5128.564072053917;5142.382914050338;5155.046316431472;5259;2050.4463794775625;2058.176729308259;2112.926047588327;2120.4380839077658;2172.4677454023868;948.6300342866288;1030.7062487191265;1068.8984546468073;1079.9956040881898;1106.8007758603528;21172.894135529532;21264.681029784566;21302.680459793115;21336.253231136834;21425.892870535547;1085.3379438542484;1086.8804431512526;1094.3269889018197;1110.9444527773578;1126.4761885723178;10988.230823842254;11713.707157321136;11889.88110118905;11996.460159292852;12120.27278363301;568357;578230;585100;586326;590806;98355.50822245843;102255;102609;111064.4446777777;111229.44385278184;1053.9104176145113;1078.3152698036647;1098.1215027977587;1102.691246450995;1104.0339702760084;19006.904965475085;19403.126859291082;19512.8048719511;19610.901945490183;19854.90072549628;34627;46415.30377044279;46695.29957050579;46885.76557117193;48010.75994620004;64343.67828160829;69647;71254.28745712683;71888;72430.63784681042;8858.291336693179;9101.40840845343;9198.126178013077;9210.585523651585;9286.814263714823;10438.63464778729;13823.654408639864;14270.286485675468;14679.48621798232;14778.778318325449;12580.245185288912;12672.04959628013;12690.11169218146;12743.87256127427;12905.354732263537;11811.055115590903;12211.328376939353;12247.632571022883;12478.313692746986;12612.87387126117;12272.938635306766;12372;12467.812982805446;12536.435860386488;12816.55142070023;7880.763577092696;7898.052233731989;8062.7581172564915;9080.500572468578;9093.909060909305;8727.214550690469;11634.301941883175;12468.563600273947;12522.311272879715;12778.744425111632 04:20:58 INFO - PROCESS | 4184 | |3;mootools.html;1281.8461784585852;1431.9355628996698;1540.568640780581;1803.5130514761006;1824.854011679065;8155.388345874054;8254.504729716215;8571.914280857189;8777.122287771212;8803.20771130598;8626.827463450743;8904.554772261377;8942.329325300612;8953.328500362466;8955.283577313816;2432.501337225869;2463.1132792194794;2465.1988103866224;2475.3687809608523;2482.044412901037;2414.33605758417;2477.8017758579363;2481.2432208176497;2490.2778194323623;2496.3883848457062;2415.6014257647466;2441.023590563771;2471.4192164841247;2486.825922185448;2490.9128180513685;2356.4580146566213;2361.551305252005;2363.243761996162;2381.499885024147;2382.5949588569897;2340.6372012338115;2354.7527509611587;2358.233574088428;2362.350353652742;2363.7045369328835;9023.09769023099;9046.140616641409;9058.094190580889;9080.545972701339;9139.497327646977;5326.360836699582;5415.83752487426;5430.91853622196;5435.130379139318;5443.564514838803;3303.752218583616;3461.100113970386;3522.8590856365713;3533.0460775590445;3541.185527328703;1194.0805579703667;1242.763874863773;1249.843769528809;1250.7748605251143;1274.770541302565;12368;12405.193662411913;12418.565350212699;12431.875681243162;12460.376981150906;4502.347159661831;4619.4687610925175;4757.738324392122;4784.497627749106;4798.95201047992;10516.579336826595;10547.578096876192;10581;10588.470576471145;10592.523336449878;5335.493128152819;5380.973095134499;5382.542483888835;5392.838214853561;5405.324334458192;4394.1870753910625;4809.663323567317;4913.385826771653;4943.209086546207;4978.228374601942;4143.875683729493;4175.331946888544;4229.217594744982;4247.957520424756;4281.743095414223;1255.7927941889668;1259.1060347153623;1265.8923991460645;1269.6889262130837;1275.923444593309;1014.3356101753363;1017.2878984710732;1030.4023666273692;1035.694470131313;1043.3114144664485;5984.970075149684;6059.666718330534;6096.055111457731;6265.561410701298;6542.116814230113;998.1814911772277;1003;1023.7287118913493;1029.8300780371155;1032.5869652139204;3951.150502641888;3977.5226972762875;4020.2562525932794;4049.8987525312104;4103.138340948434;10537.367757934548;10893;10897.618583349546;10898.346099234072;10949;10670.519826607666;10808.89191108079;10822.02601765829;10841;10869.239153259354;8262.958685206655;8335.66657333712;8381.916180838236;8387.62255698495;8389.53857537829;5975.521958243243;5981.820545383645;6116.113163591165;6139.72371243304;6148.077788331786;9976.351537150353;9983.60065597368;9991.200703943521;9993.801983365252;10162.288639795144;10141.797164056825;10179.541920613443;10191.235657325878;10240.743981400226;10256.846147307946;7034.577925324497;7321.9633901832285;7447.813804654927;7663.846723065619;7748.186440423674;8700.56497175126;8743.606537705946;8750.431221970806;8763.561821908752;8836.91163088361;7514.62426878643;7685.385169186564;7758.7672369829;7819.296263336327;7925.920740792519;7534.886976695464;7574.128975167926;7633.1985141559335;7646.120696120018;7705.306522412786;7095.432365410651;7189;7191.101112360955;7201;7208.495405321577;4880.926786098283;5044.066847633199;5064.063148317573;5084.51697088776;5147.9227811583605;5115.64190506661;5276.366835979707;5309.522143007148;5324.680519168863;5337.919931200958 04:20:58 INFO - PROCESS | 4184 | |4;prototype.html;331.0928057123481;332.5792872016899;341.13862497194583;341.65492852219285;343.2551363541115;5777.740001699923;5783.71081445927;5839.452545075553;5847.502962248203;5854.44382783636;5714.885702285952;5727.398623144572;5786.71066446677;5789.797357092502;5798;4225.6408205302505;4335.9566404335865;4418.911621767563;4428.247197976336;4431.313146462304;4413.293872980324;4441.4004109445295;4457.10857828434;4469.418975533176;4470.770538102031;4456.6880318377725;4468.832616181149;4469.418975533176;4506.346579745951;4516.593506584407;4327.437433133704;4342.218400687875;4367.8471253506295;4418.911621767546;4427.848759322567;3872.206197729459;3881.408622464804;3887.844486220576;3904.726669133162;3910.608939106095;5587.804426845041;5620.9437905620825;5681.715914204273;5706.28671416073;5706.400827913051;5066.164082926312;5120.564751996085;5138.177891537336;5159.484051594848;5182.7408629568745;5934.5845790794665;5974.103884417372;5984.581079324449;5993.490553302974;5999.73001214942;4303.35449682547;4321.503027151886;4343.826246950118;4347.391365208873;4356.760378179199;6064.4541991221;6294.716737746812;6310.747570097191;6311.400416960428;6321.178246827929;4408.052268762167;4417.801198946056;4434.667399945017;4440.555944405533;4454.576815202616;4438.210044213551;4476.283794592915;4479.731216127043;4486.237339652267;4497.865064048084;4974.27872958419;5030.773615187252;5069.138246498104;5092.828649410582;5096.821611243663;6000.609960352563;6015.4586087252355;6049.094535221391;6078.665673387918;6094.786682466092;1512.4177191781023;1515.2348064227715;1535.9555502258347;1556.0352581399604;1561.1569752333612;976.7802244494932;979.304693667504;985.7831277119022;1005.2510879394897;1024.7386916336286;5848.590598658053;5876.500497457679;5889.823305300848;5913.58604897653;5935;6154.815355539341;6228;6256.468200202943;6258.249010118815;6259.843503912439;5742.971285143548;5857.560682948796;6016.488598469179;6062.363451837494;6091.238595175603;3374.8818791342187;3391.7281019617644;3391.847366868497;3423.5720534933134;3424.7260219182403;6329.461995730322;6522.771702990372;6542.938974223104;6594.373534514213;6607.306232845482;6389.9361006389345;6431.614103153825;6438.645874476855;6472.741090356333;6496.382843629847;6328.278840098802;6525.314841941623;6544.3782840630065;6568.1789776277965;6569.7006047883815;6311.191519773657;6328.6519241442165;6335.524835637438;6344.460720838596;6346.1432706585865;6163.506919446344;6190;6233.875322493615;6234.657093859882;6249.625022498664;6196.504279657526;6530.575512591667;6548.853950558729;6574.605523668595;6623.768168114093;4496.865094047183;4539.886502837456;4550.704204226715;4557.680962332737;4562.520935301745;6199.969000155151;6278.183836101278;6413.262474815269;6416.069669897932;6484.935150648433;6211.937880621136;6221.96889015552;6222.533310001859;6236.532260080603;6279.456819987912;6001.819945401645;6189.659568723763;6203.790260899262;6213.689315534296;6262.749490020348;5832.825015249549;5924;6033.974224381778;6108.297545782114;6118.694065296806;6177.660228687465;6181.350958149509;6193.84515387119;6212.365766026925;6269.655168965751;5946.583739138392;6040.848978775566;6054.54590905675;6056.36408177135;6076.6961651916345 04:20:58 INFO - PROCESS | 4184 | |5;yui.html;860.8106216632339;872.1975782280306;890.4123278636099;920.8112336970913;922.5295099499256;16545.66908661826;17510.737338939925;17552.64894702107;17557.561060973483;17563.82436175638;13510.729785404286;13533.188008719459;13618.387172577233;13681.726365472685;13692.110012849183;724.5326764237064;857.9914200858005;883.6156272021659;887.6804350433839;901.4996676844348;877.6489404238292;882.2500874256895;884.6815146547237;885.1590988560861;886.2289807867164;955.3026290807715;955.4649396338039;956.2684546322034;956.3544607390019;956.9330146889721;937.2174234514189;937.2221056523069;939.1172298039855;939.4175611121115;939.5443210043123;692.5567636712508;695.5200911371188;697.2783169419677;697.6128248821901;701.1901254051579;15421.766258699277;15571.299291531908;15577.454789082327;15606.375744970188;15623.531294061082;16580.336786528525;16779.46277728347;16833.01429906587;16911.323547058102;16930.322787088502;12582.496700131984;12907.806382904264;13089.345532723326;13154.21074735519;13660.248686322248;4711.623070154379;4724.102420540121;4767.451743049524;4783.402074740658;4822.758862056883;75642.24357756408;77505.99999999943;78059.60970195169;78373.60813195897;81179.18820811834;11906.404679765978;11963.40182990847;12005.699857503458;12053.578124765767;12279.815802762965;21496.4625884351;21519.35441936713;21539.707617542997;21564;21589;8613.181747733955;8662.177093176138;8814.118588141135;8883.644654213758;8891.19979201862;5020.322256495399;5064.746762661852;5208.479152084761;5251.711155886463;5292.338457692788;3598.136447252693;3750.099976005739;3752.1745216052423;3760.6615404613167;4099;683.9897401538882;688.0779755128152;702.2485940044104;707.3280383635566;711.1892442615423;672.8755180291662;701.7859552836434;744.7281742164071;748.4648476339444;790.2018960849468;9511.952440237754;9787.804243915081;10592.15262778976;10681.51933162994;10698.358098514114;678.7454704485817;701.2496628607341;726.8400951790703;742.8922806193071;781.7654703588901;4785.183932683155;5127.820526281637;5205.193195054772;5316.46835316473;5423.728813559306;112869.43565282285;128430;131255.34372328268;133752.33123834318;135279;116797.41601291939;118234.40882795531;118680;119937;121166;101856;103079.4846025765;103856.48071759744;105126;107020;9969.601215951281;9978.351407158512;10181.134603558485;10216.540255688364;10340.327878687862;57656;57950.7102464485;58108;58853.41146588479;58991.70504147452;47412;77745;79571.60214198891;79961;82042;12449.626511204679;12517;13146.60560183196;13416.12795168311;13647.38586763618;13643.86356136426;13698.863011370157;13789.448422063406;13957.58127256184;14518.346674399889;13802.309884505534;13871.653208669864;14225.786613201017;14278.928605356907;14317.498887538886;14159;14185;14641.121532708072;15183.16492592918;15206.923965380545;13341.19952802835;13479.39342729599;13981.860181398055;14288.28558572088;14297;9911.157551608194;9998.900011000087;10156.746081348025;10276.17790576737;10363.481825908524;10583.312084714777;11060.834087488854;11293.153013523854;11344.546218151512;11344.943275283571 04:20:58 INFO - PROCESS | 4184 | __end_tp_report 04:20:58 INFO - PROCESS | 4184 | __start_cc_report 04:20:58 INFO - PROCESS | 4184 | _x_x_mozilla_cycle_collect,340 04:20:58 INFO - PROCESS | 4184 | __end_cc_report 04:20:58 INFO - PROCESS | 4184 | __startTimestamp1474197658346__endTimestamp 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | ------- Summary: start ------- 04:20:58 INFO - PROCESS | 4184 | Number of tests: 6 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | [#0] dojo.html Cycles:165 Average:5670.25 Median:5908.23 stddev:655.27 (11.1%) stddev-sans-first:629.17 04:20:58 INFO - PROCESS | 4184 | Values: 3249.7 3252.3 3265.8 3294.7 3305.6 5656.9 5690.3 5752.9 5759.3 5778.9 5733.9 5781.2 5793.5 5799.4 5799.5 5172.6 5209.8 5223.5 5262.3 5310.0 5093.6 5094.1 5131.2 5140.4 5140.6 5172.9 5190.8 5201.9 5274.4 5276.2 5215.8 5231.1 5238.4 5254.2 5255.5 4947.6 4968.2 5116.6 5137.8 5138.2 5537.9 5585.9 5589.9 5624.9 5629.9 6033.4 6036.4 6038.3 6038.6 6064.0 5901.5 6002.2 6108.1 6112.0 6120.5 5618.3 5702.8 5720.3 5724.6 5763.1 6208.1 6222.7 6226.6 6226.8 6265.9 5822.5 5871.1 5975.8 6002.3 6009.4 5959.5 6093.9 6102.5 6116.7 6129.4 5995.6 6022.0 6030.3 6039.6 6065.0 5854.6 5936.2 6051.4 6062.1 6065.4 4540.3 4643.6 4658.0 4667.2 4677.0 4134.1 4141.2 4142.6 4161.3 4163.9 5622.4 5708.3 5805.2 5827.4 5828.2 6095.1 6168.8 6170.4 6196.1 6199.1 5892.4 5894.3 5900.2 5905.7 5912.9 5125.9 5204.9 5297.7 5310.9 5317.0 6250.8 6398.7 6410.4 6410.8 6411.9 6190.4 6193.6 6195.4 6195.7 6197.6 6064.0 6225.0 6385.0 6413.1 6414.9 5932.5 6101.7 6111.8 6113.1 6142.9 6176.7 6182.0 6190.4 6216.6 6222.0 5897.1 5958.1 6069.8 6085.3 6098.9 5953.1 5965.3 5976.9 5983.9 6005.6 5863.1 5899.6 5918.2 5941.1 5967.5 5908.2 5908.8 5932.6 5990.7 6005.2 5816.3 5909.4 5941.7 5950.1 5967.1 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | [#1] ext.html Cycles:180 Average:66363.29 Median:43936.45 stddev:140802.53 (320.5%) stddev-sans-first:141110.89 04:20:58 INFO - PROCESS | 4184 | Values: 581.2 620.0 650.6 654.5 699.7 42154.6 46313.8 46378.7 46429.5 46555.0 45057.8 45830.0 45872.0 45972.8 46010.0 8958.5 9001.6 9043.7 9055.5 9077.0 8971.5 8984.6 9026.9 9043.7 9071.1 9139.2 9191.0 9191.9 9195.0 9216.0 9062.7 9080.3 9086.9 9091.9 9110.6 8983.6 9109.2 9116.9 9137.6 9145.5 43067.6 43422.0 43422.3 43461.0 43500.6 3369.5 3763.6 3774.3 4152.6 4601.7 33091.2 33288.5 33478.0 33870.2 33918.7 4484.7 4500.5 4528.9 4555.8 4570.1 321989.0 325150.0 325291.0 326666.0 327142.0 37760.2 37864.2 37874.0 37901.4 38050.0 39002.8 39086.2 39341.2 39371.0 39435.6 17169.2 17733.8 17894.6 17957.4 18041.7 13156.3 13172.9 13198.3 13218.6 13251.5 20965.6 21021.1 21041.5 21159.6 21174.8 7648.2 7731.6 7789.0 7816.2 7848.7 1011.5 1013.3 1160.6 1174.8 1180.9 31861.0 33636.8 33916.8 34197.5 34262.0 1222.0 1227.1 1232.2 1242.7 1247.6 17115.3 17542.0 17601.8 17771.0 17979.7 646474.0 648844.0 651851.0 652778.0 653285.0 64589.7 64914.0 65849.0 65994.0 66013.7 1445.9 1452.6 1480.9 1482.3 1487.1 32849.3 33223.7 33512.0 33936.0 34014.3 55376.7 56113.7 56209.4 56257.7 56268.7 545465.0 550806.0 552374.0 555497.0 557250.0 29873.0 30514.7 30623.4 30781.4 30785.7 51975.2 52266.5 52620.7 52758.0 53458.7 43498.3 44372.3 44569.6 45369.5 46436.0 44444.3 46093.8 46377.0 46475.9 46708.3 45544.3 45604.3 46107.0 46583.8 49441.3 38351.8 38976.0 39808.6 40381.4 40786.2 30247.2 30835.7 30878.7 30968.5 31574.0 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | [#2] jquery.html Cycles:180 Average:32842.63 Median:21319.47 stddev:96003.25 (450.3%) stddev-sans-first:96241.65 04:20:58 INFO - PROCESS | 4184 | Values: 397.9 401.4 422.7 430.2 435.7 19784.4 20356.0 20540.3 21358.4 22039.2 18809.3 19581.4 20181.2 20684.5 20944.3 6043.0 6267.1 6267.4 6269.5 6287.2 6133.7 6163.6 6188.5 6192.9 6203.7 5995.2 6084.9 6128.9 6163.1 6169.8 6051.7 6085.8 6095.5 6133.3 6148.1 5060.7 5431.0 5443.1 5516.8 5544.4 13112.9 13727.5 13739.3 13761.0 17658.7 2364.8 2595.2 2709.0 2813.1 2899.2 9871.8 10061.1 10230.5 10245.7 10285.1 1929.9 1959.4 1969.8 1972.8 2017.3 85678.6 90535.1 93176.5 93678.5 95673.5 11842.5 11900.0 11902.8 12141.1 12302.4 17138.6 17171.2 17271.7 17301.1 17319.8 7595.8 8045.8 8127.6 8183.6 8764.2 7997.2 8062.9 8211.1 8235.1 8303.9 5036.5 5128.6 5142.4 5155.0 5259.0 2050.4 2058.2 2112.9 2120.4 2172.5 948.6 1030.7 1068.9 1080.0 1106.8 21172.9 21264.7 21302.7 21336.3 21425.9 1085.3 1086.9 1094.3 1110.9 1126.5 10988.2 11713.7 11889.9 11996.5 12120.3 568357.0 578230.0 585100.0 586326.0 590806.0 98355.5 102255.0 102609.0 111064.4 111229.4 1053.9 1078.3 1098.1 1102.7 1104.0 19006.9 19403.1 19512.8 19610.9 19854.9 34627.0 46415.3 46695.3 46885.8 48010.8 64343.7 69647.0 71254.3 71888.0 72430.6 8858.3 9101.4 9198.1 9210.6 9286.8 10438.6 13823.7 14270.3 14679.5 14778.8 12580.2 12672.0 12690.1 12743.9 12905.4 11811.1 12211.3 12247.6 12478.3 12612.9 12272.9 12372.0 12467.8 12536.4 12816.6 7880.8 7898.1 8062.8 9080.5 9093.9 8727.2 11634.3 12468.6 12522.3 12778.7 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | [#3] mootools.html Cycles:180 Average:5867.25 Median:4448.27 stddev:3280.47 (73.7%) stddev-sans-first:3271.57 04:20:58 INFO - PROCESS | 4184 | Values: 1281.8 1431.9 1540.6 1803.5 1824.9 8155.4 8254.5 8571.9 8777.1 8803.2 8626.8 8904.6 8942.3 8953.3 8955.3 2432.5 2463.1 2465.2 2475.4 2482.0 2414.3 2477.8 2481.2 2490.3 2496.4 2415.6 2441.0 2471.4 2486.8 2490.9 2356.5 2361.6 2363.2 2381.5 2382.6 2340.6 2354.8 2358.2 2362.4 2363.7 9023.1 9046.1 9058.1 9080.5 9139.5 5326.4 5415.8 5430.9 5435.1 5443.6 3303.8 3461.1 3522.9 3533.0 3541.2 1194.1 1242.8 1249.8 1250.8 1274.8 12368.0 12405.2 12418.6 12431.9 12460.4 4502.3 4619.5 4757.7 4784.5 4799.0 10516.6 10547.6 10581.0 10588.5 10592.5 5335.5 5381.0 5382.5 5392.8 5405.3 4394.2 4809.7 4913.4 4943.2 4978.2 4143.9 4175.3 4229.2 4248.0 4281.7 1255.8 1259.1 1265.9 1269.7 1275.9 1014.3 1017.3 1030.4 1035.7 1043.3 5985.0 6059.7 6096.1 6265.6 6542.1 998.2 1003.0 1023.7 1029.8 1032.6 3951.2 3977.5 4020.3 4049.9 4103.1 10537.4 10893.0 10897.6 10898.3 10949.0 10670.5 10808.9 10822.0 10841.0 10869.2 8263.0 8335.7 8381.9 8387.6 8389.5 5975.5 5981.8 6116.1 6139.7 6148.1 9976.4 9983.6 9991.2 9993.8 10162.3 10141.8 10179.5 10191.2 10240.7 10256.8 7034.6 7322.0 7447.8 7663.8 7748.2 8700.6 8743.6 8750.4 8763.6 8836.9 7514.6 7685.4 7758.8 7819.3 7925.9 7534.9 7574.1 7633.2 7646.1 7705.3 7095.4 7189.0 7191.1 7201.0 7208.5 4880.9 5044.1 5064.1 5084.5 5147.9 5115.6 5276.4 5309.5 5324.7 5337.9 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | [#4] prototype.html Cycles:180 Average:5137.37 Median:5867.03 stddev:1537.62 (26.2%) stddev-sans-first:1499.02 04:20:58 INFO - PROCESS | 4184 | Values: 331.1 332.6 341.1 341.7 343.3 5777.7 5783.7 5839.5 5847.5 5854.4 5714.9 5727.4 5786.7 5789.8 5798.0 4225.6 4336.0 4418.9 4428.2 4431.3 4413.3 4441.4 4457.1 4469.4 4470.8 4456.7 4468.8 4469.4 4506.3 4516.6 4327.4 4342.2 4367.8 4418.9 4427.8 3872.2 3881.4 3887.8 3904.7 3910.6 5587.8 5620.9 5681.7 5706.3 5706.4 5066.2 5120.6 5138.2 5159.5 5182.7 5934.6 5974.1 5984.6 5993.5 5999.7 4303.4 4321.5 4343.8 4347.4 4356.8 6064.5 6294.7 6310.7 6311.4 6321.2 4408.1 4417.8 4434.7 4440.6 4454.6 4438.2 4476.3 4479.7 4486.2 4497.9 4974.3 5030.8 5069.1 5092.8 5096.8 6000.6 6015.5 6049.1 6078.7 6094.8 1512.4 1515.2 1536.0 1556.0 1561.2 976.8 979.3 985.8 1005.3 1024.7 5848.6 5876.5 5889.8 5913.6 5935.0 6154.8 6228.0 6256.5 6258.2 6259.8 5743.0 5857.6 6016.5 6062.4 6091.2 3374.9 3391.7 3391.8 3423.6 3424.7 6329.5 6522.8 6542.9 6594.4 6607.3 6389.9 6431.6 6438.6 6472.7 6496.4 6328.3 6525.3 6544.4 6568.2 6569.7 6311.2 6328.7 6335.5 6344.5 6346.1 6163.5 6190.0 6233.9 6234.7 6249.6 6196.5 6530.6 6548.9 6574.6 6623.8 4496.9 4539.9 4550.7 4557.7 4562.5 6200.0 6278.2 6413.3 6416.1 6484.9 6211.9 6222.0 6222.5 6236.5 6279.5 6001.8 6189.7 6203.8 6213.7 6262.7 5832.8 5924.0 6034.0 6108.3 6118.7 6177.7 6181.4 6193.8 6212.4 6269.7 5946.6 6040.8 6054.5 6056.4 6076.7 04:20:58 INFO - PROCESS | 4184 | 04:20:58 INFO - PROCESS | 4184 | [#5] yui.html Cycles:180 Average:22710.26 Median:3751.14 stddev:34009.47 (906.6%) stddev-sans-first:34065.31 04:20:58 INFO - PROCESS | 4184 | Values: 860.8 872.2 890.4 920.8 922.5 16545.7 17510.7 17552.6 17557.6 17563.8 13510.7 13533.2 13618.4 13681.7 13692.1 724.5 858.0 883.6 887.7 901.5 877.6 882.3 884.7 885.2 886.2 955.3 955.5 956.3 956.4 956.9 937.2 937.2 939.1 939.4 939.5 692.6 695.5 697.3 697.6 701.2 15421.8 15571.3 15577.5 15606.4 15623.5 16580.3 16779.5 16833.0 16911.3 16930.3 12582.5 12907.8 13089.3 13154.2 13660.2 4711.6 4724.1 4767.5 4783.4 4822.8 75642.2 77506.0 78059.6 78373.6 81179.2 11906.4 11963.4 12005.7 12053.6 12279.8 21496.5 21519.4 21539.7 21564.0 21589.0 8613.2 8662.2 8814.1 8883.6 8891.2 5020.3 5064.7 5208.5 5251.7 5292.3 3598.1 3750.1 3752.2 3760.7 4099.0 684.0 688.1 702.2 707.3 711.2 672.9 701.8 744.7 748.5 790.2 9512.0 9787.8 10592.2 10681.5 10698.4 678.7 701.2 726.8 742.9 781.8 4785.2 5127.8 5205.2 5316.5 5423.7 112869.4 128430.0 131255.3 133752.3 135279.0 116797.4 118234.4 118680.0 119937.0 121166.0 101856.0 103079.5 103856.5 105126.0 107020.0 9969.6 9978.4 10181.1 10216.5 10340.3 57656.0 57950.7 58108.0 58853.4 58991.7 47412.0 77745.0 79571.6 79961.0 82042.0 12449.6 12517.0 13146.6 13416.1 13647.4 13643.9 13698.9 13789.4 13957.6 14518.3 13802.3 13871.7 14225.8 14278.9 14317.5 14159.0 14185.0 14641.1 15183.2 15206.9 13341.2 13479.4 13981.9 14288.3 14297.0 9911.2 9998.9 10156.7 10276.2 10363.5 10583.3 11060.8 11293.2 11344.5 11344.9 04:20:58 INFO - PROCESS | 4184 | -------- Summary: end -------- 04:20:58 INFO - PROCESS | 4184 | 04:20:59 INFO - TEST-INFO | 4184: exit 0 04:20:59 INFO - TEST-OK | dromaeo_css | took 1110707ms 04:20:59 INFO - TEST-START | kraken 04:20:59 INFO - operating with platform_type : linux_ 04:20:59 INFO - Initialising browser for kraken test... 04:20:59 INFO - TEST-INFO | started process 4448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODqJ7j/profile http://localhost:40658/getInfo.html) 04:21:03 INFO - PROCESS | 4448 | __metrics Screen width/height:1600/1200 04:21:03 INFO - PROCESS | 4448 | colorDepth:24 04:21:03 INFO - PROCESS | 4448 | Browser inner width/height: 1024/697 04:21:03 INFO - PROCESS | 4448 | __metrics 04:21:04 ERROR - PROCESS | 4448 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:21:04 INFO - TEST-INFO | 4448: exit 0 04:21:04 INFO - Browser initialized. 04:21:04 INFO - Running cycle 1/1 for kraken test... 04:21:04 INFO - TEST-INFO | started process 4574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODqJ7j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:16 INFO - PROCESS | 4574 | RSS: Main: 153509888 04:21:16 INFO - PROCESS | 4574 | 04:21:19 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40658/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:20 INFO - PROCESS | 4574 | RSS: Main: 158969856 04:21:20 INFO - PROCESS | 4574 | 04:21:22 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40658/tests/kraken/driver.html?testName=audio-dft) 04:21:23 INFO - PROCESS | 4574 | RSS: Main: 157450240 04:21:23 INFO - PROCESS | 4574 | 04:21:26 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40658/tests/kraken/driver.html?testName=audio-fft) 04:21:26 INFO - PROCESS | 4574 | RSS: Main: 158068736 04:21:26 INFO - PROCESS | 4574 | 04:21:28 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40658/tests/kraken/driver.html?testName=audio-oscillator) 04:21:29 INFO - PROCESS | 4574 | RSS: Main: 157691904 04:21:29 INFO - PROCESS | 4574 | 04:21:31 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:32 INFO - PROCESS | 4574 | RSS: Main: 157642752 04:21:32 INFO - PROCESS | 4574 | 04:21:35 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40658/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:36 INFO - PROCESS | 4574 | RSS: Main: 157831168 04:21:36 INFO - PROCESS | 4574 | 04:21:39 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40658/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:40 INFO - PROCESS | 4574 | RSS: Main: 158932992 04:21:40 INFO - PROCESS | 4574 | 04:21:42 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40658/tests/kraken/driver.html?testName=json-parse-financial) 04:21:43 INFO - PROCESS | 4574 | RSS: Main: 158322688 04:21:43 INFO - PROCESS | 4574 | 04:21:45 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:45 INFO - PROCESS | 4574 | RSS: Main: 157372416 04:21:45 INFO - PROCESS | 4574 | 04:21:47 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:48 INFO - PROCESS | 4574 | RSS: Main: 158371840 04:21:48 INFO - PROCESS | 4574 | 04:21:49 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:50 INFO - PROCESS | 4574 | RSS: Main: 158490624 04:21:50 INFO - PROCESS | 4574 | 04:21:53 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:53 INFO - PROCESS | 4574 | RSS: Main: 159072256 04:21:53 INFO - PROCESS | 4574 | 04:21:56 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:57 INFO - PROCESS | 4574 | RSS: Main: 158855168 04:21:57 INFO - PROCESS | 4574 | 04:21:58 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:40658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40658/tests/kraken/driver.html?testName=ai-astar) 04:21:59 INFO - PROCESS | 4574 | RSS: Main: 160559104 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | __start_tp_report 04:21:59 INFO - PROCESS | 4574 | _x_x_mozilla_page_load 04:21:59 INFO - PROCESS | 4574 | _x_x_mozilla_page_load_details 04:21:59 INFO - PROCESS | 4574 | |i|pagename|runs| 04:21:59 INFO - PROCESS | 4574 | |0;ai-astar;103;114;113;107;112;110;110;114;112;122 04:21:59 INFO - PROCESS | 4574 | |1;audio-beat-detection;143;114;150;167;117;148;148;116;168;121 04:21:59 INFO - PROCESS | 4574 | |2;audio-dft;161;163;164;161;164;160;160;161;161;163 04:21:59 INFO - PROCESS | 4574 | |3;audio-fft;76;76;75;176;76;76;75;75;165;75 04:21:59 INFO - PROCESS | 4574 | |4;audio-oscillator;85;88;153;84;83;84;148;84;83;141 04:21:59 INFO - PROCESS | 4574 | |5;imaging-gaussian-blur;118;117;119;117;117;117;118;118;117;117 04:21:59 INFO - PROCESS | 4574 | |6;imaging-darkroom;148;147;148;148;147;147;148;147;146;146 04:21:59 INFO - PROCESS | 4574 | |7;imaging-desaturate;96;95;96;96;97;96;95;97;96;96 04:21:59 INFO - PROCESS | 4574 | |8;json-parse-financial;53;52;53;51;55;52;51;51;51;54 04:21:59 INFO - PROCESS | 4574 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;59;60;60 04:21:59 INFO - PROCESS | 4574 | |10;stanford-crypto-aes;75;74;78;74;74;77;73;73;77;72 04:21:59 INFO - PROCESS | 4574 | |11;stanford-crypto-ccm;128;120;128;116;117;117;132;118;155;134 04:21:59 INFO - PROCESS | 4574 | |12;stanford-crypto-pbkdf2;153;153;152;151;152;155;151;149;152;150 04:21:59 INFO - PROCESS | 4574 | |13;stanford-crypto-sha256-iterative;63;62;61;62;62;61;61;62;60;65 04:21:59 INFO - PROCESS | 4574 | __end_tp_report 04:21:59 INFO - PROCESS | 4574 | __start_cc_report 04:21:59 INFO - PROCESS | 4574 | _x_x_mozilla_cycle_collect,855 04:21:59 INFO - PROCESS | 4574 | __end_cc_report 04:21:59 INFO - PROCESS | 4574 | __startTimestamp1474197719015__endTimestamp 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | ------- Summary: start ------- 04:21:59 INFO - PROCESS | 4574 | Number of tests: 14 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:4.97 (4.4%) stddev-sans-first:4.15 04:21:59 INFO - PROCESS | 4574 | Values: 103.0 114.0 113.0 107.0 112.0 110.0 110.0 114.0 112.0 122.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:148.00 stddev:20.78 (14.0%) stddev-sans-first:21.99 04:21:59 INFO - PROCESS | 4574 | Values: 143.0 114.0 150.0 167.0 117.0 148.0 148.0 116.0 168.0 121.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.62 04:21:59 INFO - PROCESS | 4574 | Values: 161.0 163.0 164.0 161.0 164.0 160.0 160.0 161.0 161.0 163.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.50 stddev:40.14 (53.2%) stddev-sans-first:42.02 04:21:59 INFO - PROCESS | 4574 | Values: 76.0 76.0 75.0 176.0 76.0 76.0 75.0 75.0 165.0 75.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:30.55 (36.4%) stddev-sans-first:31.68 04:21:59 INFO - PROCESS | 4574 | Values: 85.0 88.0 153.0 84.0 83.0 84.0 148.0 84.0 83.0 141.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 04:21:59 INFO - PROCESS | 4574 | Values: 118.0 117.0 119.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 04:21:59 INFO - PROCESS | 4574 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 146.0 146.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:21:59 INFO - PROCESS | 4574 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 95.0 97.0 96.0 96.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:1.42 (2.7%) stddev-sans-first:1.48 04:21:59 INFO - PROCESS | 4574 | Values: 53.0 52.0 53.0 51.0 55.0 52.0 51.0 51.0 51.0 54.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:21:59 INFO - PROCESS | 4574 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 59.0 60.0 60.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:2.00 (2.7%) stddev-sans-first:2.12 04:21:59 INFO - PROCESS | 4574 | Values: 75.0 74.0 78.0 74.0 74.0 77.0 73.0 73.0 77.0 72.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.00 stddev:12.06 (9.4%) stddev-sans-first:12.78 04:21:59 INFO - PROCESS | 4574 | Values: 128.0 120.0 128.0 116.0 117.0 117.0 132.0 118.0 155.0 134.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:152.00 stddev:1.69 (1.1%) stddev-sans-first:1.73 04:21:59 INFO - PROCESS | 4574 | Values: 153.0 153.0 152.0 151.0 152.0 155.0 151.0 149.0 152.0 150.0 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - PROCESS | 4574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.39 04:21:59 INFO - PROCESS | 4574 | Values: 63.0 62.0 61.0 62.0 62.0 61.0 61.0 62.0 60.0 65.0 04:21:59 INFO - PROCESS | 4574 | -------- Summary: end -------- 04:21:59 INFO - PROCESS | 4574 | 04:21:59 INFO - TEST-INFO | 4574: exit 0 04:21:59 INFO - TEST-OK | kraken | took 60870ms 04:21:59 INFO - SUITE-END | took 1171s 04:22:00 INFO - Completed test suite (00:19:31) 04:22:00 INFO - javascript benchmark 04:22:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7673.095977341418, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.6750324967497, 3252.2519820441285, 3265.820379879107, 3294.7364210863147, 3305.6363799981996, 5656.943430565693, 5690.345610254822, 5752.856178595537, 5759.280089988752, 5778.855528611776, 5733.885322293562, 5781.19063331134, 5793.478586927186, 5799.391063938289, 5799.478046975772, 5172.6379153459275, 5209.843704688847, 5223.477652234765, 5262.315898933152, 5309.973450132744, 5093.567046801008, 5094.083065048289, 5131.179011358184, 5140.357455318085, 5140.563052140573, 5172.8706782330555, 5190.792368305263, 5201.921971170416, 5274.393444753864, 5276.15581506959, 5215.817446389358, 5231.084560201987, 5238.423773384925, 5254.159334506479, 5255.474452554714, 4947.604191664658, 4968.180250258703, 5116.616253780981, 5137.768800403954, 5138.177891537336, 5537.916931246034, 5585.916211256835, 5589.944100559023, 5624.859378515529, 5629.887402251973, 6033.366496517846, 6036.396360363972, 6038.275406951194, 6038.637681739066, 6064.0, 5901.468867801918, 6002.189704389939, 6108.144859719643, 6112.022076467744, 6120.540959428061, 5618.269624948772, 5702.8289151325525, 5720.2849643794525, 5724.627899186539, 5763.1355296705415, 6208.068789681584, 6222.688865556704, 6226.62640241587, 6226.813195604139, 6265.937340626627, 5822.475977161991, 5871.089981052944, 5975.790847320323, 6002.339742628307, 6009.369016253318, 5959.523238140939, 6093.878122437615, 6102.4507794298725, 6116.724747386378, 6129.448349648553, 5995.580309378389, 6022.0, 6030.27636683592, 6039.607425517327, 6065.0, 5854.5901786875365, 5936.168936348915, 6051.394860513913, 6062.090686397076, 6065.423784740443, 4540.250858608359, 4643.628509719214, 4658.0, 4667.183242932473, 4676.95323046772, 4134.131832315187, 4141.171765646883, 4142.627163555295, 4161.2509748245, 4163.8959026024595, 5622.409646987089, 5708.257926469532, 5805.216295800097, 5827.4172582741385, 5828.213191219131, 6095.085737139376, 6168.753249870045, 6170.382961703794, 6196.10156527301, 6199.070139479114, 5892.351841297454, 5894.2926848778425, 5900.20347253124, 5905.704714764244, 5912.881742365129, 5125.923111153335, 5204.869878253074, 5297.735113244399, 5310.867228319323, 5317.042932272228, 6250.843728906813, 6398.680065996681, 6410.391012853772, 6410.775622853178, 6411.871762564816, 6190.41191086846, 6193.597416167935, 6195.4424101831055, 6195.721192546256, 6197.628142311476, 6063.969125248806, 6225.0, 6384.968075159594, 6413.102165696713, 6414.935850641434, 5932.525397968238, 6101.6644084574, 6111.804454079419, 6113.05926533857, 6142.938570614416, 6176.722047507783, 6181.9690901547, 6190.442860142609, 6216.595921265103, 6222.004479283293, 5897.085951677497, 5958.106284057253, 6069.757209711739, 6085.300190478151, 6098.908516372347, 5953.1070339449425, 5965.313988891333, 5976.8804623908145, 5983.880322393615, 6005.6396616203165, 5863.091220860773, 5899.557533184942, 5918.23063001807, 5941.1088336749835, 5967.49276311501, 5908.231929849264, 5908.763649454146, 5932.614380065282, 5990.6705131218205, 6005.249343832021, 5816.272965879265, 5909.438603332676, 5941.673207973603, 5950.077737950624, 5967.134765459071], "value": 5625.120720275001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1921429213394, 619.9566030377873, 650.5966300893443, 654.486228310776, 699.6536714326409, 42154.57845421545, 46313.7684311578, 46378.68106594665, 46429.535704642985, 46555.0, 45057.77471112648, 45830.0, 45872.0, 45972.77013614935, 46010.0, 8958.507282099497, 9001.639934402649, 9043.683471078513, 9055.501947392891, 9077.0, 8971.46171229725, 8984.550772461384, 9026.864597031017, 9043.683471078513, 9071.138241867013, 9139.177474027336, 9190.954045229764, 9191.908080919173, 9194.954025229865, 9215.953920230422, 9062.682806101788, 9080.318976076787, 9086.909570851474, 9091.909080909238, 9110.59002344896, 8983.595738191732, 9109.225715814164, 9116.8632470513, 9137.634494620208, 9145.542722863831, 43067.56932430698, 43422.0, 43422.348664770056, 43461.0, 43500.56499434997, 3369.5451114099774, 3763.5671897731836, 3774.2640185163905, 4152.563980782034, 4601.723896566216, 33091.172720681934, 33288.50067248993, 33478.0, 33870.1532461688, 33918.6608133918, 4484.686071974963, 4500.549945005506, 4528.88677783058, 4555.772211389417, 4570.131674981742, 321989.0, 325150.0, 325291.0, 326666.0, 327141.9999999976, 37760.24479510394, 37864.242715146094, 37874.0, 37901.43147852785, 38050.0, 39002.804985974886, 39086.218275634325, 39341.213175736324, 39371.0, 39435.60564394377, 17169.227384767717, 17733.822661773218, 17894.642107158044, 17957.371491997717, 18041.729374059138, 13156.342182891009, 13172.868271317357, 13198.27409492468, 13218.60344189676, 13251.536196233086, 20965.580688386453, 21021.05405256767, 21041.527093103337, 21159.576808463746, 21174.78825211759, 7648.235176482419, 7731.5747633879555, 7788.961055194801, 7816.218378162138, 7848.686052557834, 1011.4841430870309, 1013.3362647465922, 1160.6169963911889, 1174.8162479680163, 1180.8819118088122, 31861.0, 33636.831815840764, 33916.83041584826, 34197.48703769445, 34262.0, 1222.0162768970886, 1227.0919519555464, 1232.186756740547, 1242.7079636285466, 1247.5945317771761, 17115.315387384613, 17542.0, 17601.823981760273, 17771.0, 17979.73030404545, 646474.0, 648844.0, 651851.0, 652778.0, 653285.0, 64589.67705161444, 64914.0, 65849.0, 65994.0, 66013.66993165003, 1445.927703614836, 1452.6295794572527, 1480.9407623695147, 1482.2514630111941, 1487.0631502153574, 32849.34301314008, 33223.66776332206, 33512.0, 33935.98192054144, 34014.319713605095, 55376.72311638577, 56113.719431402584, 56209.43790562042, 56257.71871140782, 56268.71865640809, 545465.0, 550806.0, 552374.0, 555497.0, 557250.0, 29873.0, 30514.694853052075, 30623.387532249675, 30781.384372312878, 30785.692143078282, 51975.2203716937, 52266.47733522768, 52620.73689631528, 52758.0, 53458.73270633622, 43498.34752478779, 44372.33441498445, 44569.55430445654, 45369.54630453653, 46436.0, 44444.33333500065, 46093.76953115347, 46377.0, 46475.86330863387, 46708.299375510076, 45544.31683524816, 45604.315935261664, 46107.0, 46583.76708116573, 49441.25838112503, 38351.80824095861, 38976.0, 39808.60191398049, 40381.39427908525, 40786.1842763149, 30247.243818903822, 30835.69164308418, 30878.691213087583, 30968.53547196839, 31574.0], "value": 20998.02011885506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.906491974386, 401.42796514966165, 422.72945314998407, 430.2019753357522, 435.6819521749123, 19784.40646780597, 20356.0, 20540.281090161847, 21358.359249222547, 22039.228626998058, 18809.341673041446, 19581.412557623295, 20181.192752289928, 20684.48288792781, 20944.26695065673, 6042.969785151079, 6267.122602835607, 6267.373262673742, 6269.498440124779, 6287.245530536342, 6133.693315334238, 6163.599366041193, 6188.5358598105095, 6192.907106393408, 6203.658798766066, 5995.190649262359, 6084.878302433949, 6128.938710612882, 6163.1063495793305, 6169.7532098716, 6051.697415129248, 6085.817425477243, 6095.481884039862, 6133.264008318985, 6148.108524264001, 5060.721660308682, 5431.0, 5443.074677304868, 5516.834494965157, 5544.390117087117, 13112.934435327763, 13727.45090196391, 13739.313034348343, 13761.0, 17658.735118973098, 2364.846284991487, 2595.195489398274, 2709.024751089606, 2813.1138691312376, 2899.1737354853767, 9871.753206169831, 10061.14480269178, 10230.488475576265, 10245.692629221136, 10285.074343309063, 1929.9207496386355, 1959.4317647882096, 1969.7734760502583, 1972.763268407786, 2017.314113201504, 85678.57160714157, 90535.09464905332, 93176.53411732966, 93678.53160734221, 95673.52163239209, 11842.526298947945, 11900.0, 11902.761944761056, 12141.089418293486, 12302.384880755926, 17138.571535711457, 17171.227294771765, 17271.74092388615, 17301.134943252786, 17319.826801732073, 7595.772126836204, 8045.83908321842, 8127.552984585786, 8183.590820458953, 8764.21122099014, 7997.200279971957, 8062.919370806334, 8211.137830527829, 8235.094139644634, 8303.875441868377, 5036.521530454601, 5128.564072053917, 5142.382914050338, 5155.046316431472, 5259.0, 2050.4463794775625, 2058.176729308259, 2112.926047588327, 2120.4380839077658, 2172.4677454023868, 948.6300342866288, 1030.7062487191265, 1068.8984546468073, 1079.9956040881898, 1106.8007758603528, 21172.894135529532, 21264.681029784566, 21302.680459793115, 21336.253231136834, 21425.892870535547, 1085.3379438542484, 1086.8804431512526, 1094.3269889018197, 1110.9444527773578, 1126.4761885723178, 10988.230823842254, 11713.707157321136, 11889.88110118905, 11996.460159292852, 12120.27278363301, 568357.0, 578230.0, 585100.0, 586326.0, 590806.0, 98355.50822245843, 102255.0, 102609.0, 111064.4446777777, 111229.44385278184, 1053.9104176145113, 1078.3152698036647, 1098.1215027977587, 1102.691246450995, 1104.0339702760084, 19006.904965475085, 19403.126859291082, 19512.8048719511, 19610.901945490183, 19854.90072549628, 34627.0, 46415.30377044279, 46695.29957050579, 46885.76557117193, 48010.75994620004, 64343.67828160829, 69647.0, 71254.28745712683, 71888.0, 72430.63784681042, 8858.291336693179, 9101.40840845343, 9198.126178013077, 9210.585523651585, 9286.814263714823, 10438.63464778729, 13823.654408639864, 14270.286485675468, 14679.48621798232, 14778.778318325449, 12580.245185288912, 12672.04959628013, 12690.11169218146, 12743.87256127427, 12905.354732263537, 11811.055115590903, 12211.328376939353, 12247.632571022883, 12478.313692746986, 12612.87387126117, 12272.938635306766, 12372.0, 12467.812982805446, 12536.435860386488, 12816.55142070023, 7880.763577092696, 7898.052233731989, 8062.7581172564915, 9080.500572468578, 9093.909060909305, 8727.214550690469, 11634.301941883175, 12468.563600273947, 12522.311272879715, 12778.744425111632], "value": 9743.266084827254, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.8461784585852, 1431.9355628996698, 1540.568640780581, 1803.5130514761006, 1824.854011679065, 8155.388345874054, 8254.504729716215, 8571.914280857189, 8777.122287771212, 8803.20771130598, 8626.827463450743, 8904.554772261377, 8942.329325300612, 8953.328500362466, 8955.283577313816, 2432.501337225869, 2463.1132792194794, 2465.1988103866224, 2475.3687809608523, 2482.044412901037, 2414.33605758417, 2477.8017758579363, 2481.2432208176497, 2490.2778194323623, 2496.3883848457062, 2415.6014257647466, 2441.023590563771, 2471.4192164841247, 2486.825922185448, 2490.9128180513685, 2356.4580146566213, 2361.551305252005, 2363.243761996162, 2381.499885024147, 2382.5949588569897, 2340.6372012338115, 2354.7527509611587, 2358.233574088428, 2362.350353652742, 2363.7045369328835, 9023.09769023099, 9046.140616641409, 9058.094190580889, 9080.545972701339, 9139.497327646977, 5326.360836699582, 5415.83752487426, 5430.91853622196, 5435.130379139318, 5443.564514838803, 3303.752218583616, 3461.100113970386, 3522.8590856365713, 3533.0460775590445, 3541.185527328703, 1194.0805579703667, 1242.763874863773, 1249.843769528809, 1250.7748605251143, 1274.770541302565, 12368.0, 12405.193662411913, 12418.565350212699, 12431.875681243162, 12460.376981150906, 4502.347159661831, 4619.4687610925175, 4757.738324392122, 4784.497627749106, 4798.95201047992, 10516.579336826595, 10547.578096876192, 10581.0, 10588.470576471145, 10592.523336449878, 5335.493128152819, 5380.973095134499, 5382.542483888835, 5392.838214853561, 5405.324334458192, 4394.1870753910625, 4809.663323567317, 4913.385826771653, 4943.209086546207, 4978.228374601942, 4143.875683729493, 4175.331946888544, 4229.217594744982, 4247.957520424756, 4281.743095414223, 1255.7927941889668, 1259.1060347153623, 1265.8923991460645, 1269.6889262130837, 1275.923444593309, 1014.3356101753363, 1017.2878984710732, 1030.4023666273692, 1035.694470131313, 1043.3114144664485, 5984.970075149684, 6059.666718330534, 6096.055111457731, 6265.561410701298, 6542.116814230113, 998.1814911772277, 1003.0, 1023.7287118913493, 1029.8300780371155, 1032.5869652139204, 3951.150502641888, 3977.5226972762875, 4020.2562525932794, 4049.8987525312104, 4103.138340948434, 10537.367757934548, 10893.0, 10897.618583349546, 10898.346099234072, 10949.0, 10670.519826607666, 10808.89191108079, 10822.02601765829, 10841.0, 10869.239153259354, 8262.958685206655, 8335.66657333712, 8381.916180838236, 8387.62255698495, 8389.53857537829, 5975.521958243243, 5981.820545383645, 6116.113163591165, 6139.72371243304, 6148.077788331786, 9976.351537150353, 9983.60065597368, 9991.200703943521, 9993.801983365252, 10162.288639795144, 10141.797164056825, 10179.541920613443, 10191.235657325878, 10240.743981400226, 10256.846147307946, 7034.577925324497, 7321.9633901832285, 7447.813804654927, 7663.846723065619, 7748.186440423674, 8700.56497175126, 8743.606537705946, 8750.431221970806, 8763.561821908752, 8836.91163088361, 7514.62426878643, 7685.385169186564, 7758.7672369829, 7819.296263336327, 7925.920740792519, 7534.886976695464, 7574.128975167926, 7633.1985141559335, 7646.120696120018, 7705.306522412786, 7095.432365410651, 7189.0, 7191.101112360955, 7201.0, 7208.495405321577, 4880.926786098283, 5044.066847633199, 5064.063148317573, 5084.51697088776, 5147.9227811583605, 5115.64190506661, 5276.366835979707, 5309.522143007148, 5324.680519168863, 5337.919931200958], "value": 4737.166624401118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.0928057123481, 332.5792872016899, 341.13862497194583, 341.65492852219285, 343.2551363541115, 5777.740001699923, 5783.71081445927, 5839.452545075553, 5847.502962248203, 5854.44382783636, 5714.885702285952, 5727.398623144572, 5786.71066446677, 5789.797357092502, 5798.0, 4225.6408205302505, 4335.9566404335865, 4418.911621767563, 4428.247197976336, 4431.313146462304, 4413.293872980324, 4441.4004109445295, 4457.10857828434, 4469.418975533176, 4470.770538102031, 4456.6880318377725, 4468.832616181149, 4469.418975533176, 4506.346579745951, 4516.593506584407, 4327.437433133704, 4342.218400687875, 4367.8471253506295, 4418.911621767546, 4427.848759322567, 3872.206197729459, 3881.408622464804, 3887.844486220576, 3904.726669133162, 3910.608939106095, 5587.804426845041, 5620.9437905620825, 5681.715914204273, 5706.28671416073, 5706.400827913051, 5066.164082926312, 5120.564751996085, 5138.177891537336, 5159.484051594848, 5182.7408629568745, 5934.5845790794665, 5974.103884417372, 5984.581079324449, 5993.490553302974, 5999.73001214942, 4303.35449682547, 4321.503027151886, 4343.826246950118, 4347.391365208873, 4356.760378179199, 6064.4541991221, 6294.716737746812, 6310.747570097191, 6311.400416960428, 6321.178246827929, 4408.052268762167, 4417.801198946056, 4434.667399945017, 4440.555944405533, 4454.576815202616, 4438.210044213551, 4476.283794592915, 4479.731216127043, 4486.237339652267, 4497.865064048084, 4974.27872958419, 5030.773615187252, 5069.138246498104, 5092.828649410582, 5096.821611243663, 6000.609960352563, 6015.4586087252355, 6049.094535221391, 6078.665673387918, 6094.786682466092, 1512.4177191781023, 1515.2348064227715, 1535.9555502258347, 1556.0352581399604, 1561.1569752333612, 976.7802244494932, 979.304693667504, 985.7831277119022, 1005.2510879394897, 1024.7386916336286, 5848.590598658053, 5876.500497457679, 5889.823305300848, 5913.58604897653, 5935.0, 6154.815355539341, 6228.0, 6256.468200202943, 6258.249010118815, 6259.843503912439, 5742.971285143548, 5857.560682948796, 6016.488598469179, 6062.363451837494, 6091.238595175603, 3374.8818791342187, 3391.7281019617644, 3391.847366868497, 3423.5720534933134, 3424.7260219182403, 6329.461995730322, 6522.771702990372, 6542.938974223104, 6594.373534514213, 6607.306232845482, 6389.9361006389345, 6431.614103153825, 6438.645874476855, 6472.741090356333, 6496.382843629847, 6328.278840098802, 6525.314841941623, 6544.3782840630065, 6568.1789776277965, 6569.7006047883815, 6311.191519773657, 6328.6519241442165, 6335.524835637438, 6344.460720838596, 6346.1432706585865, 6163.506919446344, 6190.0, 6233.875322493615, 6234.657093859882, 6249.625022498664, 6196.504279657526, 6530.575512591667, 6548.853950558729, 6574.605523668595, 6623.768168114093, 4496.865094047183, 4539.886502837456, 4550.704204226715, 4557.680962332737, 4562.520935301745, 6199.969000155151, 6278.183836101278, 6413.262474815269, 6416.069669897932, 6484.935150648433, 6211.937880621136, 6221.96889015552, 6222.533310001859, 6236.532260080603, 6279.456819987912, 6001.819945401645, 6189.659568723763, 6203.790260899262, 6213.689315534296, 6262.749490020348, 5832.825015249549, 5924.0, 6033.974224381778, 6108.297545782114, 6118.694065296806, 6177.660228687465, 6181.350958149509, 6193.84515387119, 6212.365766026925, 6269.655168965751, 5946.583739138392, 6040.848978775566, 6054.54590905675, 6056.36408177135, 6076.6961651916345], "value": 4635.931096371207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.8106216632339, 872.1975782280306, 890.4123278636099, 920.8112336970913, 922.5295099499256, 16545.66908661826, 17510.737338939925, 17552.64894702107, 17557.561060973483, 17563.82436175638, 13510.729785404286, 13533.188008719459, 13618.387172577233, 13681.726365472685, 13692.110012849183, 724.5326764237064, 857.9914200858005, 883.6156272021659, 887.6804350433839, 901.4996676844348, 877.6489404238292, 882.2500874256895, 884.6815146547237, 885.1590988560861, 886.2289807867164, 955.3026290807715, 955.4649396338039, 956.2684546322034, 956.3544607390019, 956.9330146889721, 937.2174234514189, 937.2221056523069, 939.1172298039855, 939.4175611121115, 939.5443210043123, 692.5567636712508, 695.5200911371188, 697.2783169419677, 697.6128248821901, 701.1901254051579, 15421.766258699277, 15571.299291531908, 15577.454789082327, 15606.375744970188, 15623.531294061082, 16580.336786528525, 16779.46277728347, 16833.01429906587, 16911.323547058102, 16930.322787088502, 12582.496700131984, 12907.806382904264, 13089.345532723326, 13154.21074735519, 13660.248686322248, 4711.623070154379, 4724.102420540121, 4767.451743049524, 4783.402074740658, 4822.758862056883, 75642.24357756408, 77505.99999999943, 78059.60970195169, 78373.60813195897, 81179.18820811834, 11906.404679765978, 11963.40182990847, 12005.699857503458, 12053.578124765767, 12279.815802762965, 21496.4625884351, 21519.35441936713, 21539.707617542997, 21564.0, 21589.0, 8613.181747733955, 8662.177093176138, 8814.118588141135, 8883.644654213758, 8891.19979201862, 5020.322256495399, 5064.746762661852, 5208.479152084761, 5251.711155886463, 5292.338457692788, 3598.136447252693, 3750.099976005739, 3752.1745216052423, 3760.6615404613167, 4099.0, 683.9897401538882, 688.0779755128152, 702.2485940044104, 707.3280383635566, 711.1892442615423, 672.8755180291662, 701.7859552836434, 744.7281742164071, 748.4648476339444, 790.2018960849468, 9511.952440237754, 9787.804243915081, 10592.15262778976, 10681.51933162994, 10698.358098514114, 678.7454704485817, 701.2496628607341, 726.8400951790703, 742.8922806193071, 781.7654703588901, 4785.183932683155, 5127.820526281637, 5205.193195054772, 5316.46835316473, 5423.728813559306, 112869.43565282285, 128430.0, 131255.34372328268, 133752.33123834318, 135279.0, 116797.41601291939, 118234.40882795531, 118680.0, 119937.0, 121166.0, 101856.0, 103079.4846025765, 103856.48071759744, 105126.0, 107020.0, 9969.601215951281, 9978.351407158512, 10181.134603558485, 10216.540255688364, 10340.327878687862, 57656.0, 57950.7102464485, 58108.0, 58853.41146588479, 58991.70504147452, 47412.0, 77745.0, 79571.60214198891, 79961.0, 82042.0, 12449.626511204679, 12517.0, 13146.60560183196, 13416.12795168311, 13647.38586763618, 13643.86356136426, 13698.863011370157, 13789.448422063406, 13957.58127256184, 14518.346674399889, 13802.309884505534, 13871.653208669864, 14225.786613201017, 14278.928605356907, 14317.498887538886, 14159.0, 14185.0, 14641.121532708072, 15183.16492592918, 15206.923965380545, 13341.19952802835, 13479.39342729599, 13981.860181398055, 14288.28558572088, 14297.0, 9911.157551608194, 9998.900011000087, 10156.746081348025, 10276.17790576737, 10363.481825908524, 10583.312084714777, 11060.834087488854, 11293.153013523854, 11344.546218151512, 11344.943275283571], "value": 8074.421062108828, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 107.0, 112.0, 110.0, 110.0, 114.0, 112.0, 122.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 150.0, 167.0, 117.0, 148.0, 148.0, 116.0, 168.0, 121.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 161.0, 164.0, 160.0, 160.0, 161.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 176.0, 76.0, 76.0, 75.0, 75.0, 165.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 153.0, 84.0, 83.0, 84.0, 148.0, 84.0, 83.0, 141.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 55.0, 52.0, 51.0, 51.0, 51.0, 54.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 74.0, 74.0, 77.0, 73.0, 73.0, 77.0, 72.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 128.0, 116.0, 117.0, 117.0, 132.0, 118.0, 155.0, 134.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 152.0, 151.0, 152.0, 155.0, 151.0, 149.0, 152.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 60.0, 65.0], "value": 61.9, "unit": "score"}]}]} 04:22:00 INFO - Return code: 0 04:22:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:22:00 ERROR - # TBPL SUCCESS # 04:22:00 INFO - Running post-action listener: _resource_record_post_action 04:22:00 INFO - [mozharness: 2016-09-18 11:22:00.309731Z] Finished run-tests step (success) 04:22:00 INFO - Running post-run listener: _resource_record_post_run 04:22:00 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 696320; Write bytes: 328695808; Read time: 468; Write time: 346636 04:22:00 INFO - TinderboxPrint: CPU usage
13.2% 04:22:00 INFO - TinderboxPrint: I/O read bytes / time
696,320 / 468 04:22:00 INFO - TinderboxPrint: I/O write bytes / time
328,695,808 / 346,636 04:22:00 INFO - TinderboxPrint: CPU idle
8,225.2 (86.8%) 04:22:00 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 04:22:00 INFO - TinderboxPrint: Swap in / out
0 / 0 04:22:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 78422016; Read time: 232; Write time: 109076 04:22:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 688128; Write bytes: 249311232; Read time: 220; Write time: 237504 04:22:00 INFO - Running post-run listener: _upload_blobber_files 04:22:00 INFO - Blob upload gear active. 04:22:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:00 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 04:22:00 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'] 04:22:00 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 04:22:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:05 INFO - (blobuploader) - INFO - Done attempting. 04:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:06 INFO - (blobuploader) - INFO - Done attempting. 04:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:07 INFO - (blobuploader) - INFO - Done attempting. 04:22:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:07 INFO - Return code: 0 04:22:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e37ae273e9eceef2d24a7963cef69cc8136fac70e06ff11c47f4db712c5286669b499b6f5975c208c7f11f8ebed5f85042d45f2340dd79f947596a5968f2e864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7976d360fa1f5a8d9e688a12eb8ca936e618d333c2e479cf5b83fe11797bb81f06d3218195269c78e2086a75e21fc84a4f83823b592287b2ec16dad54788efc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50cbd3ae2d2322ce6a698f4bb385635399fc3dcb98604f9b53760a7ba945d4fdcd32877528b9df34d759d1cfd3ae25415424408842c66f10691293233222a0c"} 04:22:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:07 INFO - Contents: 04:22:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e37ae273e9eceef2d24a7963cef69cc8136fac70e06ff11c47f4db712c5286669b499b6f5975c208c7f11f8ebed5f85042d45f2340dd79f947596a5968f2e864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7976d360fa1f5a8d9e688a12eb8ca936e618d333c2e479cf5b83fe11797bb81f06d3218195269c78e2086a75e21fc84a4f83823b592287b2ec16dad54788efc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50cbd3ae2d2322ce6a698f4bb385635399fc3dcb98604f9b53760a7ba945d4fdcd32877528b9df34d759d1cfd3ae25415424408842c66f10691293233222a0c"} 04:22:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:07 INFO - Copying logs to upload dir... 04:22:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.489474 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-18 04:22:07.891617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 04:22:07.895360) ========= 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=0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381 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/e37ae273e9eceef2d24a7963cef69cc8136fac70e06ff11c47f4db712c5286669b499b6f5975c208c7f11f8ebed5f85042d45f2340dd79f947596a5968f2e864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7976d360fa1f5a8d9e688a12eb8ca936e618d333c2e479cf5b83fe11797bb81f06d3218195269c78e2086a75e21fc84a4f83823b592287b2ec16dad54788efc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50cbd3ae2d2322ce6a698f4bb385635399fc3dcb98604f9b53760a7ba945d4fdcd32877528b9df34d759d1cfd3ae25415424408842c66f10691293233222a0c"} build_url:https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/Jdxi_9r2Ss2Q5mXofg4CCA/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/e37ae273e9eceef2d24a7963cef69cc8136fac70e06ff11c47f4db712c5286669b499b6f5975c208c7f11f8ebed5f85042d45f2340dd79f947596a5968f2e864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7976d360fa1f5a8d9e688a12eb8ca936e618d333c2e479cf5b83fe11797bb81f06d3218195269c78e2086a75e21fc84a4f83823b592287b2ec16dad54788efc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50cbd3ae2d2322ce6a698f4bb385635399fc3dcb98604f9b53760a7ba945d4fdcd32877528b9df34d759d1cfd3ae25415424408842c66f10691293233222a0c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 04:22:07.921503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 04:22:07.922040) ========= 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=0e2a256762fed810e2f0f810000001b3-1474194421.385264-114333381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 04:22:08.004789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 04:22:08.005120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 04:22:08.005432) ========= ========= Total master_lag: 0.17 =========