builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1473418149.75 results: success (0) buildid: 20160909004004 builduid: 3eb85dec366a4c3ebecb09cd518bd8cf revision: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.752856) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.753320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.753596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.768421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.768798) ========= 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=6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-09 03:49:10-- 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% 37.8M=0s 2016-09-09 03:49:10 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.896786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.897099) ========= 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=6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018093 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.946706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:09.947068) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6cd56350a8953b0161a40064f0b332fbc93c6cb1 --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 6cd56350a8953b0161a40064f0b332fbc93c6cb1 --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=6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-09 03:49:10,874 truncating revision to first 12 chars 2016-09-09 03:49:10,874 Setting DEBUG logging. 2016-09-09 03:49:10,874 attempt 1/10 2016-09-09 03:49:10,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6cd56350a895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-09 03:49:11,442 unpacking tar archive at: mozilla-aurora-6cd56350a895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:10.875384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:10.875766) ========= script_repo_revision: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:10.876162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:10.876430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 03:49:10.887573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-09 03:49:10.887968) ========= /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=6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:11 INFO - MultiFileLogger online at 20160909 03:49:11 in /builds/slave/test 03:49:11 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:49:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:11 INFO - {'append_to_log': False, 03:49:11 INFO - 'base_work_dir': '/builds/slave/test', 03:49:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:49:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:11 INFO - 'branch': 'Mozilla-Aurora', 03:49:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:11 INFO - 'config_files': ('talos/linux_config.py',), 03:49:11 INFO - 'default_actions': ('clobber', 03:49:11 INFO - 'read-buildbot-config', 03:49:11 INFO - 'download-and-extract', 03:49:11 INFO - 'populate-webroot', 03:49:11 INFO - 'create-virtualenv', 03:49:11 INFO - 'install', 03:49:11 INFO - 'run-tests'), 03:49:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:11 INFO - 'download_minidump_stackwalk': True, 03:49:11 INFO - 'download_symbols': 'ondemand', 03:49:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:11 INFO - 'installer_path': 'installer.exe', 03:49:11 INFO - 'log_level': 'info', 03:49:11 INFO - 'log_name': 'talos', 03:49:11 INFO - 'log_to_console': True, 03:49:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:11 INFO - 'opt_config_files': (), 03:49:11 INFO - 'pip_index': False, 03:49:11 INFO - 'sps_profile': False, 03:49:11 INFO - 'sps_profile_interval': 0, 03:49:11 INFO - 'suite': 'dromaeojs-e10s', 03:49:11 INFO - 'system_bits': '32', 03:49:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:11 INFO - 'title': 'talos-linux64-ix-050', 03:49:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:11 INFO - 'use_talos_json': True, 03:49:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:11 INFO - 'work_dir': 'build'} 03:49:11 INFO - [mozharness: 2016-09-09 10:49:11.916614Z] Running clobber step. 03:49:11 INFO - Running pre-action listener: _resource_record_pre_action 03:49:11 INFO - Running main action method: clobber 03:49:11 INFO - rmtree: /builds/slave/test/build 03:49:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:12 INFO - Running post-action listener: _resource_record_post_action 03:49:12 INFO - [mozharness: 2016-09-09 10:49:12.378161Z] Finished clobber step (success) 03:49:12 INFO - [mozharness: 2016-09-09 10:49:12.378265Z] Running read-buildbot-config step. 03:49:12 INFO - Running pre-action listener: _resource_record_pre_action 03:49:12 INFO - Running main action method: read_buildbot_config 03:49:12 INFO - Using buildbot properties: 03:49:12 INFO - { 03:49:12 INFO - "project": "", 03:49:12 INFO - "product": "firefox", 03:49:12 INFO - "script_repo_revision": "production", 03:49:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:49:12 INFO - "repository": "", 03:49:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:49:12 INFO - "buildid": "20160909004004", 03:49:12 INFO - "stage_platform": "linux64-pgo", 03:49:12 INFO - "basedir": "/builds/slave/test", 03:49:12 INFO - "nightly_build": "True", 03:49:12 INFO - "buildnumber": 542, 03:49:12 INFO - "slavename": "talos-linux64-ix-050", 03:49:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:49:12 INFO - "platform": "ubuntu64_hw", 03:49:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:49:12 INFO - "branch": "mozilla-aurora", 03:49:12 INFO - "repo_path": "releases/mozilla-aurora", 03:49:12 INFO - "revision": "6cd56350a8953b0161a40064f0b332fbc93c6cb1", 03:49:12 INFO - "pgo_build": "True", 03:49:12 INFO - "builduid": "3eb85dec366a4c3ebecb09cd518bd8cf", 03:49:12 INFO - "slavebuilddir": "test" 03:49:12 INFO - } 03:49:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:49:12 INFO - Running post-action listener: _resource_record_post_action 03:49:12 INFO - [mozharness: 2016-09-09 10:49:12.380796Z] Finished read-buildbot-config step (success) 03:49:12 INFO - [mozharness: 2016-09-09 10:49:12.380886Z] Running download-and-extract step. 03:49:12 INFO - Running pre-action listener: _resource_record_pre_action 03:49:12 INFO - Running main action method: download_and_extract 03:49:12 INFO - mkdir: /builds/slave/test/build/tests 03:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:12 INFO - https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:49:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:49:12 INFO - retry: Failed, sleeping 30 seconds before retrying 03:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:49:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:49:42 INFO - retry: Failed, sleeping 60 seconds before retrying 03:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:50:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:50:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:50:42 INFO - Caught exception: HTTP Error 404: Not Found 03:50:42 INFO - Caught exception: HTTP Error 404: Not Found 03:50:42 INFO - Caught exception: HTTP Error 404: Not Found 03:50:42 INFO - trying https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:50:43 INFO - Downloaded 1361 bytes. 03:50:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:43 INFO - Using the following test package requirements: 03:50:43 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:43 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:43 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:50:43 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'jsshell-linux-x86_64.zip'], 03:50:43 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:43 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:43 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:50:43 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:50:43 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:43 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:43 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:43 INFO - https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:50:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:50:43 INFO - retry: Failed, sleeping 30 seconds before retrying 03:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:51:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:51:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:51:13 INFO - retry: Failed, sleeping 60 seconds before retrying 03:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:52:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:13 INFO - Caught exception: HTTP Error 404: Not Found 03:52:13 INFO - Caught exception: HTTP Error 404: Not Found 03:52:13 INFO - Caught exception: HTTP Error 404: Not Found 03:52:13 INFO - trying https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:13 INFO - Downloading https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:14 INFO - Downloaded 21769539 bytes. 03:52:14 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:52:14 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:52:15 INFO - Return code: 0 03:52:15 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:52:15 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:52:15 INFO - https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:52:15 INFO - retry: Failed, sleeping 30 seconds before retrying 03:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:52:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:52:45 INFO - retry: Failed, sleeping 60 seconds before retrying 03:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:53:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:53:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:53:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:53:45 INFO - Caught exception: HTTP Error 404: Not Found 03:53:45 INFO - Caught exception: HTTP Error 404: Not Found 03:53:45 INFO - Caught exception: HTTP Error 404: Not Found 03:53:45 INFO - trying https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:53:45 INFO - Downloading https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:53:46 INFO - Downloaded 21769539 bytes. 03:53:46 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:53:46 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:53:47 INFO - Return code: 0 03:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:47 INFO - https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:53:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:53:47 INFO - retry: Failed, sleeping 30 seconds before retrying 03:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:54:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:54:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:54:17 INFO - retry: Failed, sleeping 60 seconds before retrying 03:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:55:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:55:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:55:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:55:17 INFO - Caught exception: HTTP Error 404: Not Found 03:55:17 INFO - Caught exception: HTTP Error 404: Not Found 03:55:17 INFO - Caught exception: HTTP Error 404: Not Found 03:55:17 INFO - trying https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:55:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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:55:18 INFO - Downloaded 14413740 bytes. 03:55:18 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'] 03:55:18 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 03:55:18 INFO - Return code: 0 03:55: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')]} 03:55:18 INFO - https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:55:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:55:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:55:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:55:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:55:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:56:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:56:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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! 03:56:48 INFO - Caught exception: HTTP Error 404: Not Found 03:56:48 INFO - Caught exception: HTTP Error 404: Not Found 03:56:48 INFO - Caught exception: HTTP Error 404: Not Found 03:56:48 INFO - trying https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:48 INFO - Downloading https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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 03:56:49 INFO - Downloaded 63872865 bytes. 03:56:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:49 INFO - mkdir: /builds/slave/test/properties 03:56:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:56:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:56:49 INFO - Contents: 03:56:49 INFO - build_url:https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:50 INFO - Running post-action listener: _resource_record_post_action 03:56:50 INFO - Running post-action listener: set_extra_try_arguments 03:56:50 INFO - [mozharness: 2016-09-09 10:56:50.669057Z] Finished download-and-extract step (success) 03:56:50 INFO - [mozharness: 2016-09-09 10:56:50.669333Z] Running populate-webroot step. 03:56:50 INFO - Running pre-action listener: _resource_record_pre_action 03:56:50 INFO - Running main action method: populate_webroot 03:56:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:56:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:56:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:56:50 INFO - '--tppagecycles', 03:56:50 INFO - '7'], 03:56:50 INFO - 'tests': ['tsvgm']}}, 03:56:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:56:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:56:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:56:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:56:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['damp', 'tps']}, 03:56:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'tests': ['damp', 'tps']}, 03:56:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['dromaeo_dom']}, 03:56:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['basic_compositor_video']}, 03:56:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:56:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['a11yr', 03:56:50 INFO - 'ts_paint', 03:56:50 INFO - 'tpaint', 03:56:50 INFO - 'sessionrestore', 03:56:50 INFO - 'sessionrestore_no_auto_restore', 03:56:50 INFO - 'tabpaint']}, 03:56:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:56:50 INFO - 'ts_paint', 03:56:50 INFO - 'tpaint', 03:56:50 INFO - 'sessionrestore', 03:56:50 INFO - 'sessionrestore_no_auto_restore', 03:56:50 INFO - 'tabpaint']}, 03:56:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:56:50 INFO - 'ts_paint', 03:56:50 INFO - 'tpaint', 03:56:50 INFO - 'sessionrestore', 03:56:50 INFO - 'sessionrestore_no_auto_restore', 03:56:50 INFO - 'tabpaint']}, 03:56:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:56:50 INFO - 'ts_paint', 03:56:50 INFO - 'tpaint', 03:56:50 INFO - 'sessionrestore', 03:56:50 INFO - 'sessionrestore_no_auto_restore', 03:56:50 INFO - 'tabpaint']}, 03:56:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['a11yr', 03:56:50 INFO - 'ts_paint', 03:56:50 INFO - 'tpaint', 03:56:50 INFO - 'sessionrestore', 03:56:50 INFO - 'sessionrestore_no_auto_restore', 03:56:50 INFO - 'tabpaint']}, 03:56:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['a11yr', 03:56:50 INFO - 'ts_paint', 03:56:50 INFO - 'tpaint', 03:56:50 INFO - 'sessionrestore', 03:56:50 INFO - 'sessionrestore_no_auto_restore', 03:56:50 INFO - 'tabpaint']}, 03:56:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['tsvgx', 03:56:50 INFO - 'tsvgr_opacity', 03:56:50 INFO - 'tart', 03:56:50 INFO - 'tscrollx', 03:56:50 INFO - 'cart']}, 03:56:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:56:50 INFO - 'tsvgr_opacity', 03:56:50 INFO - 'tart', 03:56:50 INFO - 'tscrollx', 03:56:50 INFO - 'cart']}, 03:56:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'talos_options': ['--disable-e10s'], 03:56:50 INFO - 'tests': ['tp5o']}, 03:56:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'tests': ['tp5o']}, 03:56:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'talos_options': ['--disable-e10s', 03:56:50 INFO - '--xperf_path', 03:56:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:50 INFO - 'tests': ['tp5n']}, 03:56:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:50 INFO - 'talos_options': ['--xperf_path', 03:56:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:50 INFO - 'tests': ['tp5n']}}, 03:56:50 INFO - 'talos.zip': {'path': '', 03:56:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:56:50 INFO - Running post-action listener: _resource_record_post_action 03:56:50 INFO - [mozharness: 2016-09-09 10:56:50.687726Z] Finished populate-webroot step (success) 03:56:50 INFO - [mozharness: 2016-09-09 10:56:50.687816Z] Running create-virtualenv step. 03:56:50 INFO - Running pre-action listener: _resource_record_pre_action 03:56:50 INFO - Running main action method: create_virtualenv 03:56:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:56: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 03:56:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:56:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:50 INFO - Using real prefix '/usr' 03:56:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:56:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:53 INFO - Installing pip.................done. 03:56:53 INFO - Return code: 0 03:56:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:53 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:56:53 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 03:56:53 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 03:56:53 INFO - Using env: {'DISPLAY': ':0', 03:56:53 INFO - 'HOME': '/home/cltbld', 03:56:53 INFO - 'LANG': 'en_US.UTF-8', 03:56:53 INFO - 'LANGUAGE': 'en_US:en', 03:56:53 INFO - 'LOGNAME': 'cltbld', 03:56:53 INFO - 'MAIL': '/var/mail/cltbld', 03:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:53 INFO - 'MOZ_NO_REMOTE': '1', 03:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:53 INFO - 'NO_EM_RESTART': '1', 03:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:53 INFO - 'PWD': '/builds/slave/test', 03:56:53 INFO - 'SHELL': '/bin/bash', 03:56:53 INFO - 'SHLVL': '1', 03:56:53 INFO - 'TERM': 'linux', 03:56:53 INFO - 'TMOUT': '86400', 03:56:53 INFO - 'USER': 'cltbld', 03:56:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:53 INFO - '_': '/tools/buildbot/bin/python'} 03:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:53 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 03:56:53 INFO - Cleaning up... 03:56:53 INFO - Return code: 0 03:56:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:53 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:56:53 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 03:56:53 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 03:56:53 INFO - Using env: {'DISPLAY': ':0', 03:56:53 INFO - 'HOME': '/home/cltbld', 03:56:53 INFO - 'LANG': 'en_US.UTF-8', 03:56:53 INFO - 'LANGUAGE': 'en_US:en', 03:56:53 INFO - 'LOGNAME': 'cltbld', 03:56:53 INFO - 'MAIL': '/var/mail/cltbld', 03:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:53 INFO - 'MOZ_NO_REMOTE': '1', 03:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:53 INFO - 'NO_EM_RESTART': '1', 03:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:53 INFO - 'PWD': '/builds/slave/test', 03:56:53 INFO - 'SHELL': '/bin/bash', 03:56:53 INFO - 'SHLVL': '1', 03:56:53 INFO - 'TERM': 'linux', 03:56:53 INFO - 'TMOUT': '86400', 03:56:53 INFO - 'USER': 'cltbld', 03:56:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:53 INFO - '_': '/tools/buildbot/bin/python'} 03:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:53 INFO - Downloading/unpacking psutil>=3.1.1 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:55 INFO - Installing collected packages: psutil 03:56:55 INFO - Running setup.py install for psutil 03:56:55 INFO - building 'psutil._psutil_linux' extension 03:56: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 03:56: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 03:56:55 INFO - building 'psutil._psutil_posix' extension 03:56: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 03:56:56 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 03:56:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:56 INFO - Successfully installed psutil 03:56:56 INFO - Cleaning up... 03:56:56 INFO - Return code: 0 03:56:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:56 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:56:56 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 03:56:56 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 03:56:56 INFO - Using env: {'DISPLAY': ':0', 03:56:56 INFO - 'HOME': '/home/cltbld', 03:56:56 INFO - 'LANG': 'en_US.UTF-8', 03:56:56 INFO - 'LANGUAGE': 'en_US:en', 03:56:56 INFO - 'LOGNAME': 'cltbld', 03:56:56 INFO - 'MAIL': '/var/mail/cltbld', 03:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:56 INFO - 'MOZ_NO_REMOTE': '1', 03:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:56 INFO - 'NO_EM_RESTART': '1', 03:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:56 INFO - 'PWD': '/builds/slave/test', 03:56:56 INFO - 'SHELL': '/bin/bash', 03:56:56 INFO - 'SHLVL': '1', 03:56:56 INFO - 'TERM': 'linux', 03:56:56 INFO - 'TMOUT': '86400', 03:56:56 INFO - 'USER': 'cltbld', 03:56:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:56 INFO - '_': '/tools/buildbot/bin/python'} 03:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:56:58 INFO - Installing collected packages: mozsystemmonitor 03:56:58 INFO - Running setup.py install for mozsystemmonitor 03:56:58 INFO - Successfully installed mozsystemmonitor 03:56:58 INFO - Cleaning up... 03:56:58 INFO - Return code: 0 03:56:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:56:58 INFO - Using env: {'DISPLAY': ':0', 03:56:58 INFO - 'HOME': '/home/cltbld', 03:56:58 INFO - 'LANG': 'en_US.UTF-8', 03:56:58 INFO - 'LANGUAGE': 'en_US:en', 03:56:58 INFO - 'LOGNAME': 'cltbld', 03:56:58 INFO - 'MAIL': '/var/mail/cltbld', 03:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:58 INFO - 'MOZ_NO_REMOTE': '1', 03:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:58 INFO - 'NO_EM_RESTART': '1', 03:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:58 INFO - 'PWD': '/builds/slave/test', 03:56:58 INFO - 'SHELL': '/bin/bash', 03:56:58 INFO - 'SHLVL': '1', 03:56:58 INFO - 'TERM': 'linux', 03:56:58 INFO - 'TMOUT': '86400', 03:56:58 INFO - 'USER': 'cltbld', 03:56:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:58 INFO - '_': '/tools/buildbot/bin/python'} 03:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:57:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:00 INFO - warning: no files found matching '*.txt' 03:57:00 INFO - no previously-included directories found matching 'build' 03:57:00 INFO - no previously-included directories found matching 'dist' 03:57:00 INFO - no previously-included directories found matching '.git*' 03:57:00 INFO - Installing collected packages: jsonschema, functools32 03:57:00 INFO - Running setup.py install for functools32 03:57:01 INFO - warning: no files found matching '*.txt' 03:57:01 INFO - no previously-included directories found matching 'build' 03:57:01 INFO - no previously-included directories found matching 'dist' 03:57:01 INFO - no previously-included directories found matching '.git*' 03:57:01 INFO - Successfully installed jsonschema functools32 03:57:01 INFO - Cleaning up... 03:57:01 INFO - Return code: 0 03:57:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:01 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:57:01 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 03:57:01 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 03:57:01 INFO - Using env: {'DISPLAY': ':0', 03:57:01 INFO - 'HOME': '/home/cltbld', 03:57:01 INFO - 'LANG': 'en_US.UTF-8', 03:57:01 INFO - 'LANGUAGE': 'en_US:en', 03:57:01 INFO - 'LOGNAME': 'cltbld', 03:57:01 INFO - 'MAIL': '/var/mail/cltbld', 03:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:01 INFO - 'MOZ_NO_REMOTE': '1', 03:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:01 INFO - 'NO_EM_RESTART': '1', 03:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:01 INFO - 'PWD': '/builds/slave/test', 03:57:01 INFO - 'SHELL': '/bin/bash', 03:57:01 INFO - 'SHLVL': '1', 03:57:01 INFO - 'TERM': 'linux', 03:57:01 INFO - 'TMOUT': '86400', 03:57:01 INFO - 'USER': 'cltbld', 03:57:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:01 INFO - '_': '/tools/buildbot/bin/python'} 03:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:57:01 INFO - Cleaning up... 03:57:01 INFO - Return code: 0 03:57:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:01 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:57:01 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 03:57:01 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 03:57:01 INFO - Using env: {'DISPLAY': ':0', 03:57:01 INFO - 'HOME': '/home/cltbld', 03:57:01 INFO - 'LANG': 'en_US.UTF-8', 03:57:01 INFO - 'LANGUAGE': 'en_US:en', 03:57:01 INFO - 'LOGNAME': 'cltbld', 03:57:01 INFO - 'MAIL': '/var/mail/cltbld', 03:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:01 INFO - 'MOZ_NO_REMOTE': '1', 03:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:01 INFO - 'NO_EM_RESTART': '1', 03:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:01 INFO - 'PWD': '/builds/slave/test', 03:57:01 INFO - 'SHELL': '/bin/bash', 03:57:01 INFO - 'SHLVL': '1', 03:57:01 INFO - 'TERM': 'linux', 03:57:01 INFO - 'TMOUT': '86400', 03:57:01 INFO - 'USER': 'cltbld', 03:57:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:01 INFO - '_': '/tools/buildbot/bin/python'} 03:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:01 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 03:57:01 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 03:57:01 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 03:57:01 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 03:57:01 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 03:57:01 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 03:57:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:04 INFO - Downloading docopt-0.6.1.tar.gz 03:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:04 INFO - Running setup.py install for blobuploader 03:57:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:04 INFO - Running setup.py install for requests 03:57:04 INFO - Running setup.py install for docopt 03:57:04 INFO - Successfully installed blobuploader requests docopt 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:57: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 03:57: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 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:05 INFO - Running setup.py (path:/tmp/pip-stXyoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:05 INFO - Running setup.py (path:/tmp/pip-rcegqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:05 INFO - Running setup.py (path:/tmp/pip-Inj5vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:05 INFO - Running setup.py (path:/tmp/pip-hKZQFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:05 INFO - Running setup.py (path:/tmp/pip-LqN_iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:05 INFO - Running setup.py (path:/tmp/pip-1c6Mx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:05 INFO - Running setup.py (path:/tmp/pip-2_apsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:05 INFO - Running setup.py (path:/tmp/pip-XWy6NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:05 INFO - Running setup.py (path:/tmp/pip-4wsT9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:05 INFO - Running setup.py (path:/tmp/pip-cOLN7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:05 INFO - Running setup.py (path:/tmp/pip-A8sriZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:05 INFO - Running setup.py (path:/tmp/pip-IqRqtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:05 INFO - Running setup.py (path:/tmp/pip-ZMN29F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:05 INFO - Running setup.py (path:/tmp/pip-brL4Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:05 INFO - Running setup.py (path:/tmp/pip-d9g6Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:06 INFO - Running setup.py (path:/tmp/pip-IiIQY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:06 INFO - Running setup.py (path:/tmp/pip-h9g8Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:06 INFO - Running setup.py install for manifestparser 03:57:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:06 INFO - Running setup.py install for mozcrash 03:57:06 INFO - Running setup.py install for mozdebug 03:57:06 INFO - Running setup.py install for mozdevice 03:57:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:06 INFO - Running setup.py install for mozfile 03:57:06 INFO - Running setup.py install for mozhttpd 03:57:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:06 INFO - Running setup.py install for mozinfo 03:57:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:06 INFO - Running setup.py install for mozInstall 03:57:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Running setup.py install for mozleak 03:57:07 INFO - Running setup.py install for mozlog 03:57:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Running setup.py install for moznetwork 03:57:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Running setup.py install for mozprocess 03:57:07 INFO - Running setup.py install for mozprofile 03:57:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Running setup.py install for mozrunner 03:57:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Running setup.py install for mozscreenshot 03:57:07 INFO - Running setup.py install for moztest 03:57:07 INFO - Running setup.py install for mozversion 03:57:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:07 INFO - Cleaning up... 03:57:08 INFO - Return code: 0 03:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:08 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:57:08 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 03:57:08 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 03:57:08 INFO - Using env: {'DISPLAY': ':0', 03:57:08 INFO - 'HOME': '/home/cltbld', 03:57:08 INFO - 'LANG': 'en_US.UTF-8', 03:57:08 INFO - 'LANGUAGE': 'en_US:en', 03:57:08 INFO - 'LOGNAME': 'cltbld', 03:57:08 INFO - 'MAIL': '/var/mail/cltbld', 03:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:08 INFO - 'MOZ_NO_REMOTE': '1', 03:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:08 INFO - 'NO_EM_RESTART': '1', 03:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:08 INFO - 'PWD': '/builds/slave/test', 03:57:08 INFO - 'SHELL': '/bin/bash', 03:57:08 INFO - 'SHLVL': '1', 03:57:08 INFO - 'TERM': 'linux', 03:57:08 INFO - 'TMOUT': '86400', 03:57:08 INFO - 'USER': 'cltbld', 03:57:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:08 INFO - '_': '/tools/buildbot/bin/python'} 03:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:08 INFO - Running setup.py (path:/tmp/pip-EqDnD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:08 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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:08 INFO - Running setup.py (path:/tmp/pip-dKPJoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:08 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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:08 INFO - Running setup.py (path:/tmp/pip-H21CZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:08 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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:08 INFO - Running setup.py (path:/tmp/pip-9ZymTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:08 INFO - Running setup.py (path:/tmp/pip-5oyN7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:08 INFO - Running setup.py (path:/tmp/pip-Jg8qJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:08 INFO - Running setup.py (path:/tmp/pip-t4rVaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:08 INFO - Running setup.py (path:/tmp/pip-GrNYQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:08 INFO - Running setup.py (path:/tmp/pip-tg4ylF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:08 INFO - Running setup.py (path:/tmp/pip-Bb8D9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57: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)) 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:08 INFO - Running setup.py (path:/tmp/pip-6kZsxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:09 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)) 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:09 INFO - Running setup.py (path:/tmp/pip-t0JDd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:09 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)) 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:09 INFO - Running setup.py (path:/tmp/pip-RjeDMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:09 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)) 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:09 INFO - Running setup.py (path:/tmp/pip-S3qG2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:09 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)) 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:09 INFO - Running setup.py (path:/tmp/pip-sziBwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:09 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)) 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:09 INFO - Running setup.py (path:/tmp/pip-e7FNBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:09 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)) 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:09 INFO - Running setup.py (path:/tmp/pip-bJSWpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:09 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)) 03:57:09 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)) 03:57:09 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)) 03:57:09 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)) 03:57:09 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)) 03:57:09 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)) 03:57:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:09 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 03:57:09 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 03:57:09 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 03:57:09 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 03:57:09 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 03:57:09 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 03:57:11 INFO - Downloading blessings-1.6.tar.gz 03:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:11 INFO - Installing collected packages: blessings 03:57:11 INFO - Running setup.py install for blessings 03:57:11 INFO - Successfully installed blessings 03:57:11 INFO - Cleaning up... 03:57:11 INFO - Return code: 0 03:57:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:11 INFO - Reading from file tmpfile_stdout 03:57:11 INFO - Current package versions: 03:57:11 INFO - argparse == 1.2.1 03:57:11 INFO - blessings == 1.6 03:57:11 INFO - blobuploader == 1.2.4 03:57:11 INFO - docopt == 0.6.1 03:57:11 INFO - functools32 == 3.2.3-2 03:57:11 INFO - jsonschema == 2.5.1 03:57:11 INFO - manifestparser == 1.1 03:57:11 INFO - mozInstall == 1.12 03:57:11 INFO - mozcrash == 0.17 03:57:11 INFO - mozdebug == 0.1 03:57:11 INFO - mozdevice == 0.48 03:57:11 INFO - mozfile == 1.2 03:57:11 INFO - mozhttpd == 0.7 03:57:11 INFO - mozinfo == 0.9 03:57:11 INFO - mozleak == 0.1 03:57:11 INFO - mozlog == 3.3 03:57:11 INFO - moznetwork == 0.27 03:57:11 INFO - mozprocess == 0.23 03:57:11 INFO - mozprofile == 0.28 03:57:11 INFO - mozrunner == 6.12 03:57:11 INFO - mozscreenshot == 0.1 03:57:11 INFO - mozsystemmonitor == 0.3 03:57:11 INFO - moztest == 0.7 03:57:11 INFO - mozversion == 1.4 03:57:11 INFO - psutil == 3.1.1 03:57:11 INFO - requests == 1.2.3 03:57:11 INFO - wsgiref == 0.1.2 03:57:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:57: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 03:57: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 03:57:11 INFO - Using env: {'DISPLAY': ':0', 03:57:11 INFO - 'HOME': '/home/cltbld', 03:57:11 INFO - 'LANG': 'en_US.UTF-8', 03:57:11 INFO - 'LANGUAGE': 'en_US:en', 03:57:11 INFO - 'LOGNAME': 'cltbld', 03:57:11 INFO - 'MAIL': '/var/mail/cltbld', 03:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:11 INFO - 'MOZ_NO_REMOTE': '1', 03:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:11 INFO - 'NO_EM_RESTART': '1', 03:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:11 INFO - 'PWD': '/builds/slave/test', 03:57:11 INFO - 'SHELL': '/bin/bash', 03:57:11 INFO - 'SHLVL': '1', 03:57:11 INFO - 'TERM': 'linux', 03:57:11 INFO - 'TMOUT': '86400', 03:57:11 INFO - 'USER': 'cltbld', 03:57:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:11 INFO - '_': '/tools/buildbot/bin/python'} 03:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 INFO - Cleaning up... 03:57:12 INFO - Return code: 0 03:57:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:12 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 0x1955030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b84400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, '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': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', '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 03:57:12 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 03:57:12 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 03:57:12 INFO - Using env: {'DISPLAY': ':0', 03:57:12 INFO - 'HOME': '/home/cltbld', 03:57:12 INFO - 'LANG': 'en_US.UTF-8', 03:57:12 INFO - 'LANGUAGE': 'en_US:en', 03:57:12 INFO - 'LOGNAME': 'cltbld', 03:57:12 INFO - 'MAIL': '/var/mail/cltbld', 03:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:12 INFO - 'MOZ_NO_REMOTE': '1', 03:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:12 INFO - 'NO_EM_RESTART': '1', 03:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:12 INFO - 'PWD': '/builds/slave/test', 03:57:12 INFO - 'SHELL': '/bin/bash', 03:57:12 INFO - 'SHLVL': '1', 03:57:12 INFO - 'TERM': 'linux', 03:57:12 INFO - 'TMOUT': '86400', 03:57:12 INFO - 'USER': 'cltbld', 03:57:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:12 INFO - '_': '/tools/buildbot/bin/python'} 03:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:57:12 INFO - Cleaning up... 03:57:12 INFO - Return code: 0 03:57:12 INFO - Running post-action listener: _resource_record_post_action 03:57:12 INFO - Running post-action listener: _start_resource_monitoring 03:57:12 INFO - Starting resource monitoring. 03:57:12 INFO - [mozharness: 2016-09-09 10:57:12.317629Z] Finished create-virtualenv step (success) 03:57:12 INFO - [mozharness: 2016-09-09 10:57:12.318060Z] Running install step. 03:57:12 INFO - Running pre-action listener: _resource_record_pre_action 03:57:12 INFO - Running main action method: install 03:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:12 INFO - Reading from file tmpfile_stdout 03:57:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:12 INFO - Reading from file tmpfile_stdout 03:57:12 INFO - Output received: 03:57:12 INFO - Usage: mozinstall [options] installer 03:57:12 INFO - Options: 03:57:12 INFO - -h, --help show this help message and exit 03:57:12 INFO - -d DEST, --destination=DEST 03:57:12 INFO - Directory to install application into. [default: 03:57:12 INFO - "/builds/slave/test"] 03:57:12 INFO - --app=APP Application being installed. [default: firefox] 03:57:12 INFO - mkdir: /builds/slave/test/build/application 03:57: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'] 03:57: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 03:57:29 INFO - Reading from file tmpfile_stdout 03:57:29 INFO - Output received: 03:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:29 INFO - Running post-action listener: _resource_record_post_action 03:57:29 INFO - [mozharness: 2016-09-09 10:57:29.183913Z] Finished install step (success) 03:57:29 INFO - [mozharness: 2016-09-09 10:57:29.184250Z] Running run-tests step. 03:57:29 INFO - Running pre-action listener: _resource_record_pre_action 03:57:29 INFO - Running main action method: run_tests 03:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:29 INFO - Python 2.7.3 03:57:29 INFO - Return code: 0 03:57:29 INFO - grabbing minidump binary from tooltool 03:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:29 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 0x1c13570>, '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 0x1c14470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c14900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:29 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 03:57:29 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 03:57:29 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 03:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:29 INFO - Return code: 0 03:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:29 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/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:57:29 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/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:57:29 INFO - Using env: {'DISPLAY': ':0', 03:57:29 INFO - 'HOME': '/home/cltbld', 03:57:29 INFO - 'LANG': 'en_US.UTF-8', 03:57:29 INFO - 'LANGUAGE': 'en_US:en', 03:57:29 INFO - 'LOGNAME': 'cltbld', 03:57:29 INFO - 'MAIL': '/var/mail/cltbld', 03:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:29 INFO - 'MOZ_NO_REMOTE': '1', 03:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:29 INFO - 'NO_EM_RESTART': '1', 03:57:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:29 INFO - 'PWD': '/builds/slave/test', 03:57:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:29 INFO - 'SHELL': '/bin/bash', 03:57:29 INFO - 'SHLVL': '1', 03:57:29 INFO - 'TERM': 'linux', 03:57:29 INFO - 'TMOUT': '86400', 03:57:29 INFO - 'USER': 'cltbld', 03:57:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349', 03:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:29 INFO - '_': '/tools/buildbot/bin/python'} 03:57:29 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/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:57:29 INFO - mozversion application_buildid: 20160909004004 03:57:29 INFO - mozversion application_changeset: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 03:57:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:57:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:29 INFO - mozversion application_name: Firefox 03:57:29 INFO - mozversion application_remotingname: firefox-dev 03:57:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:29 INFO - mozversion application_vendor: Mozilla 03:57:29 INFO - mozversion application_version: 50.0a2 03:57:29 INFO - mozversion platform_buildid: 20160909004004 03:57:29 INFO - mozversion platform_changeset: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 03:57:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:29 INFO - mozversion platform_version: 50.0a2 03:57:29 INFO - using testdate: 1473418649 03:57:29 INFO - actual date: 1473418649 03:57:29 INFO - starting webserver on 'localhost:40944' 03:57:29 INFO - SUITE-START | Running 2 tests 03:57:29 INFO - TEST-START | dromaeo_css 03:57:29 INFO - operating with platform_type : linux_ 03:57:29 INFO - Initialising browser for dromaeo_css test... 03:57:29 INFO - TEST-INFO | started process 1306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSTBC2u/profile http://localhost:40944/getInfo.html) 03:57:33 INFO - PROCESS | 1306 | __metrics Screen width/height:1600/1200 03:57:33 INFO - PROCESS | 1306 | colorDepth:24 03:57:33 INFO - PROCESS | 1306 | Browser inner width/height: 1024/697 03:57:33 INFO - PROCESS | 1306 | __metrics 03:57:34 ERROR - PROCESS | 1306 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:57:35 INFO - TEST-INFO | 1306: exit 0 03:57:35 INFO - Browser initialized. 03:57:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:35 INFO - TEST-INFO | started process 1431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSTBC2u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:46 INFO - PROCESS | 1431 | RSS: Main: 152973312 03:57:47 INFO - PROCESS | 1431 | 03:58:36 INFO - PROCESS | 1431 | 1473418716575 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:00:45 INFO - PROCESS | 1431 | Cycle 1(1): loaded http://localhost:40944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40944/tests/dromaeo/cssquery-ext.html) 04:00:46 INFO - PROCESS | 1431 | RSS: Main: 159838208 04:00:46 INFO - PROCESS | 1431 | 04:03:48 INFO - PROCESS | 1431 | Cycle 1(1): loaded http://localhost:40944/tests/dromaeo/cssquery-ext.html (next: http://localhost:40944/tests/dromaeo/cssquery-jquery.html) 04:03:49 INFO - PROCESS | 1431 | RSS: Main: 155635712 04:03:49 INFO - PROCESS | 1431 | 04:06:50 INFO - PROCESS | 1431 | Cycle 1(1): loaded http://localhost:40944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40944/tests/dromaeo/cssquery-mootools.html) 04:06:51 INFO - PROCESS | 1431 | RSS: Main: 156704768 04:06:51 INFO - PROCESS | 1431 | 04:09:53 INFO - PROCESS | 1431 | Cycle 1(1): loaded http://localhost:40944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40944/tests/dromaeo/cssquery-prototype.html) 04:09:53 INFO - PROCESS | 1431 | RSS: Main: 155082752 04:09:53 INFO - PROCESS | 1431 | 04:12:56 INFO - PROCESS | 1431 | Cycle 1(1): loaded http://localhost:40944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40944/tests/dromaeo/cssquery-yui.html) 04:12:56 INFO - PROCESS | 1431 | RSS: Main: 157421568 04:12:56 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | Cycle 1(1): loaded http://localhost:40944/tests/dromaeo/cssquery-yui.html (next: http://localhost:40944/tests/dromaeo/cssquery-dojo.html) 04:15:59 INFO - PROCESS | 1431 | RSS: Main: 157028352 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | __start_tp_report 04:15:59 INFO - PROCESS | 1431 | _x_x_mozilla_page_load 04:15:59 INFO - PROCESS | 1431 | _x_x_mozilla_page_load_details 04:15:59 INFO - PROCESS | 1431 | |i|pagename|runs| 04:15:59 INFO - PROCESS | 1431 | |0;dojo.html;3256.251062255681;3300.966990330096;3321.302526469443;3328.7170590499804;3337.115664348946;5652.604317697763;5734.598578099534;5738.053221218499;5742.109972954188;5765.625234359774;5668.716564171786;5747.626404283729;5767.36558978512;5770.249867517216;5781;5134.281200631905;5216.478352164772;5261.710605916673;5272.973635131819;5278.445763194867;5097.413797413308;5128.384593848743;5135.897282054357;5155.639105262614;5184.740762961856;5212.270282160501;5217.165253559431;5241.5020573045695;5291.497307755776;5307.363116426034;5254.605904557174;5279.604029697788;5291.3385826771655;5294.1529355303355;5302.09864323066;4977.377827771528;5028.044671512401;5160.458151894035;5187.559057480119;5242.449542798027;5488.121900495901;5611.046122159243;5642.463965923231;5663.886722265573;5710;6062;6109.541784366146;6124.846878828021;6133.846653833645;6134.202553668039;5998.430149135826;6167.383261673842;6173;6176.382361763833;6194.194754681863;5638.154276858463;5677.971610141964;5703.942960570383;5779.422057794187;5802.303723553158;6247.812565623039;6296.622202667854;6298.968505157536;6301.212348456443;6306.4639505642535;5856.970715146482;6003.549733769897;6009.699515024231;6019;6029.698515074228;5978.432048955342;6005.669688167192;6027.969860150672;6112.898653789767;6113.749968913926;6039.305479869871;6059.969700151471;6060.484858786965;6064.878702425926;6082.270127584629;5914.201582786355;6073.817785466443;6106.328303886569;6107.541934354941;6108.08378743192;4702.224133018014;4749.453812811502;4749.881252968635;4790.449098353734;4823.348847905558;4241.724287921275;4245.299525578245;4255.723377980421;4256.5105012923295;4279.743215407086;5785.971070144622;6031.517478601701;6042.214512113397;6045.455908968214;6063.938810708109;6108.493847774667;6111.287884814209;6120.17377654011;6237.937620623827;6243.75024999004;6036.3360030396625;6038.033914573735;6047.516198704093;6047.624040703569;6092.390760923872;5253.632245742838;5408.729563521887;5414.972925135349;5422.349318081855;5430.891382172414;6369.71336289868;6379.266384365765;6421.3899679531305;6542.280349161683;6551.836204094936;6197.566170368031;6218.720157592828;6229.96885015572;6239.344868788712;6240.563160578716;6289.559730818799;6463.64449955257;6478.967605161944;6523.217213934358;6523.575967562093;5984.222051133324;5989.191459153133;6020.969895150496;6073.30157031947;6118.908216376669;6160.1888088907335;6187.978983467678;6191.071339299141;6194.194754681863;6202;5817.360090389969;6014.428629280386;6030.427109424598;6036.064410016279;6045.516358691206;5892.440218179266;5925.111233315038;5928.436798504135;5959.4934430573885;6034.728437220423;5888.3228428729535;5935.9109613356695;5948;5968.432998865101;5984.700764961822;5925.170476133431;5946.316173639913;6035.818925432244;6068.4841788448475;6076.939230607814;5801.535877129735;5827.854303642273;5853.09277062056;5917.6745279010065;5960.314563825043 04:15:59 INFO - PROCESS | 1431 | |1;ext.html;575.1459083261357;615.6398506873479;648.636763412489;651.0559688451746;667.9365460281272;40896.795516022416;46057;46142.30786538205;46185;46295.76852115739;47067;48002.27996580054;48259.75870120645;48528.75735621317;48536.514634853644;9008.909910900873;9216.2626989841;9216.769580760501;9219.907800922005;9244.214241789423;9150.908490915072;9217.861732074025;9222.723318300428;9243.16811486966;9243.722688319362;9180.632774689004;9215.447073175597;9244.768880778001;9245.815083698322;9259.027802080785;9061.093890610951;9179.357444978854;9182.127697868726;9198.264138868908;9200.171984521357;9186.908130918671;9272.907270927271;9273.536323183815;9282.489463079528;9301.162895339452;44050.01774920136;44062;44117.77941110306;44382.55617443849;44390.77804610989;3099.9535006974916;3602.981985090084;3712.406015037581;3765.4163604641326;3835.616438356142;33806.1548461288;33870.83064584686;33890.83054584736;33908.660913391046;34325.485117723256;4055.760467565411;4105.158442519277;4111.8560850370395;4126.66986641071;4146.792660366969;342639;344572;345105;346095;346518;38736.418953715154;38987.80506097451;39057.41413878794;39157.21685566273;39228.411573826415;39765.80117099396;40017.39973900394;40190.799046005166;40294.39558406626;43136.56863431388;17816.198271077574;17820.46538603844;17876.642467150843;17906.194221260073;17923.820761792475;14802.925985370004;14915.105093694414;14926.626834329229;15091.849081509044;15096.471623493126;20938.37184884456;20943.16227350889;21027.26404575863;21113.366599002056;21234.681479777817;7632.961835190788;7639.197884222188;7814.53112813233;7933.523988560705;7967.721129760431;1060.3584831177182;1099.543689368903;1144.3438214903304;1156.7570810129967;1215.5124433489661;33962;34139.31721365559;34530.654693453245;34809.30381392358;35066.824665877015;1147.942602869853;1162.8081216752896;1215.726461546145;1265.9810102848464;1284.1203775413871;18008.639827203646;18177.63644727098;18308.802943646846;18317;18503.444896653124;666890;670330;672175;683027;683491;64212.67893660502;64859.67570162119;64999;65157;65320.34679653238;1433.54843224384;1447.167878469884;1480.1711041816402;1483.859033391826;1492.5074725340612;33672;33884.661153389134;34029.65970340265;34048.65951340455;34476.82761586176;55647.443525565846;55912.720436399184;56018;56057.439425606855;56228.71885640546;488104;490383;490749;492387;494672;31188.68811311858;31446.371072577964;31697;31740.841295793372;31760.841195793873;47912;48918.26622600735;52558;53189;53775;43979.74187224325;45117.774411127735;45769.77115114403;46253.76873115748;47560.2865957004;44096.55903440925;45716.54283457123;46477;46485.76757116193;46794.53205467902;38190.80904595459;42382.57617423786;43185.78407107944;43579.782101089295;44090;38221.61778382181;39426.21147576975;39462.21075578415;39905.401418979316;40431.03276168308;29804.552931706476;30290.24274393158;30529.23676908095;30545;30883 04:15:59 INFO - PROCESS | 1431 | |2;jquery.html;409.28171059790066;414.32671908149257;431.1678460571097;432.60416718702385;434.9565043495651;18813.153408096634;19791.604167916652;20591.897040514796;20774.16903323869;20923.790762092412;20024.899875500603;20092.69860952087;20267;20481.283155089575;20702;5665.830025099243;5852.736626851802;5872.677002764846;5884.735186916599;5893.941060589404;5734.713264336788;5843.8246852594275;5845.941540584604;5854.063349864023;5959.672218028007;6059.212302400681;6078.300995385521;6085.817425477243;6120.234970628671;6240.812775616716;6586.538942274043;6637.1703537057865;6796.626185559768;6941.409980151693;6960.617166055865;6138.907916381258;6179.474744646711;6235.781747638811;6239.532035097386;6249.500039996789;19645.821250725003;23691.407714807094;23781.64327535071;24419.145329913546;24541;2446.1193970170725;2600.1220667993275;2836.6596008479114;3122.344307695364;3131.060681795475;14251.85748142526;14476.855231447656;14874.107553546823;14945.40218391263;15033.774493382609;1939.2921583622017;1966.0955960258298;1978.347145442015;1978.9010549472468;1979.0797279265212;83091;85192.57403713003;85321.57339213265;85950.14049859546;88031.55984220102;10011.649592264235;10269.691909242734;10600.0989915858;10722.73193170177;10726.356418614909;14272.21502817355;14302.356393962296;14339;14382.496612618717;14427.35076921541;8391.202835730595;8407.95796021016;8476.110008449024;8639.438436501607;8686.305095592337;8659.52372619512;8684.913150868537;8770;8775.297976161892;8977.551122443852;4328.9134217316105;4368.847090351823;4400.075984043387;4411.139827733626;4469.08383781324;2054.3220737156703;2121.7878212178966;2156.5255643758346;2162.945926351854;2182.3125715399915;916.097643820836;1036.9069413229663;1056.5034433816095;1058.327961744298;1090.340344091829;20373.898130509253;20464.59070818575;20636.484087897923;20711.8964405177;20926.37220883376;1033.5194134727387;1040.7502199472071;1047.8794938582162;1075.7902209069157;1088.385062439719;11122.49948752308;11539.076873850072;11565.174129353234;11753.4710938008;11758.529658813552;520842;531192;538772;546293;554678;96680.51659741656;98291.50854245682;99360;100795;103199;1006.3006210683504;1024.897510248984;1037.387941114731;1051.7212938571286;1053.1153830782027;17688.292468301122;17795.73306400379;18437.26250949947;18574.44276671702;18645.81354186495;45804.31293530666;45925;46223.53776462192;47677;48488;65628.67185664042;65746.67126664528;66297.33702662912;66630.33369666242;66893.33106669066;9111.726648200565;9111.817763644822;9209.447433154031;9263.953680231556;9503.382280151767;10174.796504070026;13399.12905661129;13886.02797804144;14180.716385672022;14425.711485770436;5658.236138121466;11860.288382697066;12298.81551776742;12957.805632915703;13169.53906613264;12156;12524.749505010031;12553.435095420911;12570.308633025272;12840.55058072963;12392.442340094538;12534;12780.424880880568;12826.294553799631;12866.871331286568;8981;9154;9270.44377337362;9444.0555944405;9585.137337639646;12234.143609947574;12391.070669699628;12523.185992910432;12605.936970315457;12613.432395542406 04:15:59 INFO - PROCESS | 1431 | |3;mootools.html;1569.1997081488441;1571.1829848478792;1749.5975925537125;1815.5007372972439;1826.9908650456755;8553.40126191167;9229.7692557686;9283.675071372503;9895.505224738761;9910.603575856967;9253.35226534143;9722.076402741746;9727.075927786867;9748;9767.804643907117;2479.3677612208908;2511.573032584465;2513.3590934311815;2529.481456301454;2530.987345063272;2440.1825388494876;2501.0496011515597;2502.649629051934;2502.724700282967;2506.9749302507016;2463.741307162749;2466.802655787542;2483.5405449991717;2492.8753562321904;2494.638277449769;2390.5457962987152;2399.1722855614785;2406.6630671705975;2445.119756887519;2447.657327974085;2428.8421252618523;2440.731519532868;2442.255112190781;2443.68232129822;2448.045262347686;9666.516674166334;9751.756206094833;9816.165625921805;9817.165540928958;9841.950790246003;5506.697131657757;5594.300712410949;5606.971965140189;5625.296837895263;5657;3425.2122011937145;3531.276088401897;3598.118460977051;3655.689266412358;3661.2311414602964;1202.7955247607927;1206.6380085974172;1220.3227208899057;1242.975140497194;1250.4810503640979;13702.52041178564;13753.79369309461;13775.586732398144;13800.861991380158;13851.376688049062;4779.928301075487;4872.658913875995;4904.558589726942;4909.410870695468;4989.201727723546;11491.655250342503;11524.88475115255;11535.307881527135;11547.133964952494;11561.653150405502;5653.378128405954;5665.150227465913;5694.06048002075;5705.400932902068;5711.171880077365;4568.1548913451115;4841.443234028132;4945.258211268267;4959.752012399365;5230.97384513075;4333.566643335705;4406.581374769392;4427.822887084545;4448.132614140211;4463.62059224963;1269.51123817331;1293.2951541409955;1302.7134030513462;1306.8039794030972;1323.3780123342015;1069.6416700405296;1071.3839542263229;1075.4837677914645;1085.79369919715;1092.7377429416883;6280.9685951569945;6328.272248691367;6633.137692100093;6760.087388202628;6830.214525329551;471.9740414277248;476.2594166071722;481.9614430845524;485.22848670613894;488.699449838354;4447.7998490067375;4455.353973673799;4521.773911304422;4535.274356103074;4640.628749700016;11841;11891.227070240408;11959.342236176919;12012.579559715543;12101.455434505468;11838.171328007129;12014.279143251433;12080.577179798665;12108;12165.75668486643;8949.955250223707;8969.551522423853;9005.324600654978;9018.053104423941;9050.683226087056;6380.084207181391;6400.551961362846;6400.751853388544;6485.837854053498;6488.610683359014;10734.51694673726;10778.568857245622;10867.945660271647;10874.782504350027;11166.330020198815;11023.173262005543;11276.210665253353;11296;11367.715807104558;11485.942570287096;7648.426368022309;8005.3995950305125;8205.302549283379;8269.917300826915;8356.707515236938;9316.48759318217;9359.812803744024;9386.436813791195;9393.906060939576;9395.342326037111;8184.549849758082;8277.379196560161;8284.337253019865;8417.200365965224;8451.577421129043;8098.676052957816;8113.310368618733;8261.669533218605;8303.335733141213;8505.872411913702;7083.150021997393;7113.715451382094;7124.073870396815;7160.319769621878;7179.533330333512;5846.795362162304;5976.133460648269;5992.43071908168;5997.340292567901;6011.188489553854;5814.825555233349;5826.475617194473;5833.620814647034;5894.204282421818;5920.851978700394 04:15:59 INFO - PROCESS | 1431 | |4;prototype.html;344.54003904787106;350.92791521900597;351.2272999401318;355.7545293747316;355.8683287183741;5782.248307719996;5803.651780893144;5816.33112192098;5824.592278540498;5833.5333173346135;5670.914936275959;5706.600537962344;5709.257796486451;5725.599208055438;5737.741801618927;4079.326911059679;4420.651701231123;4430.734155950637;4435.334699795024;4441.223510595772;4417.249067658489;4426.800793964263;4439.178751930903;4459.866204013869;4489.102179564084;4434.467863856342;4445;4461.821527138911;4472.776361181945;4484.013517026266;4319.568043195671;4404.317330813713;4423.623991960687;4428.070105277896;4454.754988475633;3902.7412110887444;3915.941260881089;3924.1170736584327;3941.054147004727;3969.761814291152;5579.6652200868075;5597.382159718249;5619.325680918275;5646.576506761969;5661.971690141523;4907.987715049072;5060.2409638554145;5087.949120508784;5129.230615407681;5133.84598462043;5930.970345148246;5932.911006334908;5941.970290148565;5969.8806023879715;5978.459154859167;4342.630876375511;4368.60682538573;4373.693841431101;4382.605565499089;4388.956110438887;5866.677332746697;6110.175126357974;6166.84582885427;6174.487250623626;6203.193584833988;4323.7621930793475;4376.868693939187;4389.780510974439;4404.581564751344;4408.669349798778;4328.545502722169;4403.405540252089;4412.889677758082;4415.823367065345;4439.644828413784;5026.29631851541;5028.899422011613;5067.113255180328;5104.927965127291;5115.130427827278;6007.189029480965;6041.214642096499;6041.9395806041375;6042.969785151134;6070.6357618543025;1495.3271028037427;1512.9773053404208;1531.716632422983;1557.6183834960507;1568.968620627581;955.5747692277009;955.6655170690203;990.559201155479;1024.959001639926;1056.5826498533036;5867.85576812526;5878.676672783038;5879.235699359056;5883.3234178069215;5902.734376953047;6123.785667501616;6152.630842149485;6155.415235552616;6157.7229024694;6192;5798.6810725410505;5801.593888427769;5820.447057529528;5851.707414629337;5875.618084824473;3206.7755257132244;3238.2552013037134;3276.574045374086;3282.688144626257;3285.211549228216;6079.635221886701;6287.49700023997;6295.213098362705;6350.7777227796805;6377.585456945284;6096.8780624388155;6155.507559395238;6214.788116317365;6236.38072009757;6247;6112.602680825732;6300.27546832111;6379.617222966637;6443.873521737815;6455.61266324022;6191.349908259568;6203.472704820141;6227.283862355887;6247.468965138014;6248.156498872594;6156.968200493916;6190;6207;6224.564280500322;6240.625562466085;6316.526260530387;6416.262129854939;6442.774502892376;6524.347565243438;6567.146270984933;4375.824967001412;4388.5830846069575;4401.889952751078;4434.113177364476;4444.933326000048;6070.817875463743;6212.316645169119;6217.818614463418;6236.812895613139;6270.592411493239;6035.39646035393;6053.061775424816;6063.333033366238;6096.725647345791;6127.938720612915;6074.544409169242;6090.147379366981;6125.816225513242;6129.2032035835055;6141.815745527641;5880.588358815013;5894.469497745224;5965.971569666334;6054.455099041107;6078.270607526948;6011.428914253139;6077.201748906933;6080.543959202989;6097.2683278006925;6127.019676851683;5842.685395785914;5853.795117170878;5879.441453061952;5919.940800591939;5937.703114844154 04:15:59 INFO - PROCESS | 1431 | |5;yui.html;838.3460900497611;843.472829481574;883.1521739130435;906.9455832650045;916.8323294662197;14479.927600361996;15378.231088445575;15412.30644620992;15559.688806223869;15647.765283520743;16487.422940197095;16550.917245413755;16611.169441527934;16640;16760.32958681651;873.5370253765483;875.0243478521451;893.8167675626481;895.7671005538574;900.8963969143534;881.8809460722816;882.4043770454949;882.7837179890936;883.2271762208068;883.8983516895543;938.3197182042999;942.4486675294961;943.3538026451903;944.1974321826461;945.8581212818063;933.5005771911995;935.854942483916;935.8830146231721;937.7421209167466;940.1209868772719;688.2841844481733;689.5552368722147;691.1119211812846;691.930966656517;695.5061906046712;15755.291011904377;15823.20883955809;15837.524874253791;15922.522324330288;16017.11905845178;16337.673246535003;16596.50210493675;16598.75101873473;16678.16609169549;16857;13498.52755153565;13680.247586382746;13710.862891371158;13809.102408343526;13992.16047037181;4112.045817108109;4112.239235741397;4130.421740956239;4181.205570941512;4189.811458484375;89800;90863.54568227117;90883;90952.09047909568;91030.08969910283;11275.154363422776;11275.66173014811;11609;11695.766084678258;11887.762244755057;23711.762882371302;23748.406289842547;23800.285991420285;23850.642240366407;23894.880525597608;9161.77095572616;9215.262778977665;9323.160915517636;9687.9031209687;9732.805343893224;5323.893522129613;5336.573074154058;5390.380106287748;5477.7261136943;5570.61005729595;3963.6829053675638;4045.4336392905016;4080.469538959916;4083.0813067059676;4087.6525495332635;639.1658885154825;653.8038588423454;657.7237560224717;668.1347654787062;670.0485310858593;669.8425869920565;739.6597565119997;747.3050063441052;762.9791001422473;837.3928901546452;10779.78440431187;11036.779264414667;11274.605388811517;11635.185537012498;11873;634.4607083978674;774.4153164360871;786.2059320086754;789.3842802613971;805.5810978291256;5207.973960130175;5245.318108645852;5252.842414727565;5263.5525980292105;5289.9471005290225;87081.56459217664;115945.84054159519;132430.33784831208;135425;135908;65924;69662.30337696659;93574;113881;113944;81398.5930070346;81777.91110444455;82259.3548129034;83900.58049709712;93526;9972.50137493137;10619.840702389625;11016.339019658846;11311.490982905625;11353.716157096138;54207.45792542182;54839.45160548343;54943.17585236305;55238.17142742943;55666.44333556775;73171;78936.60531697304;80245.59877200576;82839.58580207061;82887.5855620718;12872.16330938486;13258.33708314561;13315.933420332836;13382.93308533451;13685.931570342085;14451.421943122157;15382.307796149424;15445.227738612799;15740.763888541453;16036.037837729773;14454.205018724071;14523.564293071226;14574.781378279546;15221.923890380478;15472.226388680296;14270.928645356707;14826.62933426673;14978.176200309088;15215.771763423336;15487.148206848731;14121.717565648423;14229.14625122496;14365.353559090076;15137.772933406228;15264.694706105594;12063.517459301529;12247;12575.371231438574;12717.109802314118;13133.212007279593;11133.665990020312;11443.599474018369;11687.123465740273;11966.961581380603;12674.176178548734 04:15:59 INFO - PROCESS | 1431 | __end_tp_report 04:15:59 INFO - PROCESS | 1431 | __start_cc_report 04:15:59 INFO - PROCESS | 1431 | _x_x_mozilla_cycle_collect,329 04:15:59 INFO - PROCESS | 1431 | __end_cc_report 04:15:59 INFO - PROCESS | 1431 | __startTimestamp1473419759378__endTimestamp 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | ------- Summary: start ------- 04:15:59 INFO - PROCESS | 1431 | Number of tests: 6 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | [#0] dojo.html Cycles:165 Average:5715.00 Median:5960.31 stddev:649.25 (10.9%) stddev-sans-first:621.93 04:15:59 INFO - PROCESS | 1431 | Values: 3256.3 3301.0 3321.3 3328.7 3337.1 5652.6 5734.6 5738.1 5742.1 5765.6 5668.7 5747.6 5767.4 5770.2 5781.0 5134.3 5216.5 5261.7 5273.0 5278.4 5097.4 5128.4 5135.9 5155.6 5184.7 5212.3 5217.2 5241.5 5291.5 5307.4 5254.6 5279.6 5291.3 5294.2 5302.1 4977.4 5028.0 5160.5 5187.6 5242.4 5488.1 5611.0 5642.5 5663.9 5710.0 6062.0 6109.5 6124.8 6133.8 6134.2 5998.4 6167.4 6173.0 6176.4 6194.2 5638.2 5678.0 5703.9 5779.4 5802.3 6247.8 6296.6 6299.0 6301.2 6306.5 5857.0 6003.5 6009.7 6019.0 6029.7 5978.4 6005.7 6028.0 6112.9 6113.7 6039.3 6060.0 6060.5 6064.9 6082.3 5914.2 6073.8 6106.3 6107.5 6108.1 4702.2 4749.5 4749.9 4790.4 4823.3 4241.7 4245.3 4255.7 4256.5 4279.7 5786.0 6031.5 6042.2 6045.5 6063.9 6108.5 6111.3 6120.2 6237.9 6243.8 6036.3 6038.0 6047.5 6047.6 6092.4 5253.6 5408.7 5415.0 5422.3 5430.9 6369.7 6379.3 6421.4 6542.3 6551.8 6197.6 6218.7 6230.0 6239.3 6240.6 6289.6 6463.6 6479.0 6523.2 6523.6 5984.2 5989.2 6021.0 6073.3 6118.9 6160.2 6188.0 6191.1 6194.2 6202.0 5817.4 6014.4 6030.4 6036.1 6045.5 5892.4 5925.1 5928.4 5959.5 6034.7 5888.3 5935.9 5948.0 5968.4 5984.7 5925.2 5946.3 6035.8 6068.5 6076.9 5801.5 5827.9 5853.1 5917.7 5960.3 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | [#1] ext.html Cycles:180 Average:66020.55 Median:23264.68 stddev:139196.20 (598.3%) stddev-sans-first:139499.95 04:15:59 INFO - PROCESS | 1431 | Values: 575.1 615.6 648.6 651.1 667.9 40896.8 46057.0 46142.3 46185.0 46295.8 47067.0 48002.3 48259.8 48528.8 48536.5 9008.9 9216.3 9216.8 9219.9 9244.2 9150.9 9217.9 9222.7 9243.2 9243.7 9180.6 9215.4 9244.8 9245.8 9259.0 9061.1 9179.4 9182.1 9198.3 9200.2 9186.9 9272.9 9273.5 9282.5 9301.2 44050.0 44062.0 44117.8 44382.6 44390.8 3100.0 3603.0 3712.4 3765.4 3835.6 33806.2 33870.8 33890.8 33908.7 34325.5 4055.8 4105.2 4111.9 4126.7 4146.8 342639.0 344572.0 345105.0 346095.0 346518.0 38736.4 38987.8 39057.4 39157.2 39228.4 39765.8 40017.4 40190.8 40294.4 43136.6 17816.2 17820.5 17876.6 17906.2 17923.8 14802.9 14915.1 14926.6 15091.8 15096.5 20938.4 20943.2 21027.3 21113.4 21234.7 7633.0 7639.2 7814.5 7933.5 7967.7 1060.4 1099.5 1144.3 1156.8 1215.5 33962.0 34139.3 34530.7 34809.3 35066.8 1147.9 1162.8 1215.7 1266.0 1284.1 18008.6 18177.6 18308.8 18317.0 18503.4 666890.0 670330.0 672175.0 683027.0 683491.0 64212.7 64859.7 64999.0 65157.0 65320.3 1433.5 1447.2 1480.2 1483.9 1492.5 33672.0 33884.7 34029.7 34048.7 34476.8 55647.4 55912.7 56018.0 56057.4 56228.7 488104.0 490383.0 490749.0 492387.0 494672.0 31188.7 31446.4 31697.0 31740.8 31760.8 47912.0 48918.3 52558.0 53189.0 53775.0 43979.7 45117.8 45769.8 46253.8 47560.3 44096.6 45716.5 46477.0 46485.8 46794.5 38190.8 42382.6 43185.8 43579.8 44090.0 38221.6 39426.2 39462.2 39905.4 40431.0 29804.6 30290.2 30529.2 30545.0 30883.0 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | [#2] jquery.html Cycles:180 Average:31494.64 Median:12936.86 stddev:88786.17 (686.3%) stddev-sans-first:89004.56 04:15:59 INFO - PROCESS | 1431 | Values: 409.3 414.3 431.2 432.6 435.0 18813.2 19791.6 20591.9 20774.2 20923.8 20024.9 20092.7 20267.0 20481.3 20702.0 5665.8 5852.7 5872.7 5884.7 5893.9 5734.7 5843.8 5845.9 5854.1 5959.7 6059.2 6078.3 6085.8 6120.2 6240.8 6586.5 6637.2 6796.6 6941.4 6960.6 6138.9 6179.5 6235.8 6239.5 6249.5 19645.8 23691.4 23781.6 24419.1 24541.0 2446.1 2600.1 2836.7 3122.3 3131.1 14251.9 14476.9 14874.1 14945.4 15033.8 1939.3 1966.1 1978.3 1978.9 1979.1 83091.0 85192.6 85321.6 85950.1 88031.6 10011.6 10269.7 10600.1 10722.7 10726.4 14272.2 14302.4 14339.0 14382.5 14427.4 8391.2 8408.0 8476.1 8639.4 8686.3 8659.5 8684.9 8770.0 8775.3 8977.6 4328.9 4368.8 4400.1 4411.1 4469.1 2054.3 2121.8 2156.5 2162.9 2182.3 916.1 1036.9 1056.5 1058.3 1090.3 20373.9 20464.6 20636.5 20711.9 20926.4 1033.5 1040.8 1047.9 1075.8 1088.4 11122.5 11539.1 11565.2 11753.5 11758.5 520842.0 531192.0 538772.0 546293.0 554678.0 96680.5 98291.5 99360.0 100795.0 103199.0 1006.3 1024.9 1037.4 1051.7 1053.1 17688.3 17795.7 18437.3 18574.4 18645.8 45804.3 45925.0 46223.5 47677.0 48488.0 65628.7 65746.7 66297.3 66630.3 66893.3 9111.7 9111.8 9209.4 9264.0 9503.4 10174.8 13399.1 13886.0 14180.7 14425.7 5658.2 11860.3 12298.8 12957.8 13169.5 12156.0 12524.7 12553.4 12570.3 12840.6 12392.4 12534.0 12780.4 12826.3 12866.9 8981.0 9154.0 9270.4 9444.1 9585.1 12234.1 12391.1 12523.2 12605.9 12613.4 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | [#3] mootools.html Cycles:180 Average:6305.79 Median:2556.30 stddev:3668.63 (143.5%) stddev-sans-first:3661.65 04:15:59 INFO - PROCESS | 1431 | Values: 1569.2 1571.2 1749.6 1815.5 1827.0 8553.4 9229.8 9283.7 9895.5 9910.6 9253.4 9722.1 9727.1 9748.0 9767.8 2479.4 2511.6 2513.4 2529.5 2531.0 2440.2 2501.0 2502.6 2502.7 2507.0 2463.7 2466.8 2483.5 2492.9 2494.6 2390.5 2399.2 2406.7 2445.1 2447.7 2428.8 2440.7 2442.3 2443.7 2448.0 9666.5 9751.8 9816.2 9817.2 9842.0 5506.7 5594.3 5607.0 5625.3 5657.0 3425.2 3531.3 3598.1 3655.7 3661.2 1202.8 1206.6 1220.3 1243.0 1250.5 13702.5 13753.8 13775.6 13800.9 13851.4 4779.9 4872.7 4904.6 4909.4 4989.2 11491.7 11524.9 11535.3 11547.1 11561.7 5653.4 5665.2 5694.1 5705.4 5711.2 4568.2 4841.4 4945.3 4959.8 5231.0 4333.6 4406.6 4427.8 4448.1 4463.6 1269.5 1293.3 1302.7 1306.8 1323.4 1069.6 1071.4 1075.5 1085.8 1092.7 6281.0 6328.3 6633.1 6760.1 6830.2 472.0 476.3 482.0 485.2 488.7 4447.8 4455.4 4521.8 4535.3 4640.6 11841.0 11891.2 11959.3 12012.6 12101.5 11838.2 12014.3 12080.6 12108.0 12165.8 8950.0 8969.6 9005.3 9018.1 9050.7 6380.1 6400.6 6400.8 6485.8 6488.6 10734.5 10778.6 10867.9 10874.8 11166.3 11023.2 11276.2 11296.0 11367.7 11485.9 7648.4 8005.4 8205.3 8269.9 8356.7 9316.5 9359.8 9386.4 9393.9 9395.3 8184.5 8277.4 8284.3 8417.2 8451.6 8098.7 8113.3 8261.7 8303.3 8505.9 7083.2 7113.7 7124.1 7160.3 7179.5 5846.8 5976.1 5992.4 5997.3 6011.2 5814.8 5826.5 5833.6 5894.2 5920.9 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | [#4] prototype.html Cycles:180 Average:5071.15 Median:5847.20 stddev:1502.44 (25.7%) stddev-sans-first:1464.17 04:15:59 INFO - PROCESS | 1431 | Values: 344.5 350.9 351.2 355.8 355.9 5782.2 5803.7 5816.3 5824.6 5833.5 5670.9 5706.6 5709.3 5725.6 5737.7 4079.3 4420.7 4430.7 4435.3 4441.2 4417.2 4426.8 4439.2 4459.9 4489.1 4434.5 4445.0 4461.8 4472.8 4484.0 4319.6 4404.3 4423.6 4428.1 4454.8 3902.7 3915.9 3924.1 3941.1 3969.8 5579.7 5597.4 5619.3 5646.6 5662.0 4908.0 5060.2 5087.9 5129.2 5133.8 5931.0 5932.9 5942.0 5969.9 5978.5 4342.6 4368.6 4373.7 4382.6 4389.0 5866.7 6110.2 6166.8 6174.5 6203.2 4323.8 4376.9 4389.8 4404.6 4408.7 4328.5 4403.4 4412.9 4415.8 4439.6 5026.3 5028.9 5067.1 5104.9 5115.1 6007.2 6041.2 6041.9 6043.0 6070.6 1495.3 1513.0 1531.7 1557.6 1569.0 955.6 955.7 990.6 1025.0 1056.6 5867.9 5878.7 5879.2 5883.3 5902.7 6123.8 6152.6 6155.4 6157.7 6192.0 5798.7 5801.6 5820.4 5851.7 5875.6 3206.8 3238.3 3276.6 3282.7 3285.2 6079.6 6287.5 6295.2 6350.8 6377.6 6096.9 6155.5 6214.8 6236.4 6247.0 6112.6 6300.3 6379.6 6443.9 6455.6 6191.3 6203.5 6227.3 6247.5 6248.2 6157.0 6190.0 6207.0 6224.6 6240.6 6316.5 6416.3 6442.8 6524.3 6567.1 4375.8 4388.6 4401.9 4434.1 4444.9 6070.8 6212.3 6217.8 6236.8 6270.6 6035.4 6053.1 6063.3 6096.7 6127.9 6074.5 6090.1 6125.8 6129.2 6141.8 5880.6 5894.5 5966.0 6054.5 6078.3 6011.4 6077.2 6080.5 6097.3 6127.0 5842.7 5853.8 5879.4 5919.9 5937.7 04:15:59 INFO - PROCESS | 1431 | 04:15:59 INFO - PROCESS | 1431 | [#5] yui.html Cycles:180 Average:21984.23 Median:4112.14 stddev:31250.26 (760.0%) stddev-sans-first:31297.59 04:15:59 INFO - PROCESS | 1431 | Values: 838.3 843.5 883.2 906.9 916.8 14479.9 15378.2 15412.3 15559.7 15647.8 16487.4 16550.9 16611.2 16640.0 16760.3 873.5 875.0 893.8 895.8 900.9 881.9 882.4 882.8 883.2 883.9 938.3 942.4 943.4 944.2 945.9 933.5 935.9 935.9 937.7 940.1 688.3 689.6 691.1 691.9 695.5 15755.3 15823.2 15837.5 15922.5 16017.1 16337.7 16596.5 16598.8 16678.2 16857.0 13498.5 13680.2 13710.9 13809.1 13992.2 4112.0 4112.2 4130.4 4181.2 4189.8 89800.0 90863.5 90883.0 90952.1 91030.1 11275.2 11275.7 11609.0 11695.8 11887.8 23711.8 23748.4 23800.3 23850.6 23894.9 9161.8 9215.3 9323.2 9687.9 9732.8 5323.9 5336.6 5390.4 5477.7 5570.6 3963.7 4045.4 4080.5 4083.1 4087.7 639.2 653.8 657.7 668.1 670.0 669.8 739.7 747.3 763.0 837.4 10779.8 11036.8 11274.6 11635.2 11873.0 634.5 774.4 786.2 789.4 805.6 5208.0 5245.3 5252.8 5263.6 5289.9 87081.6 115945.8 132430.3 135425.0 135908.0 65924.0 69662.3 93574.0 113881.0 113944.0 81398.6 81777.9 82259.4 83900.6 93526.0 9972.5 10619.8 11016.3 11311.5 11353.7 54207.5 54839.5 54943.2 55238.2 55666.4 73171.0 78936.6 80245.6 82839.6 82887.6 12872.2 13258.3 13315.9 13382.9 13685.9 14451.4 15382.3 15445.2 15740.8 16036.0 14454.2 14523.6 14574.8 15221.9 15472.2 14270.9 14826.6 14978.2 15215.8 15487.1 14121.7 14229.1 14365.4 15137.8 15264.7 12063.5 12247.0 12575.4 12717.1 13133.2 11133.7 11443.6 11687.1 11967.0 12674.2 04:15:59 INFO - PROCESS | 1431 | -------- Summary: end -------- 04:15:59 INFO - PROCESS | 1431 | 04:16:00 INFO - TEST-INFO | 1431: exit 0 04:16:00 INFO - TEST-OK | dromaeo_css | took 1110688ms 04:16:00 INFO - TEST-START | kraken 04:16:00 INFO - operating with platform_type : linux_ 04:16:00 INFO - Initialising browser for kraken test... 04:16:00 INFO - TEST-INFO | started process 1701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EhcmC/profile http://localhost:40944/getInfo.html) 04:16:04 INFO - PROCESS | 1701 | __metrics Screen width/height:1600/1200 04:16:04 INFO - PROCESS | 1701 | colorDepth:24 04:16:04 INFO - PROCESS | 1701 | Browser inner width/height: 1024/697 04:16:04 INFO - PROCESS | 1701 | __metrics 04:16:04 ERROR - PROCESS | 1701 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:16:05 INFO - TEST-INFO | 1701: exit 0 04:16:05 INFO - Browser initialized. 04:16:05 INFO - Running cycle 1/1 for kraken test... 04:16:05 INFO - TEST-INFO | started process 1826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EhcmC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:17 INFO - PROCESS | 1826 | RSS: Main: 153100288 04:16:17 INFO - PROCESS | 1826 | 04:16:19 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40944/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:20 INFO - PROCESS | 1826 | RSS: Main: 158646272 04:16:20 INFO - PROCESS | 1826 | 04:16:23 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40944/tests/kraken/driver.html?testName=audio-dft) 04:16:24 INFO - PROCESS | 1826 | RSS: Main: 157806592 04:16:24 INFO - PROCESS | 1826 | 04:16:26 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40944/tests/kraken/driver.html?testName=audio-fft) 04:16:27 INFO - PROCESS | 1826 | RSS: Main: 158572544 04:16:27 INFO - PROCESS | 1826 | 04:16:29 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40944/tests/kraken/driver.html?testName=audio-oscillator) 04:16:30 INFO - PROCESS | 1826 | RSS: Main: 158203904 04:16:30 INFO - PROCESS | 1826 | 04:16:32 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:33 INFO - PROCESS | 1826 | RSS: Main: 157646848 04:16:33 INFO - PROCESS | 1826 | 04:16:36 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40944/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:36 INFO - PROCESS | 1826 | RSS: Main: 157765632 04:16:36 INFO - PROCESS | 1826 | 04:16:40 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40944/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:40 INFO - PROCESS | 1826 | RSS: Main: 158560256 04:16:40 INFO - PROCESS | 1826 | 04:16:43 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40944/tests/kraken/driver.html?testName=json-parse-financial) 04:16:44 INFO - PROCESS | 1826 | RSS: Main: 158658560 04:16:44 INFO - PROCESS | 1826 | 04:16:45 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:46 INFO - PROCESS | 1826 | RSS: Main: 157888512 04:16:46 INFO - PROCESS | 1826 | 04:16:48 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:48 INFO - PROCESS | 1826 | RSS: Main: 157097984 04:16:48 INFO - PROCESS | 1826 | 04:16:50 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:51 INFO - PROCESS | 1826 | RSS: Main: 158154752 04:16:51 INFO - PROCESS | 1826 | 04:16:54 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:54 INFO - PROCESS | 1826 | RSS: Main: 158203904 04:16:54 INFO - PROCESS | 1826 | 04:16:57 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:57 INFO - PROCESS | 1826 | RSS: Main: 158203904 04:16:57 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:40944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40944/tests/kraken/driver.html?testName=ai-astar) 04:16:59 INFO - PROCESS | 1826 | RSS: Main: 160276480 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | __start_tp_report 04:16:59 INFO - PROCESS | 1826 | _x_x_mozilla_page_load 04:16:59 INFO - PROCESS | 1826 | _x_x_mozilla_page_load_details 04:16:59 INFO - PROCESS | 1826 | |i|pagename|runs| 04:16:59 INFO - PROCESS | 1826 | |0;ai-astar;102;112;109;108;111;110;111;110;111;121 04:16:59 INFO - PROCESS | 1826 | |1;audio-beat-detection;155;118;143;172;118;152;141;118;176;119 04:16:59 INFO - PROCESS | 1826 | |2;audio-dft;163;162;162;163;166;162;162;161;161;161 04:16:59 INFO - PROCESS | 1826 | |3;audio-fft;75;75;76;172;76;76;75;76;178;76 04:16:59 INFO - PROCESS | 1826 | |4;audio-oscillator;83;84;150;86;83;84;139;83;83;139 04:16:59 INFO - PROCESS | 1826 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;117;118;118 04:16:59 INFO - PROCESS | 1826 | |6;imaging-darkroom;148;147;148;147;147;157;147;147;147;147 04:16:59 INFO - PROCESS | 1826 | |7;imaging-desaturate;95;96;95;96;95;96;96;95;95;95 04:16:59 INFO - PROCESS | 1826 | |8;json-parse-financial;52;52;52;52;51;52;52;54;52;52 04:16:59 INFO - PROCESS | 1826 | |9;json-stringify-tinderbox;59;59;59;59;61;58;59;59;60;59 04:16:59 INFO - PROCESS | 1826 | |10;stanford-crypto-aes;74;74;74;72;72;72;74;72;79;75 04:16:59 INFO - PROCESS | 1826 | |11;stanford-crypto-ccm;133;120;124;124;120;117;126;126;151;126 04:16:59 INFO - PROCESS | 1826 | |12;stanford-crypto-pbkdf2;156;157;156;152;152;156;153;154;156;152 04:16:59 INFO - PROCESS | 1826 | |13;stanford-crypto-sha256-iterative;65;66;63;62;65;62;62;61;61;66 04:16:59 INFO - PROCESS | 1826 | __end_tp_report 04:16:59 INFO - PROCESS | 1826 | __start_cc_report 04:16:59 INFO - PROCESS | 1826 | _x_x_mozilla_cycle_collect,888 04:16:59 INFO - PROCESS | 1826 | __end_cc_report 04:16:59 INFO - PROCESS | 1826 | __startTimestamp1473419819896__endTimestamp 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | ------- Summary: start ------- 04:16:59 INFO - PROCESS | 1826 | Number of tests: 14 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:4.65 (4.2%) stddev-sans-first:3.78 04:16:59 INFO - PROCESS | 1826 | Values: 102.0 112.0 109.0 108.0 111.0 110.0 111.0 110.0 111.0 121.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:147.50 stddev:22.55 (15.3%) stddev-sans-first:23.36 04:16:59 INFO - PROCESS | 1826 | Values: 155.0 118.0 143.0 172.0 118.0 152.0 141.0 118.0 176.0 119.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 04:16:59 INFO - PROCESS | 1826 | Values: 163.0 162.0 162.0 163.0 166.0 162.0 162.0 161.0 161.0 161.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:41.93 (55.2%) stddev-sans-first:43.81 04:16:59 INFO - PROCESS | 1826 | Values: 75.0 75.0 76.0 172.0 76.0 76.0 75.0 76.0 178.0 76.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:83.00 stddev:28.65 (34.5%) stddev-sans-first:29.60 04:16:59 INFO - PROCESS | 1826 | Values: 83.0 84.0 150.0 86.0 83.0 84.0 139.0 83.0 83.0 139.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:16:59 INFO - PROCESS | 1826 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:147.00 stddev:3.12 (2.1%) stddev-sans-first:3.31 04:16:59 INFO - PROCESS | 1826 | Values: 148.0 147.0 148.0 147.0 147.0 157.0 147.0 147.0 147.0 147.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:16:59 INFO - PROCESS | 1826 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 04:16:59 INFO - PROCESS | 1826 | Values: 52.0 52.0 52.0 52.0 51.0 52.0 52.0 54.0 52.0 52.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 04:16:59 INFO - PROCESS | 1826 | Values: 59.0 59.0 59.0 59.0 61.0 58.0 59.0 59.0 60.0 59.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:2.15 (2.9%) stddev-sans-first:2.28 04:16:59 INFO - PROCESS | 1826 | Values: 74.0 74.0 74.0 72.0 72.0 72.0 74.0 72.0 79.0 75.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:126.00 stddev:9.60 (7.6%) stddev-sans-first:9.91 04:16:59 INFO - PROCESS | 1826 | Values: 133.0 120.0 124.0 124.0 120.0 117.0 126.0 126.0 151.0 126.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:156.00 stddev:2.01 (1.3%) stddev-sans-first:2.05 04:16:59 INFO - PROCESS | 1826 | Values: 156.0 157.0 156.0 152.0 152.0 156.0 153.0 154.0 156.0 152.0 04:16:59 INFO - PROCESS | 1826 | 04:16:59 INFO - PROCESS | 1826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:2.00 (3.1%) stddev-sans-first:2.03 04:16:59 INFO - PROCESS | 1826 | Values: 65.0 66.0 63.0 62.0 65.0 62.0 62.0 61.0 61.0 66.0 04:16:59 INFO - PROCESS | 1826 | -------- Summary: end -------- 04:16:59 INFO - PROCESS | 1826 | 04:17:00 INFO - TEST-INFO | 1826: exit 0 04:17:00 INFO - TEST-OK | kraken | took 60749ms 04:17:00 INFO - SUITE-END | took 1171s 04:17:01 INFO - Completed test suite (00:19:31) 04:17:01 INFO - javascript benchmark 04:17:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7757.08083402616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.251062255681, 3300.966990330096, 3321.302526469443, 3328.7170590499804, 3337.115664348946, 5652.604317697763, 5734.598578099534, 5738.053221218499, 5742.109972954188, 5765.625234359774, 5668.716564171786, 5747.626404283729, 5767.36558978512, 5770.249867517216, 5781.0, 5134.281200631905, 5216.478352164772, 5261.710605916673, 5272.973635131819, 5278.445763194867, 5097.413797413308, 5128.384593848743, 5135.897282054357, 5155.639105262614, 5184.740762961856, 5212.270282160501, 5217.165253559431, 5241.5020573045695, 5291.497307755776, 5307.363116426034, 5254.605904557174, 5279.604029697788, 5291.3385826771655, 5294.1529355303355, 5302.09864323066, 4977.377827771528, 5028.044671512401, 5160.458151894035, 5187.559057480119, 5242.449542798027, 5488.121900495901, 5611.046122159243, 5642.463965923231, 5663.886722265573, 5710.0, 6062.0, 6109.541784366146, 6124.846878828021, 6133.846653833645, 6134.202553668039, 5998.430149135826, 6167.383261673842, 6173.0, 6176.382361763833, 6194.194754681863, 5638.154276858463, 5677.971610141964, 5703.942960570383, 5779.422057794187, 5802.303723553158, 6247.812565623039, 6296.622202667854, 6298.968505157536, 6301.212348456443, 6306.4639505642535, 5856.970715146482, 6003.549733769897, 6009.699515024231, 6019.0, 6029.698515074228, 5978.432048955342, 6005.669688167192, 6027.969860150672, 6112.898653789767, 6113.749968913926, 6039.305479869871, 6059.969700151471, 6060.484858786965, 6064.878702425926, 6082.270127584629, 5914.201582786355, 6073.817785466443, 6106.328303886569, 6107.541934354941, 6108.08378743192, 4702.224133018014, 4749.453812811502, 4749.881252968635, 4790.449098353734, 4823.348847905558, 4241.724287921275, 4245.299525578245, 4255.723377980421, 4256.5105012923295, 4279.743215407086, 5785.971070144622, 6031.517478601701, 6042.214512113397, 6045.455908968214, 6063.938810708109, 6108.493847774667, 6111.287884814209, 6120.17377654011, 6237.937620623827, 6243.75024999004, 6036.3360030396625, 6038.033914573735, 6047.516198704093, 6047.624040703569, 6092.390760923872, 5253.632245742838, 5408.729563521887, 5414.972925135349, 5422.349318081855, 5430.891382172414, 6369.71336289868, 6379.266384365765, 6421.3899679531305, 6542.280349161683, 6551.836204094936, 6197.566170368031, 6218.720157592828, 6229.96885015572, 6239.344868788712, 6240.563160578716, 6289.559730818799, 6463.64449955257, 6478.967605161944, 6523.217213934358, 6523.575967562093, 5984.222051133324, 5989.191459153133, 6020.969895150496, 6073.30157031947, 6118.908216376669, 6160.1888088907335, 6187.978983467678, 6191.071339299141, 6194.194754681863, 6202.0, 5817.360090389969, 6014.428629280386, 6030.427109424598, 6036.064410016279, 6045.516358691206, 5892.440218179266, 5925.111233315038, 5928.436798504135, 5959.4934430573885, 6034.728437220423, 5888.3228428729535, 5935.9109613356695, 5948.0, 5968.432998865101, 5984.700764961822, 5925.170476133431, 5946.316173639913, 6035.818925432244, 6068.4841788448475, 6076.939230607814, 5801.535877129735, 5827.854303642273, 5853.09277062056, 5917.6745279010065, 5960.314563825043], "value": 5671.188588434188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.1459083261357, 615.6398506873479, 648.636763412489, 651.0559688451746, 667.9365460281272, 40896.795516022416, 46057.0, 46142.30786538205, 46185.0, 46295.76852115739, 47067.0, 48002.27996580054, 48259.75870120645, 48528.75735621317, 48536.514634853644, 9008.909910900873, 9216.2626989841, 9216.769580760501, 9219.907800922005, 9244.214241789423, 9150.908490915072, 9217.861732074025, 9222.723318300428, 9243.16811486966, 9243.722688319362, 9180.632774689004, 9215.447073175597, 9244.768880778001, 9245.815083698322, 9259.027802080785, 9061.093890610951, 9179.357444978854, 9182.127697868726, 9198.264138868908, 9200.171984521357, 9186.908130918671, 9272.907270927271, 9273.536323183815, 9282.489463079528, 9301.162895339452, 44050.01774920136, 44062.0, 44117.77941110306, 44382.55617443849, 44390.77804610989, 3099.9535006974916, 3602.981985090084, 3712.406015037581, 3765.4163604641326, 3835.616438356142, 33806.1548461288, 33870.83064584686, 33890.83054584736, 33908.660913391046, 34325.485117723256, 4055.760467565411, 4105.158442519277, 4111.8560850370395, 4126.66986641071, 4146.792660366969, 342639.0, 344572.0, 345105.0, 346095.0, 346518.0, 38736.418953715154, 38987.80506097451, 39057.41413878794, 39157.21685566273, 39228.411573826415, 39765.80117099396, 40017.39973900394, 40190.799046005166, 40294.39558406626, 43136.56863431388, 17816.198271077574, 17820.46538603844, 17876.642467150843, 17906.194221260073, 17923.820761792475, 14802.925985370004, 14915.105093694414, 14926.626834329229, 15091.849081509044, 15096.471623493126, 20938.37184884456, 20943.16227350889, 21027.26404575863, 21113.366599002056, 21234.681479777817, 7632.961835190788, 7639.197884222188, 7814.53112813233, 7933.523988560705, 7967.721129760431, 1060.3584831177182, 1099.543689368903, 1144.3438214903304, 1156.7570810129967, 1215.5124433489661, 33962.0, 34139.31721365559, 34530.654693453245, 34809.30381392358, 35066.824665877015, 1147.942602869853, 1162.8081216752896, 1215.726461546145, 1265.9810102848464, 1284.1203775413871, 18008.639827203646, 18177.63644727098, 18308.802943646846, 18317.0, 18503.444896653124, 666890.0, 670330.0, 672175.0, 683027.0, 683491.0, 64212.67893660502, 64859.67570162119, 64999.0, 65157.0, 65320.34679653238, 1433.54843224384, 1447.167878469884, 1480.1711041816402, 1483.859033391826, 1492.5074725340612, 33672.0, 33884.661153389134, 34029.65970340265, 34048.65951340455, 34476.82761586176, 55647.443525565846, 55912.720436399184, 56018.0, 56057.439425606855, 56228.71885640546, 488104.0, 490383.0, 490749.0, 492387.0, 494672.0, 31188.68811311858, 31446.371072577964, 31697.0, 31740.841295793372, 31760.841195793873, 47912.0, 48918.26622600735, 52558.0, 53189.0, 53775.0, 43979.74187224325, 45117.774411127735, 45769.77115114403, 46253.76873115748, 47560.2865957004, 44096.55903440925, 45716.54283457123, 46477.0, 46485.76757116193, 46794.53205467902, 38190.80904595459, 42382.57617423786, 43185.78407107944, 43579.782101089295, 44090.0, 38221.61778382181, 39426.21147576975, 39462.21075578415, 39905.401418979316, 40431.03276168308, 29804.552931706476, 30290.24274393158, 30529.23676908095, 30545.0, 30883.0], "value": 21058.6748719406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.28171059790066, 414.32671908149257, 431.1678460571097, 432.60416718702385, 434.9565043495651, 18813.153408096634, 19791.604167916652, 20591.897040514796, 20774.16903323869, 20923.790762092412, 20024.899875500603, 20092.69860952087, 20267.0, 20481.283155089575, 20702.0, 5665.830025099243, 5852.736626851802, 5872.677002764846, 5884.735186916599, 5893.941060589404, 5734.713264336788, 5843.8246852594275, 5845.941540584604, 5854.063349864023, 5959.672218028007, 6059.212302400681, 6078.300995385521, 6085.817425477243, 6120.234970628671, 6240.812775616716, 6586.538942274043, 6637.1703537057865, 6796.626185559768, 6941.409980151693, 6960.617166055865, 6138.907916381258, 6179.474744646711, 6235.781747638811, 6239.532035097386, 6249.500039996789, 19645.821250725003, 23691.407714807094, 23781.64327535071, 24419.145329913546, 24541.0, 2446.1193970170725, 2600.1220667993275, 2836.6596008479114, 3122.344307695364, 3131.060681795475, 14251.85748142526, 14476.855231447656, 14874.107553546823, 14945.40218391263, 15033.774493382609, 1939.2921583622017, 1966.0955960258298, 1978.347145442015, 1978.9010549472468, 1979.0797279265212, 83091.0, 85192.57403713003, 85321.57339213265, 85950.14049859546, 88031.55984220102, 10011.649592264235, 10269.691909242734, 10600.0989915858, 10722.73193170177, 10726.356418614909, 14272.21502817355, 14302.356393962296, 14339.0, 14382.496612618717, 14427.35076921541, 8391.202835730595, 8407.95796021016, 8476.110008449024, 8639.438436501607, 8686.305095592337, 8659.52372619512, 8684.913150868537, 8770.0, 8775.297976161892, 8977.551122443852, 4328.9134217316105, 4368.847090351823, 4400.075984043387, 4411.139827733626, 4469.08383781324, 2054.3220737156703, 2121.7878212178966, 2156.5255643758346, 2162.945926351854, 2182.3125715399915, 916.097643820836, 1036.9069413229663, 1056.5034433816095, 1058.327961744298, 1090.340344091829, 20373.898130509253, 20464.59070818575, 20636.484087897923, 20711.8964405177, 20926.37220883376, 1033.5194134727387, 1040.7502199472071, 1047.8794938582162, 1075.7902209069157, 1088.385062439719, 11122.49948752308, 11539.076873850072, 11565.174129353234, 11753.4710938008, 11758.529658813552, 520842.0, 531192.0, 538772.0, 546293.0, 554678.0, 96680.51659741656, 98291.50854245682, 99360.0, 100795.0, 103199.0, 1006.3006210683504, 1024.897510248984, 1037.387941114731, 1051.7212938571286, 1053.1153830782027, 17688.292468301122, 17795.73306400379, 18437.26250949947, 18574.44276671702, 18645.81354186495, 45804.31293530666, 45925.0, 46223.53776462192, 47677.0, 48488.0, 65628.67185664042, 65746.67126664528, 66297.33702662912, 66630.33369666242, 66893.33106669066, 9111.726648200565, 9111.817763644822, 9209.447433154031, 9263.953680231556, 9503.382280151767, 10174.796504070026, 13399.12905661129, 13886.02797804144, 14180.716385672022, 14425.711485770436, 5658.236138121466, 11860.288382697066, 12298.81551776742, 12957.805632915703, 13169.53906613264, 12156.0, 12524.749505010031, 12553.435095420911, 12570.308633025272, 12840.55058072963, 12392.442340094538, 12534.0, 12780.424880880568, 12826.294553799631, 12866.871331286568, 8981.0, 9154.0, 9270.44377337362, 9444.0555944405, 9585.137337639646, 12234.143609947574, 12391.070669699628, 12523.185992910432, 12605.936970315457, 12613.432395542406], "value": 9830.222298871662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.1997081488441, 1571.1829848478792, 1749.5975925537125, 1815.5007372972439, 1826.9908650456755, 8553.40126191167, 9229.7692557686, 9283.675071372503, 9895.505224738761, 9910.603575856967, 9253.35226534143, 9722.076402741746, 9727.075927786867, 9748.0, 9767.804643907117, 2479.3677612208908, 2511.573032584465, 2513.3590934311815, 2529.481456301454, 2530.987345063272, 2440.1825388494876, 2501.0496011515597, 2502.649629051934, 2502.724700282967, 2506.9749302507016, 2463.741307162749, 2466.802655787542, 2483.5405449991717, 2492.8753562321904, 2494.638277449769, 2390.5457962987152, 2399.1722855614785, 2406.6630671705975, 2445.119756887519, 2447.657327974085, 2428.8421252618523, 2440.731519532868, 2442.255112190781, 2443.68232129822, 2448.045262347686, 9666.516674166334, 9751.756206094833, 9816.165625921805, 9817.165540928958, 9841.950790246003, 5506.697131657757, 5594.300712410949, 5606.971965140189, 5625.296837895263, 5657.0, 3425.2122011937145, 3531.276088401897, 3598.118460977051, 3655.689266412358, 3661.2311414602964, 1202.7955247607927, 1206.6380085974172, 1220.3227208899057, 1242.975140497194, 1250.4810503640979, 13702.52041178564, 13753.79369309461, 13775.586732398144, 13800.861991380158, 13851.376688049062, 4779.928301075487, 4872.658913875995, 4904.558589726942, 4909.410870695468, 4989.201727723546, 11491.655250342503, 11524.88475115255, 11535.307881527135, 11547.133964952494, 11561.653150405502, 5653.378128405954, 5665.150227465913, 5694.06048002075, 5705.400932902068, 5711.171880077365, 4568.1548913451115, 4841.443234028132, 4945.258211268267, 4959.752012399365, 5230.97384513075, 4333.566643335705, 4406.581374769392, 4427.822887084545, 4448.132614140211, 4463.62059224963, 1269.51123817331, 1293.2951541409955, 1302.7134030513462, 1306.8039794030972, 1323.3780123342015, 1069.6416700405296, 1071.3839542263229, 1075.4837677914645, 1085.79369919715, 1092.7377429416883, 6280.9685951569945, 6328.272248691367, 6633.137692100093, 6760.087388202628, 6830.214525329551, 471.9740414277248, 476.2594166071722, 481.9614430845524, 485.22848670613894, 488.699449838354, 4447.7998490067375, 4455.353973673799, 4521.773911304422, 4535.274356103074, 4640.628749700016, 11841.0, 11891.227070240408, 11959.342236176919, 12012.579559715543, 12101.455434505468, 11838.171328007129, 12014.279143251433, 12080.577179798665, 12108.0, 12165.75668486643, 8949.955250223707, 8969.551522423853, 9005.324600654978, 9018.053104423941, 9050.683226087056, 6380.084207181391, 6400.551961362846, 6400.751853388544, 6485.837854053498, 6488.610683359014, 10734.51694673726, 10778.568857245622, 10867.945660271647, 10874.782504350027, 11166.330020198815, 11023.173262005543, 11276.210665253353, 11296.0, 11367.715807104558, 11485.942570287096, 7648.426368022309, 8005.3995950305125, 8205.302549283379, 8269.917300826915, 8356.707515236938, 9316.48759318217, 9359.812803744024, 9386.436813791195, 9393.906060939576, 9395.342326037111, 8184.549849758082, 8277.379196560161, 8284.337253019865, 8417.200365965224, 8451.577421129043, 8098.676052957816, 8113.310368618733, 8261.669533218605, 8303.335733141213, 8505.872411913702, 7083.150021997393, 7113.715451382094, 7124.073870396815, 7160.319769621878, 7179.533330333512, 5846.795362162304, 5976.133460648269, 5992.43071908168, 5997.340292567901, 6011.188489553854, 5814.825555233349, 5826.475617194473, 5833.620814647034, 5894.204282421818, 5920.851978700394], "value": 4928.56063557095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.54003904787106, 350.92791521900597, 351.2272999401318, 355.7545293747316, 355.8683287183741, 5782.248307719996, 5803.651780893144, 5816.33112192098, 5824.592278540498, 5833.5333173346135, 5670.914936275959, 5706.600537962344, 5709.257796486451, 5725.599208055438, 5737.741801618927, 4079.326911059679, 4420.651701231123, 4430.734155950637, 4435.334699795024, 4441.223510595772, 4417.249067658489, 4426.800793964263, 4439.178751930903, 4459.866204013869, 4489.102179564084, 4434.467863856342, 4445.0, 4461.821527138911, 4472.776361181945, 4484.013517026266, 4319.568043195671, 4404.317330813713, 4423.623991960687, 4428.070105277896, 4454.754988475633, 3902.7412110887444, 3915.941260881089, 3924.1170736584327, 3941.054147004727, 3969.761814291152, 5579.6652200868075, 5597.382159718249, 5619.325680918275, 5646.576506761969, 5661.971690141523, 4907.987715049072, 5060.2409638554145, 5087.949120508784, 5129.230615407681, 5133.84598462043, 5930.970345148246, 5932.911006334908, 5941.970290148565, 5969.8806023879715, 5978.459154859167, 4342.630876375511, 4368.60682538573, 4373.693841431101, 4382.605565499089, 4388.956110438887, 5866.677332746697, 6110.175126357974, 6166.84582885427, 6174.487250623626, 6203.193584833988, 4323.7621930793475, 4376.868693939187, 4389.780510974439, 4404.581564751344, 4408.669349798778, 4328.545502722169, 4403.405540252089, 4412.889677758082, 4415.823367065345, 4439.644828413784, 5026.29631851541, 5028.899422011613, 5067.113255180328, 5104.927965127291, 5115.130427827278, 6007.189029480965, 6041.214642096499, 6041.9395806041375, 6042.969785151134, 6070.6357618543025, 1495.3271028037427, 1512.9773053404208, 1531.716632422983, 1557.6183834960507, 1568.968620627581, 955.5747692277009, 955.6655170690203, 990.559201155479, 1024.959001639926, 1056.5826498533036, 5867.85576812526, 5878.676672783038, 5879.235699359056, 5883.3234178069215, 5902.734376953047, 6123.785667501616, 6152.630842149485, 6155.415235552616, 6157.7229024694, 6192.0, 5798.6810725410505, 5801.593888427769, 5820.447057529528, 5851.707414629337, 5875.618084824473, 3206.7755257132244, 3238.2552013037134, 3276.574045374086, 3282.688144626257, 3285.211549228216, 6079.635221886701, 6287.49700023997, 6295.213098362705, 6350.7777227796805, 6377.585456945284, 6096.8780624388155, 6155.507559395238, 6214.788116317365, 6236.38072009757, 6247.0, 6112.602680825732, 6300.27546832111, 6379.617222966637, 6443.873521737815, 6455.61266324022, 6191.349908259568, 6203.472704820141, 6227.283862355887, 6247.468965138014, 6248.156498872594, 6156.968200493916, 6190.0, 6207.0, 6224.564280500322, 6240.625562466085, 6316.526260530387, 6416.262129854939, 6442.774502892376, 6524.347565243438, 6567.146270984933, 4375.824967001412, 4388.5830846069575, 4401.889952751078, 4434.113177364476, 4444.933326000048, 6070.817875463743, 6212.316645169119, 6217.818614463418, 6236.812895613139, 6270.592411493239, 6035.39646035393, 6053.061775424816, 6063.333033366238, 6096.725647345791, 6127.938720612915, 6074.544409169242, 6090.147379366981, 6125.816225513242, 6129.2032035835055, 6141.815745527641, 5880.588358815013, 5894.469497745224, 5965.971569666334, 6054.455099041107, 6078.270607526948, 6011.428914253139, 6077.201748906933, 6080.543959202989, 6097.2683278006925, 6127.019676851683, 5842.685395785914, 5853.795117170878, 5879.441453061952, 5919.940800591939, 5937.703114844154], "value": 4587.333182272118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.3460900497611, 843.472829481574, 883.1521739130435, 906.9455832650045, 916.8323294662197, 14479.927600361996, 15378.231088445575, 15412.30644620992, 15559.688806223869, 15647.765283520743, 16487.422940197095, 16550.917245413755, 16611.169441527934, 16640.0, 16760.32958681651, 873.5370253765483, 875.0243478521451, 893.8167675626481, 895.7671005538574, 900.8963969143534, 881.8809460722816, 882.4043770454949, 882.7837179890936, 883.2271762208068, 883.8983516895543, 938.3197182042999, 942.4486675294961, 943.3538026451903, 944.1974321826461, 945.8581212818063, 933.5005771911995, 935.854942483916, 935.8830146231721, 937.7421209167466, 940.1209868772719, 688.2841844481733, 689.5552368722147, 691.1119211812846, 691.930966656517, 695.5061906046712, 15755.291011904377, 15823.20883955809, 15837.524874253791, 15922.522324330288, 16017.11905845178, 16337.673246535003, 16596.50210493675, 16598.75101873473, 16678.16609169549, 16857.0, 13498.52755153565, 13680.247586382746, 13710.862891371158, 13809.102408343526, 13992.16047037181, 4112.045817108109, 4112.239235741397, 4130.421740956239, 4181.205570941512, 4189.811458484375, 89800.0, 90863.54568227117, 90883.0, 90952.09047909568, 91030.08969910283, 11275.154363422776, 11275.66173014811, 11609.0, 11695.766084678258, 11887.762244755057, 23711.762882371302, 23748.406289842547, 23800.285991420285, 23850.642240366407, 23894.880525597608, 9161.77095572616, 9215.262778977665, 9323.160915517636, 9687.9031209687, 9732.805343893224, 5323.893522129613, 5336.573074154058, 5390.380106287748, 5477.7261136943, 5570.61005729595, 3963.6829053675638, 4045.4336392905016, 4080.469538959916, 4083.0813067059676, 4087.6525495332635, 639.1658885154825, 653.8038588423454, 657.7237560224717, 668.1347654787062, 670.0485310858593, 669.8425869920565, 739.6597565119997, 747.3050063441052, 762.9791001422473, 837.3928901546452, 10779.78440431187, 11036.779264414667, 11274.605388811517, 11635.185537012498, 11873.0, 634.4607083978674, 774.4153164360871, 786.2059320086754, 789.3842802613971, 805.5810978291256, 5207.973960130175, 5245.318108645852, 5252.842414727565, 5263.5525980292105, 5289.9471005290225, 87081.56459217664, 115945.84054159519, 132430.33784831208, 135425.0, 135908.0, 65924.0, 69662.30337696659, 93574.0, 113881.0, 113944.0, 81398.5930070346, 81777.91110444455, 82259.3548129034, 83900.58049709712, 93526.0, 9972.50137493137, 10619.840702389625, 11016.339019658846, 11311.490982905625, 11353.716157096138, 54207.45792542182, 54839.45160548343, 54943.17585236305, 55238.17142742943, 55666.44333556775, 73171.0, 78936.60531697304, 80245.59877200576, 82839.58580207061, 82887.5855620718, 12872.16330938486, 13258.33708314561, 13315.933420332836, 13382.93308533451, 13685.931570342085, 14451.421943122157, 15382.307796149424, 15445.227738612799, 15740.763888541453, 16036.037837729773, 14454.205018724071, 14523.564293071226, 14574.781378279546, 15221.923890380478, 15472.226388680296, 14270.928645356707, 14826.62933426673, 14978.176200309088, 15215.771763423336, 15487.148206848731, 14121.717565648423, 14229.14625122496, 14365.353559090076, 15137.772933406228, 15264.694706105594, 12063.517459301529, 12247.0, 12575.371231438574, 12717.109802314118, 13133.212007279593, 11133.665990020312, 11443.599474018369, 11687.123465740273, 11966.961581380603, 12674.176178548734], "value": 8207.29208872618, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 109.0, 108.0, 111.0, 110.0, 111.0, 110.0, 111.0, 121.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 143.0, 172.0, 118.0, 152.0, 141.0, 118.0, 176.0, 119.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 166.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 172.0, 76.0, 76.0, 75.0, 76.0, 178.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 150.0, 86.0, 83.0, 84.0, 139.0, 83.0, 83.0, 139.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 157.0, 147.0, 147.0, 147.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 51.0, 52.0, 52.0, 54.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 61.0, 58.0, 59.0, 59.0, 60.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 72.0, 72.0, 72.0, 74.0, 72.0, 79.0, 75.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 120.0, 124.0, 124.0, 120.0, 117.0, 126.0, 126.0, 151.0, 126.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 156.0, 152.0, 152.0, 156.0, 153.0, 154.0, 156.0, 152.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 63.0, 62.0, 65.0, 62.0, 62.0, 61.0, 61.0, 66.0], "value": 63.3, "unit": "score"}]}]} 04:17:01 INFO - Return code: 0 04:17:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:01 ERROR - # TBPL SUCCESS # 04:17:01 INFO - Running post-action listener: _resource_record_post_action 04:17:01 INFO - [mozharness: 2016-09-09 11:17:01.229907Z] Finished run-tests step (success) 04:17:01 INFO - Running post-run listener: _resource_record_post_run 04:17:01 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 329338880; Read time: 0; Write time: 182056 04:17:01 INFO - TinderboxPrint: CPU usage
13.2% 04:17:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:17:01 INFO - TinderboxPrint: I/O write bytes / time
329,338,880 / 182,056 04:17:01 INFO - TinderboxPrint: CPU idle
8,226.5 (86.8%) 04:17:01 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 04:17:01 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77180928; Read time: 0; Write time: 67116 04:17:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249679872; Read time: 0; Write time: 114680 04:17:01 INFO - Running post-run listener: _upload_blobber_files 04:17:01 INFO - Blob upload gear active. 04:17:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:01 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:17:01 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:17:01 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:17:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:03 INFO - (blobuploader) - INFO - Done attempting. 04:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:07 INFO - (blobuploader) - INFO - Done attempting. 04:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:17:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:08 INFO - (blobuploader) - INFO - Done attempting. 04:17:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:08 INFO - Return code: 0 04:17:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a51e707316981795e21130a28237a96cfe90552d264a904186df70d16ce9c3bc8f0f443a85f9312d4ad492519c95dfaf6d5a191dbe87ffd56d0327eaf5891338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7234889a2615a617f9c591e596d7f1b20378484a4290208909c69e0e9ce5a850df3d636d2e0b72e4820c8f01895f0e9c1f5a46b36f8144a486dbee1c3401baf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52cf4531ae68acf52cf4008c12e204d43d21b1fc4ea27e6da305c7d9f47463f4765cd53e4d43f3ea6beb5bef12f0d3d1e86b53e6bcc4472a6c6c29a195e70a71"} 04:17:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:08 INFO - Contents: 04:17:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a51e707316981795e21130a28237a96cfe90552d264a904186df70d16ce9c3bc8f0f443a85f9312d4ad492519c95dfaf6d5a191dbe87ffd56d0327eaf5891338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7234889a2615a617f9c591e596d7f1b20378484a4290208909c69e0e9ce5a850df3d636d2e0b72e4820c8f01895f0e9c1f5a46b36f8144a486dbee1c3401baf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52cf4531ae68acf52cf4008c12e204d43d21b1fc4ea27e6da305c7d9f47463f4765cd53e4d43f3ea6beb5bef12f0d3d1e86b53e6bcc4472a6c6c29a195e70a71"} 04:17:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:08 INFO - Copying logs to upload dir... 04:17:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.885454 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-09 04:17:07.782827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 04:17:07.786174) ========= 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=6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349 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/a51e707316981795e21130a28237a96cfe90552d264a904186df70d16ce9c3bc8f0f443a85f9312d4ad492519c95dfaf6d5a191dbe87ffd56d0327eaf5891338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7234889a2615a617f9c591e596d7f1b20378484a4290208909c69e0e9ce5a850df3d636d2e0b72e4820c8f01895f0e9c1f5a46b36f8144a486dbee1c3401baf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52cf4531ae68acf52cf4008c12e204d43d21b1fc4ea27e6da305c7d9f47463f4765cd53e4d43f3ea6beb5bef12f0d3d1e86b53e6bcc4472a6c6c29a195e70a71"} build_url:https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/dLFjnjlbRBKUiuECwbp7xQ/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/a51e707316981795e21130a28237a96cfe90552d264a904186df70d16ce9c3bc8f0f443a85f9312d4ad492519c95dfaf6d5a191dbe87ffd56d0327eaf5891338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7234889a2615a617f9c591e596d7f1b20378484a4290208909c69e0e9ce5a850df3d636d2e0b72e4820c8f01895f0e9c1f5a46b36f8144a486dbee1c3401baf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52cf4531ae68acf52cf4008c12e204d43d21b1fc4ea27e6da305c7d9f47463f4765cd53e4d43f3ea6beb5bef12f0d3d1e86b53e6bcc4472a6c6c29a195e70a71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 04:17:07.814100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 04:17:07.814760) ========= 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=6dbc10da6d83fee962c624be000001a8-1473418149.816720-599103349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 04:17:07.901558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 04:17:07.902289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 04:17:07.902597) ========= ========= Total master_lag: 0.17 =========