builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1471518330.63 results: success (0) buildid: 20160817221914 builduid: 8a42d84b4c664f7f898715475fc754b5 revision: d23f68f5cb77934e673700bfaaaf607893a2df9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.625897) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.626248) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.626508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.712061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.712315) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 04:05:31-- 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% 46.3M=0s 2016-08-18 04:05:31 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.824824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.825131) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018196 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.878191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.878483) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d23f68f5cb77934e673700bfaaaf607893a2df9b --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 d23f68f5cb77934e673700bfaaaf607893a2df9b --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=5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 04:05:31,298 truncating revision to first 12 chars 2016-08-18 04:05:31,298 Setting DEBUG logging. 2016-08-18 04:05:31,298 attempt 1/10 2016-08-18 04:05:31,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d23f68f5cb77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 04:05:31,614 unpacking tar archive at: mozilla-aurora-d23f68f5cb77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705532 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.597013) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.597304) ========= script_repo_revision: d23f68f5cb77934e673700bfaaaf607893a2df9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.597670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.597931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.609063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 6 secs) (at 2016-08-18 04:05:31.609389) ========= /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=5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:32 INFO - MultiFileLogger online at 20160818 04:05:32 in /builds/slave/test 04:05:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:05:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:32 INFO - {'append_to_log': False, 04:05:32 INFO - 'base_work_dir': '/builds/slave/test', 04:05:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:32 INFO - 'branch': 'Mozilla-Aurora', 04:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:32 INFO - 'config_files': ('talos/linux_config.py',), 04:05:32 INFO - 'default_actions': ('clobber', 04:05:32 INFO - 'read-buildbot-config', 04:05:32 INFO - 'download-and-extract', 04:05:32 INFO - 'populate-webroot', 04:05:32 INFO - 'create-virtualenv', 04:05:32 INFO - 'install', 04:05:32 INFO - 'run-tests'), 04:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:32 INFO - 'download_minidump_stackwalk': True, 04:05:32 INFO - 'download_symbols': 'ondemand', 04:05:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:32 INFO - 'installer_path': 'installer.exe', 04:05:32 INFO - 'log_level': 'info', 04:05:32 INFO - 'log_name': 'talos', 04:05:32 INFO - 'log_to_console': True, 04:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:32 INFO - 'opt_config_files': (), 04:05:32 INFO - 'pip_index': False, 04:05:32 INFO - 'sps_profile': False, 04:05:32 INFO - 'sps_profile_interval': 0, 04:05:32 INFO - 'suite': 'dromaeojs-e10s', 04:05:32 INFO - 'system_bits': '32', 04:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:32 INFO - 'title': 'talos-linux64-ix-011', 04:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:32 INFO - 'use_talos_json': True, 04:05:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:32 INFO - 'work_dir': 'build'} 04:05:32 INFO - [mozharness: 2016-08-18 11:05:32.112893Z] Running clobber step. 04:05:32 INFO - Running pre-action listener: _resource_record_pre_action 04:05:32 INFO - Running main action method: clobber 04:05:32 INFO - rmtree: /builds/slave/test/build 04:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:32 INFO - Running post-action listener: _resource_record_post_action 04:05:32 INFO - [mozharness: 2016-08-18 11:05:32.582737Z] Finished clobber step (success) 04:05:32 INFO - [mozharness: 2016-08-18 11:05:32.582838Z] Running read-buildbot-config step. 04:05:32 INFO - Running pre-action listener: _resource_record_pre_action 04:05:32 INFO - Running main action method: read_buildbot_config 04:05:32 INFO - Using buildbot properties: 04:05:32 INFO - { 04:05:32 INFO - "project": "", 04:05:32 INFO - "product": "firefox", 04:05:32 INFO - "script_repo_revision": "production", 04:05:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:05:32 INFO - "repository": "", 04:05:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:05:32 INFO - "buildid": "20160817221914", 04:05:32 INFO - "pgo_build": "True", 04:05:32 INFO - "basedir": "/builds/slave/test", 04:05:32 INFO - "buildnumber": 487, 04:05:32 INFO - "slavename": "talos-linux64-ix-011", 04:05:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:32 INFO - "platform": "ubuntu64_hw", 04:05:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:05:32 INFO - "branch": "mozilla-aurora", 04:05:32 INFO - "repo_path": "releases/mozilla-aurora", 04:05:32 INFO - "revision": "d23f68f5cb77934e673700bfaaaf607893a2df9b", 04:05:32 INFO - "stage_platform": "linux64-pgo", 04:05:32 INFO - "builduid": "8a42d84b4c664f7f898715475fc754b5", 04:05:32 INFO - "slavebuilddir": "test" 04:05:32 INFO - } 04:05:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 04:05:32 INFO - Running post-action listener: _resource_record_post_action 04:05:32 INFO - [mozharness: 2016-08-18 11:05:32.585288Z] Finished read-buildbot-config step (success) 04:05:32 INFO - [mozharness: 2016-08-18 11:05:32.585379Z] Running download-and-extract step. 04:05:32 INFO - Running pre-action listener: _resource_record_pre_action 04:05:32 INFO - Running main action method: download_and_extract 04:05:32 INFO - mkdir: /builds/slave/test/build/tests 04:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:32 INFO - https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:05:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:05:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:05:32 INFO - retry: Failed, sleeping 30 seconds before retrying 04:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 04:06:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:06:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:06:02 INFO - retry: Failed, sleeping 60 seconds before retrying 04:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 04:07:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:07:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:07:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 04:07:02 INFO - Caught exception: HTTP Error 404: Not Found 04:07:02 INFO - Caught exception: HTTP Error 404: Not Found 04:07:02 INFO - Caught exception: HTTP Error 404: Not Found 04:07:02 INFO - trying https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:07:03 INFO - Downloaded 1361 bytes. 04:07:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:07:03 INFO - Using the following test package requirements: 04:07:03 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:07:03 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:03 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:07:03 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'jsshell-linux-x86_64.zip'], 04:07:03 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:03 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:07:03 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:07:03 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:07:03 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:03 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:03 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:03 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:03 INFO - https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:07:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:07:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:07:03 INFO - retry: Failed, sleeping 30 seconds before retrying 04:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 04:07:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:07:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:07:33 INFO - retry: Failed, sleeping 60 seconds before retrying 04:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/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 04:08:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:08:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 04:08:33 INFO - Caught exception: HTTP Error 404: Not Found 04:08:33 INFO - Caught exception: HTTP Error 404: Not Found 04:08:33 INFO - Caught exception: HTTP Error 404: Not Found 04:08:33 INFO - trying https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:37 INFO - Downloaded 21766304 bytes. 04:08:37 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'] 04:08:37 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 04:08:39 INFO - Return code: 0 04:08:39 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 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:08:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:08:39 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 04:09:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:09:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:09:09 INFO - retry: Failed, sleeping 60 seconds before retrying 04:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/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 04:10:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:10:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:10:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 04:10:09 INFO - Caught exception: HTTP Error 404: Not Found 04:10:09 INFO - Caught exception: HTTP Error 404: Not Found 04:10:09 INFO - Caught exception: HTTP Error 404: Not Found 04:10:09 INFO - trying https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:10:09 INFO - Downloading https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:10:10 INFO - Downloaded 21766304 bytes. 04:10:10 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'] 04:10:10 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 04:10:11 INFO - Return code: 0 04:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:11 INFO - https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:10:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:10:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:10:11 INFO - retry: Failed, sleeping 30 seconds before retrying 04:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/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 04:10:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:10:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:10:41 INFO - retry: Failed, sleeping 60 seconds before retrying 04:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 04:11:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:11:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:11:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 04:11:41 INFO - Caught exception: HTTP Error 404: Not Found 04:11:41 INFO - Caught exception: HTTP Error 404: Not Found 04:11:41 INFO - Caught exception: HTTP Error 404: Not Found 04:11:41 INFO - trying https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:11:41 INFO - Downloading https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:11:42 INFO - Downloaded 14413723 bytes. 04:11:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:11:42 INFO - Return code: 0 04:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:42 INFO - https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:11:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:11:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:11:42 INFO - retry: Failed, sleeping 30 seconds before retrying 04:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 04:12:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:12:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:12:12 INFO - retry: Failed, sleeping 60 seconds before retrying 04:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 04:13:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:13:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:13:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 04:13:12 INFO - Caught exception: HTTP Error 404: Not Found 04:13:12 INFO - Caught exception: HTTP Error 404: Not Found 04:13:12 INFO - Caught exception: HTTP Error 404: Not Found 04:13:12 INFO - trying https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:13:12 INFO - Downloading https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:14 INFO - Downloaded 63746489 bytes. 04:13:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:13:14 INFO - mkdir: /builds/slave/test/properties 04:13:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:14 INFO - Contents: 04:13:14 INFO - build_url:https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:13:15 INFO - Running post-action listener: _resource_record_post_action 04:13:15 INFO - Running post-action listener: set_extra_try_arguments 04:13:15 INFO - [mozharness: 2016-08-18 11:13:15.396945Z] Finished download-and-extract step (success) 04:13:15 INFO - [mozharness: 2016-08-18 11:13:15.397176Z] Running populate-webroot step. 04:13:15 INFO - Running pre-action listener: _resource_record_pre_action 04:13:15 INFO - Running main action method: populate_webroot 04:13:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:15 INFO - '--tppagecycles', 04:13:15 INFO - '7'], 04:13:15 INFO - 'tests': ['tsvgm']}}, 04:13:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['damp', 'tps']}, 04:13:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'tests': ['damp', 'tps']}, 04:13:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['dromaeo_dom']}, 04:13:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['basic_compositor_video']}, 04:13:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['a11yr', 04:13:15 INFO - 'ts_paint', 04:13:15 INFO - 'tpaint', 04:13:15 INFO - 'sessionrestore', 04:13:15 INFO - 'sessionrestore_no_auto_restore', 04:13:15 INFO - 'tabpaint']}, 04:13:15 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:15 INFO - 'ts_paint', 04:13:15 INFO - 'tpaint', 04:13:15 INFO - 'sessionrestore', 04:13:15 INFO - 'sessionrestore_no_auto_restore', 04:13:15 INFO - 'tabpaint']}, 04:13:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:15 INFO - 'ts_paint', 04:13:15 INFO - 'tpaint', 04:13:15 INFO - 'sessionrestore', 04:13:15 INFO - 'sessionrestore_no_auto_restore', 04:13:15 INFO - 'tabpaint']}, 04:13:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:15 INFO - 'ts_paint', 04:13:15 INFO - 'tpaint', 04:13:15 INFO - 'sessionrestore', 04:13:15 INFO - 'sessionrestore_no_auto_restore', 04:13:15 INFO - 'tabpaint']}, 04:13:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['a11yr', 04:13:15 INFO - 'ts_paint', 04:13:15 INFO - 'tpaint', 04:13:15 INFO - 'sessionrestore', 04:13:15 INFO - 'sessionrestore_no_auto_restore', 04:13:15 INFO - 'tabpaint']}, 04:13:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['a11yr', 04:13:15 INFO - 'ts_paint', 04:13:15 INFO - 'tpaint', 04:13:15 INFO - 'sessionrestore', 04:13:15 INFO - 'sessionrestore_no_auto_restore', 04:13:15 INFO - 'tabpaint']}, 04:13:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['tsvgx', 04:13:15 INFO - 'tsvgr_opacity', 04:13:15 INFO - 'tart', 04:13:15 INFO - 'tscrollx', 04:13:15 INFO - 'cart']}, 04:13:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:15 INFO - 'tsvgr_opacity', 04:13:15 INFO - 'tart', 04:13:15 INFO - 'tscrollx', 04:13:15 INFO - 'cart']}, 04:13:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'talos_options': ['--disable-e10s'], 04:13:15 INFO - 'tests': ['tp5o']}, 04:13:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'tests': ['tp5o']}, 04:13:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'talos_options': ['--disable-e10s', 04:13:15 INFO - '--xperf_path', 04:13:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:15 INFO - 'tests': ['tp5n']}, 04:13:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:15 INFO - 'talos_options': ['--xperf_path', 04:13:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:15 INFO - 'tests': ['tp5n']}}, 04:13:15 INFO - 'talos.zip': {'path': '', 04:13:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:15 INFO - Running post-action listener: _resource_record_post_action 04:13:15 INFO - [mozharness: 2016-08-18 11:13:15.413152Z] Finished populate-webroot step (success) 04:13:15 INFO - [mozharness: 2016-08-18 11:13:15.413260Z] Running create-virtualenv step. 04:13:15 INFO - Running pre-action listener: _resource_record_pre_action 04:13:15 INFO - Running main action method: create_virtualenv 04:13:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:13:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:15 INFO - Using real prefix '/usr' 04:13:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:17 INFO - Installing pip.................done. 04:13:17 INFO - Return code: 0 04:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:17 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:17 INFO - Using env: {'DISPLAY': ':0', 04:13:17 INFO - 'HOME': '/home/cltbld', 04:13:17 INFO - 'LANG': 'en_US.UTF-8', 04:13:17 INFO - 'LANGUAGE': 'en_US:en', 04:13:17 INFO - 'LOGNAME': 'cltbld', 04:13:17 INFO - 'MAIL': '/var/mail/cltbld', 04:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:17 INFO - 'MOZ_NO_REMOTE': '1', 04:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:17 INFO - 'NO_EM_RESTART': '1', 04:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:17 INFO - 'PWD': '/builds/slave/test', 04:13:18 INFO - 'SHELL': '/bin/bash', 04:13:18 INFO - 'SHLVL': '1', 04:13:18 INFO - 'TERM': 'linux', 04:13:18 INFO - 'TMOUT': '86400', 04:13:18 INFO - 'USER': 'cltbld', 04:13:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:18 INFO - '_': '/tools/buildbot/bin/python'} 04:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:13:18 INFO - Cleaning up... 04:13:18 INFO - Return code: 0 04:13:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:18 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:13:18 INFO - Using env: {'DISPLAY': ':0', 04:13:18 INFO - 'HOME': '/home/cltbld', 04:13:18 INFO - 'LANG': 'en_US.UTF-8', 04:13:18 INFO - 'LANGUAGE': 'en_US:en', 04:13:18 INFO - 'LOGNAME': 'cltbld', 04:13:18 INFO - 'MAIL': '/var/mail/cltbld', 04:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:18 INFO - 'MOZ_NO_REMOTE': '1', 04:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:18 INFO - 'NO_EM_RESTART': '1', 04:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:18 INFO - 'PWD': '/builds/slave/test', 04:13:18 INFO - 'SHELL': '/bin/bash', 04:13:18 INFO - 'SHLVL': '1', 04:13:18 INFO - 'TERM': 'linux', 04:13:18 INFO - 'TMOUT': '86400', 04:13:18 INFO - 'USER': 'cltbld', 04:13:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:18 INFO - '_': '/tools/buildbot/bin/python'} 04:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:18 INFO - Downloading/unpacking psutil>=3.1.1 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:21 INFO - Installing collected packages: psutil 04:13:21 INFO - Running setup.py install for psutil 04:13:21 INFO - building 'psutil._psutil_linux' extension 04:13:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:13:21 INFO - building 'psutil._psutil_posix' extension 04:13:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:21 INFO - Successfully installed psutil 04:13:21 INFO - Cleaning up... 04:13:21 INFO - Return code: 0 04:13:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:21 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:13:21 INFO - Using env: {'DISPLAY': ':0', 04:13:21 INFO - 'HOME': '/home/cltbld', 04:13:21 INFO - 'LANG': 'en_US.UTF-8', 04:13:21 INFO - 'LANGUAGE': 'en_US:en', 04:13:21 INFO - 'LOGNAME': 'cltbld', 04:13:21 INFO - 'MAIL': '/var/mail/cltbld', 04:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:21 INFO - 'MOZ_NO_REMOTE': '1', 04:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:21 INFO - 'NO_EM_RESTART': '1', 04:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:21 INFO - 'PWD': '/builds/slave/test', 04:13:21 INFO - 'SHELL': '/bin/bash', 04:13:21 INFO - 'SHLVL': '1', 04:13:21 INFO - 'TERM': 'linux', 04:13:21 INFO - 'TMOUT': '86400', 04:13:21 INFO - 'USER': 'cltbld', 04:13:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:21 INFO - '_': '/tools/buildbot/bin/python'} 04:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:24 INFO - Installing collected packages: mozsystemmonitor 04:13:24 INFO - Running setup.py install for mozsystemmonitor 04:13:24 INFO - Successfully installed mozsystemmonitor 04:13:24 INFO - Cleaning up... 04:13:24 INFO - Return code: 0 04:13:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:24 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:13:24 INFO - Using env: {'DISPLAY': ':0', 04:13:24 INFO - 'HOME': '/home/cltbld', 04:13:24 INFO - 'LANG': 'en_US.UTF-8', 04:13:24 INFO - 'LANGUAGE': 'en_US:en', 04:13:24 INFO - 'LOGNAME': 'cltbld', 04:13:24 INFO - 'MAIL': '/var/mail/cltbld', 04:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:24 INFO - 'MOZ_NO_REMOTE': '1', 04:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:24 INFO - 'NO_EM_RESTART': '1', 04:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:24 INFO - 'PWD': '/builds/slave/test', 04:13:24 INFO - 'SHELL': '/bin/bash', 04:13:24 INFO - 'SHLVL': '1', 04:13:24 INFO - 'TERM': 'linux', 04:13:24 INFO - 'TMOUT': '86400', 04:13:24 INFO - 'USER': 'cltbld', 04:13:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:24 INFO - '_': '/tools/buildbot/bin/python'} 04:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:26 INFO - warning: no files found matching '*.txt' 04:13:26 INFO - no previously-included directories found matching 'build' 04:13:26 INFO - no previously-included directories found matching 'dist' 04:13:26 INFO - no previously-included directories found matching '.git*' 04:13:26 INFO - Installing collected packages: jsonschema, functools32 04:13:26 INFO - Running setup.py install for functools32 04:13:26 INFO - warning: no files found matching '*.txt' 04:13:26 INFO - no previously-included directories found matching 'build' 04:13:26 INFO - no previously-included directories found matching 'dist' 04:13:26 INFO - no previously-included directories found matching '.git*' 04:13:26 INFO - Successfully installed jsonschema functools32 04:13:26 INFO - Cleaning up... 04:13:27 INFO - Return code: 0 04:13:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:13:27 INFO - Cleaning up... 04:13:27 INFO - Return code: 0 04:13:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:30 INFO - Downloading docopt-0.6.1.tar.gz 04:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:30 INFO - Running setup.py install for blobuploader 04:13:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:30 INFO - Running setup.py install for requests 04:13:30 INFO - Running setup.py install for docopt 04:13:30 INFO - Successfully installed blobuploader requests docopt 04:13:30 INFO - Cleaning up... 04:13:30 INFO - Return code: 0 04:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:30 INFO - Using env: {'DISPLAY': ':0', 04:13:30 INFO - 'HOME': '/home/cltbld', 04:13:30 INFO - 'LANG': 'en_US.UTF-8', 04:13:30 INFO - 'LANGUAGE': 'en_US:en', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MAIL': '/var/mail/cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SHLVL': '1', 04:13:30 INFO - 'TERM': 'linux', 04:13:30 INFO - 'TMOUT': '86400', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - '_': '/tools/buildbot/bin/python'} 04:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:31 INFO - Running setup.py (path:/tmp/pip-nB7OVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:31 INFO - Running setup.py (path:/tmp/pip-jjWCFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:31 INFO - Running setup.py (path:/tmp/pip-Sbx3Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:31 INFO - Running setup.py (path:/tmp/pip-c9jIdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:31 INFO - Running setup.py (path:/tmp/pip-lCDJmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:31 INFO - Running setup.py (path:/tmp/pip-ahgVdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:31 INFO - Running setup.py (path:/tmp/pip-qXLWI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:31 INFO - Running setup.py (path:/tmp/pip-JFaC4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:31 INFO - Running setup.py (path:/tmp/pip-J33cwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:31 INFO - Running setup.py (path:/tmp/pip-wBs4sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:31 INFO - Running setup.py (path:/tmp/pip-6CMtZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:31 INFO - Running setup.py (path:/tmp/pip-0LJ39j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:31 INFO - Running setup.py (path:/tmp/pip-nUQMan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:32 INFO - Running setup.py (path:/tmp/pip-fGWypM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:32 INFO - Running setup.py (path:/tmp/pip-yyfHwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:32 INFO - Running setup.py (path:/tmp/pip-3S1uz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:32 INFO - Running setup.py (path:/tmp/pip-Mgw8LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:32 INFO - Running setup.py install for manifestparser 04:13:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:32 INFO - Running setup.py install for mozcrash 04:13:32 INFO - Running setup.py install for mozdebug 04:13:32 INFO - Running setup.py install for mozdevice 04:13:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:32 INFO - Running setup.py install for mozfile 04:13:32 INFO - Running setup.py install for mozhttpd 04:13:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:32 INFO - Running setup.py install for mozinfo 04:13:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:32 INFO - Running setup.py install for mozInstall 04:13:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for mozleak 04:13:33 INFO - Running setup.py install for mozlog 04:13:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for moznetwork 04:13:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for mozprocess 04:13:33 INFO - Running setup.py install for mozprofile 04:13:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for mozrunner 04:13:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for mozscreenshot 04:13:33 INFO - Running setup.py install for moztest 04:13:33 INFO - Running setup.py install for mozversion 04:13:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:34 INFO - Using env: {'DISPLAY': ':0', 04:13:34 INFO - 'HOME': '/home/cltbld', 04:13:34 INFO - 'LANG': 'en_US.UTF-8', 04:13:34 INFO - 'LANGUAGE': 'en_US:en', 04:13:34 INFO - 'LOGNAME': 'cltbld', 04:13:34 INFO - 'MAIL': '/var/mail/cltbld', 04:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:34 INFO - 'MOZ_NO_REMOTE': '1', 04:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:34 INFO - 'NO_EM_RESTART': '1', 04:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:34 INFO - 'PWD': '/builds/slave/test', 04:13:34 INFO - 'SHELL': '/bin/bash', 04:13:34 INFO - 'SHLVL': '1', 04:13:34 INFO - 'TERM': 'linux', 04:13:34 INFO - 'TMOUT': '86400', 04:13:34 INFO - 'USER': 'cltbld', 04:13:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:34 INFO - Running setup.py (path:/tmp/pip-xRDz_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:34 INFO - Running setup.py (path:/tmp/pip-200uBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:34 INFO - Running setup.py (path:/tmp/pip-Yy_0HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:34 INFO - Running setup.py (path:/tmp/pip-8IR0XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:34 INFO - Running setup.py (path:/tmp/pip-TvXyLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:34 INFO - Running setup.py (path:/tmp/pip-dGcxqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:34 INFO - Running setup.py (path:/tmp/pip-o1fcWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:34 INFO - Running setup.py (path:/tmp/pip-UqRr1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:34 INFO - Running setup.py (path:/tmp/pip-pUUpw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:34 INFO - Running setup.py (path:/tmp/pip-s3CUPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:34 INFO - Running setup.py (path:/tmp/pip-BDnoAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:35 INFO - Running setup.py (path:/tmp/pip-bS3I25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:35 INFO - Running setup.py (path:/tmp/pip-dHhGxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:35 INFO - Running setup.py (path:/tmp/pip-7EbLSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:35 INFO - Running setup.py (path:/tmp/pip-uH5DTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:35 INFO - Running setup.py (path:/tmp/pip-TCahY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:35 INFO - Running setup.py (path:/tmp/pip-oFYG1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:37 INFO - Downloading blessings-1.6.tar.gz 04:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:37 INFO - Installing collected packages: blessings 04:13:37 INFO - Running setup.py install for blessings 04:13:37 INFO - Successfully installed blessings 04:13:37 INFO - Cleaning up... 04:13:37 INFO - Return code: 0 04:13:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:37 INFO - Reading from file tmpfile_stdout 04:13:37 INFO - Current package versions: 04:13:37 INFO - argparse == 1.2.1 04:13:37 INFO - blessings == 1.6 04:13:37 INFO - blobuploader == 1.2.4 04:13:37 INFO - docopt == 0.6.1 04:13:37 INFO - functools32 == 3.2.3-2 04:13:37 INFO - jsonschema == 2.5.1 04:13:37 INFO - manifestparser == 1.1 04:13:37 INFO - mozInstall == 1.12 04:13:37 INFO - mozcrash == 0.17 04:13:37 INFO - mozdebug == 0.1 04:13:37 INFO - mozdevice == 0.48 04:13:37 INFO - mozfile == 1.2 04:13:37 INFO - mozhttpd == 0.7 04:13:37 INFO - mozinfo == 0.9 04:13:37 INFO - mozleak == 0.1 04:13:37 INFO - mozlog == 3.3 04:13:37 INFO - moznetwork == 0.27 04:13:37 INFO - mozprocess == 0.23 04:13:37 INFO - mozprofile == 0.28 04:13:37 INFO - mozrunner == 6.12 04:13:37 INFO - mozscreenshot == 0.1 04:13:37 INFO - mozsystemmonitor == 0.3 04:13:37 INFO - moztest == 0.7 04:13:37 INFO - mozversion == 1.4 04:13:37 INFO - psutil == 3.1.1 04:13:37 INFO - requests == 1.2.3 04:13:37 INFO - wsgiref == 0.1.2 04:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:37 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 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:37 INFO - Using env: {'DISPLAY': ':0', 04:13:37 INFO - 'HOME': '/home/cltbld', 04:13:37 INFO - 'LANG': 'en_US.UTF-8', 04:13:37 INFO - 'LANGUAGE': 'en_US:en', 04:13:37 INFO - 'LOGNAME': 'cltbld', 04:13:37 INFO - 'MAIL': '/var/mail/cltbld', 04:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:37 INFO - 'MOZ_NO_REMOTE': '1', 04:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:37 INFO - 'NO_EM_RESTART': '1', 04:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:37 INFO - 'PWD': '/builds/slave/test', 04:13:37 INFO - 'SHELL': '/bin/bash', 04:13:37 INFO - 'SHLVL': '1', 04:13:37 INFO - 'TERM': 'linux', 04:13:37 INFO - 'TMOUT': '86400', 04:13:37 INFO - 'USER': 'cltbld', 04:13:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:37 INFO - '_': '/tools/buildbot/bin/python'} 04:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:38 INFO - Cleaning up... 04:13:38 INFO - Return code: 0 04:13:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:38 INFO - Using env: {'DISPLAY': ':0', 04:13:38 INFO - 'HOME': '/home/cltbld', 04:13:38 INFO - 'LANG': 'en_US.UTF-8', 04:13:38 INFO - 'LANGUAGE': 'en_US:en', 04:13:38 INFO - 'LOGNAME': 'cltbld', 04:13:38 INFO - 'MAIL': '/var/mail/cltbld', 04:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:38 INFO - 'MOZ_NO_REMOTE': '1', 04:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:38 INFO - 'NO_EM_RESTART': '1', 04:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:38 INFO - 'PWD': '/builds/slave/test', 04:13:38 INFO - 'SHELL': '/bin/bash', 04:13:38 INFO - 'SHLVL': '1', 04:13:38 INFO - 'TERM': 'linux', 04:13:38 INFO - 'TMOUT': '86400', 04:13:38 INFO - 'USER': 'cltbld', 04:13:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:38 INFO - '_': '/tools/buildbot/bin/python'} 04:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:38 INFO - Cleaning up... 04:13:38 INFO - Return code: 0 04:13:38 INFO - Running post-action listener: _resource_record_post_action 04:13:38 INFO - Running post-action listener: _start_resource_monitoring 04:13:38 INFO - Starting resource monitoring. 04:13:38 INFO - [mozharness: 2016-08-18 11:13:38.303923Z] Finished create-virtualenv step (success) 04:13:38 INFO - [mozharness: 2016-08-18 11:13:38.304358Z] Running install step. 04:13:38 INFO - Running pre-action listener: _resource_record_pre_action 04:13:38 INFO - Running main action method: install 04:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:38 INFO - Reading from file tmpfile_stdout 04:13:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:38 INFO - Reading from file tmpfile_stdout 04:13:38 INFO - Output received: 04:13:38 INFO - Usage: mozinstall [options] installer 04:13:38 INFO - Options: 04:13:38 INFO - -h, --help show this help message and exit 04:13:38 INFO - -d DEST, --destination=DEST 04:13:38 INFO - Directory to install application into. [default: 04:13:38 INFO - "/builds/slave/test"] 04:13:38 INFO - --app=APP Application being installed. [default: firefox] 04:13:38 INFO - mkdir: /builds/slave/test/build/application 04:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:55 INFO - Reading from file tmpfile_stdout 04:13:55 INFO - Output received: 04:13:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:55 INFO - Running post-action listener: _resource_record_post_action 04:13:55 INFO - [mozharness: 2016-08-18 11:13:55.940488Z] Finished install step (success) 04:13:55 INFO - [mozharness: 2016-08-18 11:13:55.940764Z] Running run-tests step. 04:13:55 INFO - Running pre-action listener: _resource_record_pre_action 04:13:55 INFO - Running main action method: run_tests 04:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:55 INFO - Python 2.7.3 04:13:55 INFO - Return code: 0 04:13:55 INFO - grabbing minidump binary from tooltool 04:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:55 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 0xf5d570>, '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 0xf5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:13:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:56 INFO - Return code: 0 04:13:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:56 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/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:13:56 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/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:13:56 INFO - Using env: {'DISPLAY': ':0', 04:13:56 INFO - 'HOME': '/home/cltbld', 04:13:56 INFO - 'LANG': 'en_US.UTF-8', 04:13:56 INFO - 'LANGUAGE': 'en_US:en', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MAIL': '/var/mail/cltbld', 04:13:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SHLVL': '1', 04:13:56 INFO - 'TERM': 'linux', 04:13:56 INFO - 'TMOUT': '86400', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - '_': '/tools/buildbot/bin/python'} 04:13:56 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/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:13:56 INFO - mozversion application_buildid: 20160817221914 04:13:56 INFO - mozversion application_changeset: d23f68f5cb77934e673700bfaaaf607893a2df9b 04:13:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:13:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:56 INFO - mozversion application_name: Firefox 04:13:56 INFO - mozversion application_remotingname: firefox-dev 04:13:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:13:56 INFO - mozversion application_vendor: Mozilla 04:13:56 INFO - mozversion application_version: 50.0a2 04:13:56 INFO - mozversion platform_buildid: 20160817221914 04:13:56 INFO - mozversion platform_changeset: d23f68f5cb77934e673700bfaaaf607893a2df9b 04:13:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:13:56 INFO - mozversion platform_version: 50.0a2 04:13:56 INFO - using testdate: 1471518836 04:13:56 INFO - actual date: 1471518836 04:13:56 INFO - starting webserver on 'localhost:51977' 04:13:56 INFO - SUITE-START | Running 2 tests 04:13:56 INFO - TEST-START | dromaeo_css 04:13:56 INFO - operating with platform_type : linux_ 04:13:56 INFO - Initialising browser for dromaeo_css test... 04:13:56 INFO - TEST-INFO | started process 21388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8UUB2q/profile http://localhost:51977/getInfo.html) 04:14:01 INFO - PROCESS | 21388 | __metrics Screen width/height:1600/1200 04:14:01 INFO - PROCESS | 21388 | colorDepth:24 04:14:01 INFO - PROCESS | 21388 | Browser inner width/height: 1024/697 04:14:01 INFO - PROCESS | 21388 | __metrics 04:14:02 ERROR - PROCESS | 21388 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:14:03 INFO - TEST-INFO | 21388: exit 0 04:14:03 INFO - Browser initialized. 04:14:03 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:03 INFO - TEST-INFO | started process 21515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8UUB2q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:15 INFO - PROCESS | 21515 | RSS: Main: 152424448 04:14:15 INFO - PROCESS | 21515 | 04:15:04 INFO - PROCESS | 21515 | 1471518904964 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:17:13 INFO - PROCESS | 21515 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51977/tests/dromaeo/cssquery-ext.html) 04:17:14 INFO - PROCESS | 21515 | RSS: Main: 158154752 04:17:14 INFO - PROCESS | 21515 | 04:20:16 INFO - PROCESS | 21515 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-ext.html (next: http://localhost:51977/tests/dromaeo/cssquery-jquery.html) 04:20:17 INFO - PROCESS | 21515 | RSS: Main: 153182208 04:20:17 INFO - PROCESS | 21515 | 04:23:19 INFO - PROCESS | 21515 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51977/tests/dromaeo/cssquery-mootools.html) 04:23:19 INFO - PROCESS | 21515 | RSS: Main: 154361856 04:23:19 INFO - PROCESS | 21515 | 04:26:21 INFO - PROCESS | 21515 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51977/tests/dromaeo/cssquery-prototype.html) 04:26:22 INFO - PROCESS | 21515 | RSS: Main: 152027136 04:26:22 INFO - PROCESS | 21515 | 04:29:24 INFO - PROCESS | 21515 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51977/tests/dromaeo/cssquery-yui.html) 04:29:25 INFO - PROCESS | 21515 | RSS: Main: 154869760 04:29:25 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-yui.html (next: http://localhost:51977/tests/dromaeo/cssquery-dojo.html) 04:32:27 INFO - PROCESS | 21515 | RSS: Main: 156094464 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | __start_tp_report 04:32:27 INFO - PROCESS | 21515 | _x_x_mozilla_page_load 04:32:27 INFO - PROCESS | 21515 | _x_x_mozilla_page_load_details 04:32:27 INFO - PROCESS | 21515 | |i|pagename|runs| 04:32:27 INFO - PROCESS | 21515 | |0;dojo.html;3317.75116866235;3319.236575587613;3325.418051840927;3334.2831291272373;3354.8825791097315;5799.565032622554;5846.853828654286;5855.502282305998;5859.296884373875;5871.559633027518;5832.9708351458185;5903.409659034105;5905.143754155655;5905.586608937376;5917.289925208981;5217.71302578359;5339.359276886779;5340.599455040868;5363.892722145555;5390.4879036491475;5201.063808514466;5213.348331458567;5255.658382205163;5262.079136151158;5302.575793936476;5245.4754524547625;5247.239150323201;5276.023935571912;5342.439043900393;5391.218273350361;5303.920441193385;5322.2282768998475;5328.387235467893;5338.252644629755;5346.946530534684;5060.063888180662;5161.406438259611;5218.556422704075;5249.212618107276;5283.86790330241;5814.796482123148;5821.330546987108;5835.5915085944;5837.416258374171;5858.062709966385;6249.843753906143;6284.780032698834;6303.401176888188;6312.368763123651;6320.71556779946;6041.78853740117;6134.834601026134;6309.3491183127135;6349.873002539969;6352.650604216767;5840.415958404168;5892.587518873681;5906.70466476683;5912.556558258105;5921.052631578927;6367.235931688227;6380.776672816429;6388.425041746265;6401.199850018747;6405.3594640535575;5866.090755932837;6036.185115009505;6109.633421994695;6174.567780255339;6175.475084617858;6120.690942950841;6251.28110267316;6289;6290.370962903765;6309.810705678837;6199.194104766351;6219.315875253718;6242.406971337716;6243.937560624336;6245.125682404467;5934.495567876693;6086.02623580225;6195.349488303754;6203.069539569011;6216.875662486725;4673.065386922561;4700.412448443944;4703.082898834763;4739.715617062987;4744.027474367746;4174.269502837052;4183.6653067754505;4191.497020357577;4201.978990105091;4202.957970420318;5829.125631155276;5835.912461313083;5846.152307915413;5911.113332999998;5916.940830591639;6229.470495007885;6325.272593651697;6355.951268040814;6358.395952384609;6376.107344971708;5976.581639285295;5981.880362392815;5991.64050156992;6011.6693581853415;6086.756529738849;4963.925541116886;5139.974300128551;5231.0584094862525;5237.580993520509;5257.474252574789;6411.807645770635;6505.4795616350575;6516.804495865132;6518.739250430024;6528.869422611521;6181.629102253879;6236.812895613139;6257.906131407942;6259.937400625936;6264.780732674334;6236.75052997875;6346.079818426395;6456.580322279036;6495;6507.934920650733;6069.666168360783;6140.938590614037;6147.477464415575;6162.753489860355;6178.66017369031;6250.749970001149;6255.749770009149;6262;6271.655058971618;6272.121902933684;5960.225170727777;6112.816615501542;6143.631382117087;6151.3541078186145;6159.938400616115;6052.939470605414;6154.630722156685;6165.599236049642;6169.352218017044;6178.289496707936;6011.789587364421;6042.214512113397;6075.2193691118;6097.664628445478;6140.293866205265;5932.584719069624;5937.762489500372;6188.916964450387;6211.627302361872;6248.718807653758;5834.824955251349;5896.498797602252;5923;5928.49607783326;5942.10868369748 04:32:27 INFO - PROCESS | 21515 | |1;ext.html;595.1637948682101;631.4853394483496;667.3893387550395;669.6986356139736;706.1420374245291;45274;46244.53755462445;46303.536964630344;46359.30461043087;46384.304235436495;47680.523194768044;47918;48249.517504824944;48393.51606483934;48636.75681621596;9020.503872287021;9122.08779122089;9167.862482062741;9168.40405373652;9193.08069193082;9085.318601104911;9126.726198214064;9166.954165229197;9195.494247816367;9201.815963680723;9102.499362535058;9139.131782480687;9169.770755731093;9189.862152067692;9230.630774769035;9082.77293067672;9185.265178785681;9192.080791920787;9210.631574737003;9246.491442970633;9085.182333590008;9117.954410227907;9156.084391560857;9178.586963586587;9205.217556507705;44710.77644611789;44734.552654473366;44789.55210447886;44905.77547112276;44945.550544494465;3259.2992506610954;3893.06566424059;3897.142628621699;3995.700322475826;4039.252738243405;36300.273994519965;36830.263394731955;37159.628403715884;39700.20599588021;40174.79912600418;4749.121412538691;4893.510648935114;4947.678400903966;4964.67729597575;4978.228374601942;416561;419287;424169;424281;424343.87828060973;70950.64524677343;71821;72096.27903721;72102.63948680223;72116.63941680259;39791.80104099461;42117.1576568473;42207.36688949668;76051.23948760552;76585.23414765781;19710.901445492967;19716.40850774479;19736.70394944077;19774.209031638573;19838.50403739918;15139.167345796088;15281.083135011935;15305.617359565877;15314.234288285541;15337.0797752133;22641.54716905653;22818.885905570365;22837.657435138488;23071.307860764206;23172.420689482897;8276.379271554657;8397.270886961762;8460.915390846136;8534.53060081689;8556.914430855737;1083.6044843632176;1106.3859557945418;1115.185914282562;1135.2167004766684;1182.9467673954694;35463.82268088643;35543.82228088895;36133.45799813005;36345;38259.42610860839;1128.3906690387264;1147.7761836441814;1152.2970987697497;1261.5269274022241;1262.7600755856542;17628.471145865387;17773.644527109645;17795;17906.462806115836;17914.55213619644;644547;651742;656229;658434;660162;64164;64690;64850;64904;64944.72693455706;1446.1612264886342;1488.2038109611306;1497.7378958682186;1502.9849701503065;1504.2102895979478;33467.832660837514;34815.65184348124;34961;35151.82424087863;35422;57116;57801.421985779605;57882;57905.42094579169;57912.710436447545;558292;561235;561995;563086;563115;31765.523517146798;31927;32062.35875282528;32166.67833321637;32465;53164.73417632887;53190;54441;54698.17952730792;54987;46081;47334.76332618315;47999.280010799164;48022.75988620034;48176.5182348172;47201;48688.75655621699;48696.513034870615;48754.512454876414;49004.2649360267;39881.40177897276;45733;45977.77011114923;46846;47553;39222.803885980386;40532.7041132599;40723.796381017906;40816;41858.37212441755;31061.223469413446;31628;31750.21944071148;31836.84081579577;31936.68063319337 04:32:27 INFO - PROCESS | 21515 | |2;jquery.html;409.98770036898867;412.1530255325307;424.51817187492196;425.478788484107;437.2021061562649;19192.520186995316;20145.496362590944;20535.28126515572;20604.793952060474;21184.57630847384;19590.510237244074;20231.696524552142;20456.181752729874;20806.47983800406;20899.791002089976;5975.492083172925;6133.693315334238;6193.659348735818;6196.008638617799;6196.194494715681;5986.161937328778;6035.3059398169335;6037.698115094249;6082.482988945945;6109.450149486545;5916.497097746696;5998.6400815950965;6007.669578173199;6029.788957386492;6031.065184896326;5940.04959206527;5946.464818166364;5999.910001349983;6008;6014.458698717114;5303.787848486056;5335.306410166692;5343.278657381243;5348.786048558053;5357.624966252364;23758.881205594033;24753.133640322503;24797.62803557948;24866.751332486623;24921.875390622932;2587.1721049264243;2591.06721580231;2700.540908045637;2823.830570165776;3119.9688003119904;15250.542483725507;15663.295151718201;15811.209439527978;15828.52514424569;16304.184790760415;2012.3560460652598;2111.123883588309;2113.3976816607346;2136.8504204705678;2152.160657343637;67002;70616.293837062;75921.62039189824;77196.61401693012;87637;11273.379964102052;11373;11609.187356885106;11623.186376953532;11628.127890408254;16384.26270817816;16433.342666293214;16466.75299870503;16477;16516.50450486487;8569.657213711382;8620.698275560326;8830.514321712368;8970.058143894928;9187.127222913812;8605.913940860637;8616.827663446697;8741.825163496695;8862.379633425599;8971.775705607282;5007.173816320339;5008.323876276656;5052.115879721034;5061.936993231389;5142.151544995108;2022.7572691277142;2027.1891243502716;2030.4822270320974;2086.5201003769216;2139.229877244191;961.3078583419926;1025.0825511167463;1032.5972870580479;1038.4755698372426;1124.5756670937017;20423.387298381072;20805.687914681293;20820.479488012617;21013.739175649203;21265.89367053155;1050.3382868792612;1079.9352038877691;1093.4040947683532;1096.276457538037;1118.7147277444362;11240.662780116609;11275.548978040786;11364.090872730161;11513.53945842157;11656.53373865036;522194;544893;546921;562359;565541;95330;95409.52295238618;95753.52123239479;95859;103948;1034.9275550711377;1040.953157107932;1053.7365658585354;1054.9208809339177;1062.888396718349;17856.46430607084;18623.81376186275;18848.717269241246;19075.523111921757;19092.522686932938;44938.55061449343;45785.313220301054;45931.31103033524;47433.28850067321;48450.38243766707;61323.69338153281;62073.68963155336;64446;65639;67238;13551.186928784304;13599.388027538587;13667.521636742666;13821.101628394123;13856.376463059389;14730.189839558927;15158.469453569072;15306.923465382602;15368.462103826312;15565.676917462142;12190.451429685863;12393.380330983595;13055.543055992996;13084.738305234032;13334.39995200199;12373.195742276723;12640.494380225056;12749.17130386522;13215.801762973371;13647.86352136466;12452.81320780171;12638.747225055264;13247.735045299232;13308.201507909556;13571.321433928066;13549.796753048515;13618.727625447635;13628.386722597308;13636.454541818217;13687.178769273876;12914.418851151908;13048.151870128411;13057.151285166434;13216.66958326011;13243.20540767557 04:32:27 INFO - PROCESS | 21515 | |3;mootools.html;1543.2669481996054;1583.849534294242;1757.58696706274;1868.327402135231;1913.5790126172237;8735.73792786216;9375.343725939187;9538;10135.44255065971;10164.847527287087;9596.376235544685;9866.950665246664;9873.901260987388;9927.900720992788;9947.452890091043;2483.6522886795865;2508.761667641571;2531.911383101592;2535.6703628528267;2544.8727563621746;2526.090607381341;2591.391023109568;2599.54507961107;2599.753023462768;2601.8048646351504;2541.733118022609;2552.2343297010916;2572.6655534780452;2576.4589436218416;2582.935426614331;2514.899404023846;2521.344450442889;2521.4957008598353;2539.873006349675;2542.898284068635;2494.451220731436;2499.3751562109474;2502.249325202432;2504.0734928076545;2533.505966336565;9806.509674516246;9883.505824708736;9973.850392244121;9982.251331150193;9999.450030248334;5861.20873682056;5988.071848863433;5988.880222395528;6036.305824830113;6048.7882924097885;3706.944395834065;3756.6619004289746;3807.1053302473897;3854.939891529824;3945.802709864524;1230.7353918907388;1291.6706239908858;1293.333933024493;1297.1762930539176;1330.2816479101273;13774.380152893043;13856.93071534646;13868.86131138696;13910.095843770123;13912.652183695489;5053.5957123430035;5068.493150684902;5077.593792496666;5093;5324.254604355393;11563.537458501734;11645.6506304811;11742.119341049456;11744.354060526754;11766;5861.120831875252;5901.468867801918;5903.291605007426;5905.970470147708;5916.437938395846;4840.564349208588;5192.3769147702515;5280.313559237351;5315.123004704258;5452.182172674131;4362.454693163355;4402.405675233803;4453.35426363182;4502.684812063189;4541.8183272669385;1366.5558693424678;1411.400154934149;1418.44680574576;1422.9217393043482;1425.0238586568234;1042.4735508568124;1069.2622090757352;1071.4000159910474;1072.9356238625708;1090.3948308688755;6563.409293163638;6584.8024559263295;6655.134832471747;6722.9663851680425;6769.559978601375;477.7229207059897;478.4808482796205;488.4017079078172;489.3858207949001;499.455593403185;4582.9770851146195;4610;4652.97673511637;4692.0850434165695;4751.382320298339;12078;12288.447019884126;12399.938000310121;12431.191972521758;12437.93781031089;11550.480228389742;12134.453949572115;12157.878421215852;12284.877151228553;12299.077569182347;9102.59038343263;9196;9286.164245217962;9292.53537323131;9311.068893110634;6426.4216220540375;6444.806655800334;6596.901046484402;6696.263411024686;6744.123263975848;10997.725056873322;11059.778804424028;11083.72290692739;11226.775464490502;11284.887151128383;11248.718782030188;11345.48945297447;11362.772744545227;11397.202195846212;11492.620885493794;7804.9609751950875;8366.079731229438;8368.581570921308;8427.199416055464;8622.310215182895;9699.612015519582;9756.951215243878;9806.75483112928;9811.018898110417;9824.901750982399;8104;8131.512109273463;8178.754637360888;8229.506229626242;8301.086880443027;8451.704190353308;8476.660933562589;8520.957395212985;8534.658613655385;8624.353173512138;7800.375969922279;7896.526208427513;7963.044434667645;8036.959815200887;8038.276555110068;5517.503424691797;5708.5147762439;5727.36998930109;5748.080307150836;5857.677827719346;5821.359650438533;5823.097419899922;5906.940930590639;5949.434803693643;5991.940080599138 04:32:27 INFO - PROCESS | 21515 | |4;prototype.html;336.4767786092626;345.1044539420204;345.2421933855187;353.8872928616164;359.7841295222865;5863.149843272723;5904.3800400957925;5911.46796788289;5918.7632494700265;5957.731902064406;5775.393583673716;5786.363500014995;5790.855228619286;5791.942080579193;5797.594168408203;4095.610916962884;4415.712978656377;4458.2866741321395;4487.19230538503;4513.736153876904;4476.239039363316;4480.602877460559;4485.215087359716;4508.66185036122;4510.210713125206;4465.598096171344;4465.620422264112;4473.239549276631;4486.528914463967;4492.303692927601;4276.465441819772;4354.3468479728135;4416.205083085043;4437.778111094464;4460.130274596455;3889.4749208856724;3891.9805400973096;3896.337622604164;3897.649211570972;3905.3987864975225;5620.325560932673;5648.43515648436;5650.0959846424375;5672.4894759471845;5674.914876276859;5008.874778130539;5152.046871328778;5157.948420515784;5161.4322424533275;5182.533571978503;6062.514683902428;6064.241969753781;6091.634501929899;6091.695415229266;6104.206453161105;4219.282721937278;4356.194104090721;4391.209582275189;4392.71447355924;4416.889577760549;6164.167837341991;6219.067139929001;6233.096201050867;6253.96873015632;6253.968730156365;4445.866624001285;4451.376807246988;4462.955370446319;4471.7987690554;4473.507914129443;4392.1874453226255;4468.322412316484;4476.865694029184;4508.143452743968;4535.365048893158;5112.923306150411;5133;5167.560757335594;5171.4052883918075;5181.248718935733;6156.846078847975;6157.630542167484;6167.167432396659;6174.938250617526;6183.381661833871;1543.104999100519;1543.3749331520753;1554.6113471632093;1560.5786437661768;1564.0146707574156;1019.1490105761771;1021.3208216536069;1028.290479569095;1059.433203236265;1094.3051162511863;5886.117082437669;5900.1149827526215;5900.76396944126;5904.911426328608;5908.852278692981;6206.252217053957;6212.565120441525;6266.185395898504;6285;6337.176167098248;5681.772729090872;5792.177163072352;5901.232839730807;5905.498032667186;5911.438413350725;3313.784604000732;3363.209645733251;3373.40965331071;3375.7974521528786;3379.7803142795638;6364.204474440695;6451.903221451588;6472.385123413268;6540.345965403421;6564.277929427759;6319.178506794087;6333.46165575922;6354.332795056453;6363.840903977438;6381.744730210832;6316.873662526724;6418.807435776934;6422.3577642235405;6537.280899101095;6546.574472659262;6118.449339559461;6143.508519318533;6220.191375121205;6231.189945307081;6267.4045965633195;5870.5010074142465;6151.415615516519;6179.567430280017;6189.442950134509;6196.442320191204;6344.953082741296;6391.424771770563;6418.775342862978;6440.262888272559;6470.417662410406;4486.618637415726;4512.706674066175;4515.819367225406;4533.478649955166;4566.429196350457;5961.076033214858;6137.754489820357;6166.537509686702;6213.347598502092;6245.970059730696;6024.367441418588;6031.155638210566;6084.269887613515;6112.17485639433;6125.785597504066;5798.94201057984;6011.6693581853415;6056.273247210363;6082.239720034996;6092.872818528586;5743.59794814359;5874.94125058744;5906.379830117948;5951.702414879325;6028.517718582415;6156.661383623944;6167.938320616737;6174.598651087665;6186;6201.6899155041165;5823.708814559171;5953.791617293374;5989;5995.2206213192;6000.039993601003 04:32:27 INFO - PROCESS | 21515 | |5;yui.html;812.8293058457724;830.5764060329234;851.5146366571055;869.8695195720637;917.8531434970406;16937.407190748327;18083.095845207736;18232.81767182328;18234.726479102806;18344.81655183448;15878.920605396957;15911.44309949152;15968.121753303563;16016.35934562616;16029.198540072979;888.7511496780912;902.1474706402453;914.2548822709504;919.7010971434311;920.1120918313826;908.0420156734642;915.7664795477177;918.2241006349624;919.8298314811781;920.2132176988679;948.393028461785;948.800751842114;950.1875896108832;951.7906060666643;953.2707478778705;948.9762755931088;950.5199874063588;951.7715748220412;952.4618590496417;953.8998405167462;695.6521739130435;698.3121625199175;699.3740602161088;700.1073631120312;700.831800367908;16435.26041328143;16555.834441655672;16602.08688522131;16650.33398664052;16705.498835034967;15647;15809.288582013836;16234.51296461108;16375.508734737978;16375.754363684555;13933.233672148028;13964.441422343094;14017.71964560703;14129.293535323193;14315.713685726332;4110.445089912883;4221.535631080578;4228.238916994939;4321.416608757841;4354.107407981356;66415;72504.63747681228;83766.58116709438;85078;85308;12011.099167562468;12113.273203607636;12150.878491215151;12244.938775306244;12479.438425270884;23584.41038974005;23617.527649446914;23626.763732362455;23639.7636023641;23757.524849502912;8272.586370681442;8497.702580409656;8506.064332923374;8627.525486098324;8984.55077246135;4526.434195725535;4529.5243999380245;4536.183486972377;4580.633549316047;4611.1930412177735;4004.2992476316526;4083.4079058536345;4122.216778812016;4127.277726397869;4279.379489973936;696.989545156823;698.5773606967813;709.021550260637;709.7728726807372;743.4201322968094;786.103841620553;799.580220384303;836.8159005018886;840.1010918317464;850.5577099908013;10273.743156421;10913.618023369303;11212;11255.493502792395;11376.772464550662;844.5059640110481;847.9319277078602;851.9105493923173;854.2183901729971;872.9825403492022;5007.4241462231585;5414.972925135349;5476.17857321397;5488.615796894259;5553.416891226444;102594.48702756439;116720;118924.40537797255;120138;121550.39224803996;105845;109606.32755707024;109653;111305;112548;57020.714896425256;82823;92749.53625231965;95883.0411695888;98327.50836245916;10484.370937743759;10874.238803283693;10974.286671366335;11003.22977391575;11028.44857757125;54580.454195459126;55827.441725582226;55969.720151398986;56280.71859640839;56628.15057774219;72507.27492725005;76921.61539192268;77602.61198693971;78241.60879195567;78514.6074269625;14603.634909127357;14617.122972621677;14692.779608306098;14817.110973341634;14824.703505930036;15605.45380911708;16078.59803504875;16262.67474650524;16422.343106275614;16467.752983705013;14792.186429746036;14899.553013409615;15602.453914113406;15784.13187274711;15840.76238856395;12953.41709623088;13704.177749335071;13746.587602371945;13894.652633684238;14892.180930048951;15110.54668359951;15550;15552.066875987477;15559.910806243453;15660.13869237203;12424.875751242373;12574.559890404158;12857.549985750455;12975.416106275428;13415;12862.292573908524;12928.741425171633;13138.737225255632;13297.534586289434;13341.132826366254 04:32:27 INFO - PROCESS | 21515 | __end_tp_report 04:32:27 INFO - PROCESS | 21515 | __start_cc_report 04:32:27 INFO - PROCESS | 21515 | _x_x_mozilla_cycle_collect,311 04:32:27 INFO - PROCESS | 21515 | __end_cc_report 04:32:27 INFO - PROCESS | 21515 | __startTimestamp1471519947595__endTimestamp 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | ------- Summary: start ------- 04:32:27 INFO - PROCESS | 21515 | Number of tests: 6 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | [#0] dojo.html Cycles:165 Average:5786.53 Median:5991.64 stddev:681.45 (11.4%) stddev-sans-first:655.44 04:32:27 INFO - PROCESS | 21515 | Values: 3317.8 3319.2 3325.4 3334.3 3354.9 5799.6 5846.9 5855.5 5859.3 5871.6 5833.0 5903.4 5905.1 5905.6 5917.3 5217.7 5339.4 5340.6 5363.9 5390.5 5201.1 5213.3 5255.7 5262.1 5302.6 5245.5 5247.2 5276.0 5342.4 5391.2 5303.9 5322.2 5328.4 5338.3 5346.9 5060.1 5161.4 5218.6 5249.2 5283.9 5814.8 5821.3 5835.6 5837.4 5858.1 6249.8 6284.8 6303.4 6312.4 6320.7 6041.8 6134.8 6309.3 6349.9 6352.7 5840.4 5892.6 5906.7 5912.6 5921.1 6367.2 6380.8 6388.4 6401.2 6405.4 5866.1 6036.2 6109.6 6174.6 6175.5 6120.7 6251.3 6289.0 6290.4 6309.8 6199.2 6219.3 6242.4 6243.9 6245.1 5934.5 6086.0 6195.3 6203.1 6216.9 4673.1 4700.4 4703.1 4739.7 4744.0 4174.3 4183.7 4191.5 4202.0 4203.0 5829.1 5835.9 5846.2 5911.1 5916.9 6229.5 6325.3 6356.0 6358.4 6376.1 5976.6 5981.9 5991.6 6011.7 6086.8 4963.9 5140.0 5231.1 5237.6 5257.5 6411.8 6505.5 6516.8 6518.7 6528.9 6181.6 6236.8 6257.9 6259.9 6264.8 6236.8 6346.1 6456.6 6495.0 6507.9 6069.7 6140.9 6147.5 6162.8 6178.7 6250.7 6255.7 6262.0 6271.7 6272.1 5960.2 6112.8 6143.6 6151.4 6159.9 6052.9 6154.6 6165.6 6169.4 6178.3 6011.8 6042.2 6075.2 6097.7 6140.3 5932.6 5937.8 6188.9 6211.6 6248.7 5834.8 5896.5 5923.0 5928.5 5942.1 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | [#1] ext.html Cycles:180 Average:71615.09 Median:46371.80 stddev:147449.95 (318.0%) stddev-sans-first:147767.17 04:32:27 INFO - PROCESS | 21515 | Values: 595.2 631.5 667.4 669.7 706.1 45274.0 46244.5 46303.5 46359.3 46384.3 47680.5 47918.0 48249.5 48393.5 48636.8 9020.5 9122.1 9167.9 9168.4 9193.1 9085.3 9126.7 9167.0 9195.5 9201.8 9102.5 9139.1 9169.8 9189.9 9230.6 9082.8 9185.3 9192.1 9210.6 9246.5 9085.2 9118.0 9156.1 9178.6 9205.2 44710.8 44734.6 44789.6 44905.8 44945.6 3259.3 3893.1 3897.1 3995.7 4039.3 36300.3 36830.3 37159.6 39700.2 40174.8 4749.1 4893.5 4947.7 4964.7 4978.2 416561.0 419287.0 424169.0 424281.0 424343.9 70950.6 71821.0 72096.3 72102.6 72116.6 39791.8 42117.2 42207.4 76051.2 76585.2 19710.9 19716.4 19736.7 19774.2 19838.5 15139.2 15281.1 15305.6 15314.2 15337.1 22641.5 22818.9 22837.7 23071.3 23172.4 8276.4 8397.3 8460.9 8534.5 8556.9 1083.6 1106.4 1115.2 1135.2 1182.9 35463.8 35543.8 36133.5 36345.0 38259.4 1128.4 1147.8 1152.3 1261.5 1262.8 17628.5 17773.6 17795.0 17906.5 17914.6 644547.0 651742.0 656229.0 658434.0 660162.0 64164.0 64690.0 64850.0 64904.0 64944.7 1446.2 1488.2 1497.7 1503.0 1504.2 33467.8 34815.7 34961.0 35151.8 35422.0 57116.0 57801.4 57882.0 57905.4 57912.7 558292.0 561235.0 561995.0 563086.0 563115.0 31765.5 31927.0 32062.4 32166.7 32465.0 53164.7 53190.0 54441.0 54698.2 54987.0 46081.0 47334.8 47999.3 48022.8 48176.5 47201.0 48688.8 48696.5 48754.5 49004.3 39881.4 45733.0 45977.8 46846.0 47553.0 39222.8 40532.7 40723.8 40816.0 41858.4 31061.2 31628.0 31750.2 31836.8 31936.7 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | [#2] jquery.html Cycles:180 Average:31920.24 Median:11493.16 stddev:90075.67 (783.7%) stddev-sans-first:90297.28 04:32:27 INFO - PROCESS | 21515 | Values: 410.0 412.2 424.5 425.5 437.2 19192.5 20145.5 20535.3 20604.8 21184.6 19590.5 20231.7 20456.2 20806.5 20899.8 5975.5 6133.7 6193.7 6196.0 6196.2 5986.2 6035.3 6037.7 6082.5 6109.5 5916.5 5998.6 6007.7 6029.8 6031.1 5940.0 5946.5 5999.9 6008.0 6014.5 5303.8 5335.3 5343.3 5348.8 5357.6 23758.9 24753.1 24797.6 24866.8 24921.9 2587.2 2591.1 2700.5 2823.8 3120.0 15250.5 15663.3 15811.2 15828.5 16304.2 2012.4 2111.1 2113.4 2136.9 2152.2 67002.0 70616.3 75921.6 77196.6 87637.0 11273.4 11373.0 11609.2 11623.2 11628.1 16384.3 16433.3 16466.8 16477.0 16516.5 8569.7 8620.7 8830.5 8970.1 9187.1 8605.9 8616.8 8741.8 8862.4 8971.8 5007.2 5008.3 5052.1 5061.9 5142.2 2022.8 2027.2 2030.5 2086.5 2139.2 961.3 1025.1 1032.6 1038.5 1124.6 20423.4 20805.7 20820.5 21013.7 21265.9 1050.3 1079.9 1093.4 1096.3 1118.7 11240.7 11275.5 11364.1 11513.5 11656.5 522194.0 544893.0 546921.0 562359.0 565541.0 95330.0 95409.5 95753.5 95859.0 103948.0 1034.9 1041.0 1053.7 1054.9 1062.9 17856.5 18623.8 18848.7 19075.5 19092.5 44938.6 45785.3 45931.3 47433.3 48450.4 61323.7 62073.7 64446.0 65639.0 67238.0 13551.2 13599.4 13667.5 13821.1 13856.4 14730.2 15158.5 15306.9 15368.5 15565.7 12190.5 12393.4 13055.5 13084.7 13334.4 12373.2 12640.5 12749.2 13215.8 13647.9 12452.8 12638.7 13247.7 13308.2 13571.3 13549.8 13618.7 13628.4 13636.5 13687.2 12914.4 13048.2 13057.2 13216.7 13243.2 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | [#3] mootools.html Cycles:180 Average:6458.70 Median:4721.73 stddev:3718.37 (78.8%) stddev-sans-first:3710.45 04:32:27 INFO - PROCESS | 21515 | Values: 1543.3 1583.8 1757.6 1868.3 1913.6 8735.7 9375.3 9538.0 10135.4 10164.8 9596.4 9867.0 9873.9 9927.9 9947.5 2483.7 2508.8 2531.9 2535.7 2544.9 2526.1 2591.4 2599.5 2599.8 2601.8 2541.7 2552.2 2572.7 2576.5 2582.9 2514.9 2521.3 2521.5 2539.9 2542.9 2494.5 2499.4 2502.2 2504.1 2533.5 9806.5 9883.5 9973.9 9982.3 9999.5 5861.2 5988.1 5988.9 6036.3 6048.8 3706.9 3756.7 3807.1 3854.9 3945.8 1230.7 1291.7 1293.3 1297.2 1330.3 13774.4 13856.9 13868.9 13910.1 13912.7 5053.6 5068.5 5077.6 5093.0 5324.3 11563.5 11645.7 11742.1 11744.4 11766.0 5861.1 5901.5 5903.3 5906.0 5916.4 4840.6 5192.4 5280.3 5315.1 5452.2 4362.5 4402.4 4453.4 4502.7 4541.8 1366.6 1411.4 1418.4 1422.9 1425.0 1042.5 1069.3 1071.4 1072.9 1090.4 6563.4 6584.8 6655.1 6723.0 6769.6 477.7 478.5 488.4 489.4 499.5 4583.0 4610.0 4653.0 4692.1 4751.4 12078.0 12288.4 12399.9 12431.2 12437.9 11550.5 12134.5 12157.9 12284.9 12299.1 9102.6 9196.0 9286.2 9292.5 9311.1 6426.4 6444.8 6596.9 6696.3 6744.1 10997.7 11059.8 11083.7 11226.8 11284.9 11248.7 11345.5 11362.8 11397.2 11492.6 7805.0 8366.1 8368.6 8427.2 8622.3 9699.6 9757.0 9806.8 9811.0 9824.9 8104.0 8131.5 8178.8 8229.5 8301.1 8451.7 8476.7 8521.0 8534.7 8624.4 7800.4 7896.5 7963.0 8037.0 8038.3 5517.5 5708.5 5727.4 5748.1 5857.7 5821.4 5823.1 5906.9 5949.4 5991.9 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | [#4] prototype.html Cycles:180 Average:5115.25 Median:5866.83 stddev:1510.06 (25.7%) stddev-sans-first:1471.08 04:32:27 INFO - PROCESS | 21515 | Values: 336.5 345.1 345.2 353.9 359.8 5863.1 5904.4 5911.5 5918.8 5957.7 5775.4 5786.4 5790.9 5791.9 5797.6 4095.6 4415.7 4458.3 4487.2 4513.7 4476.2 4480.6 4485.2 4508.7 4510.2 4465.6 4465.6 4473.2 4486.5 4492.3 4276.5 4354.3 4416.2 4437.8 4460.1 3889.5 3892.0 3896.3 3897.6 3905.4 5620.3 5648.4 5650.1 5672.5 5674.9 5008.9 5152.0 5157.9 5161.4 5182.5 6062.5 6064.2 6091.6 6091.7 6104.2 4219.3 4356.2 4391.2 4392.7 4416.9 6164.2 6219.1 6233.1 6254.0 6254.0 4445.9 4451.4 4463.0 4471.8 4473.5 4392.2 4468.3 4476.9 4508.1 4535.4 5112.9 5133.0 5167.6 5171.4 5181.2 6156.8 6157.6 6167.2 6174.9 6183.4 1543.1 1543.4 1554.6 1560.6 1564.0 1019.1 1021.3 1028.3 1059.4 1094.3 5886.1 5900.1 5900.8 5904.9 5908.9 6206.3 6212.6 6266.2 6285.0 6337.2 5681.8 5792.2 5901.2 5905.5 5911.4 3313.8 3363.2 3373.4 3375.8 3379.8 6364.2 6451.9 6472.4 6540.3 6564.3 6319.2 6333.5 6354.3 6363.8 6381.7 6316.9 6418.8 6422.4 6537.3 6546.6 6118.4 6143.5 6220.2 6231.2 6267.4 5870.5 6151.4 6179.6 6189.4 6196.4 6345.0 6391.4 6418.8 6440.3 6470.4 4486.6 4512.7 4515.8 4533.5 4566.4 5961.1 6137.8 6166.5 6213.3 6246.0 6024.4 6031.2 6084.3 6112.2 6125.8 5798.9 6011.7 6056.3 6082.2 6092.9 5743.6 5874.9 5906.4 5951.7 6028.5 6156.7 6167.9 6174.6 6186.0 6201.7 5823.7 5953.8 5989.0 5995.2 6000.0 04:32:27 INFO - PROCESS | 21515 | 04:32:27 INFO - PROCESS | 21515 | [#5] yui.html Cycles:180 Average:22135.65 Median:4043.85 stddev:31087.52 (768.8%) stddev-sans-first:31133.50 04:32:27 INFO - PROCESS | 21515 | Values: 812.8 830.6 851.5 869.9 917.9 16937.4 18083.1 18232.8 18234.7 18344.8 15878.9 15911.4 15968.1 16016.4 16029.2 888.8 902.1 914.3 919.7 920.1 908.0 915.8 918.2 919.8 920.2 948.4 948.8 950.2 951.8 953.3 949.0 950.5 951.8 952.5 953.9 695.7 698.3 699.4 700.1 700.8 16435.3 16555.8 16602.1 16650.3 16705.5 15647.0 15809.3 16234.5 16375.5 16375.8 13933.2 13964.4 14017.7 14129.3 14315.7 4110.4 4221.5 4228.2 4321.4 4354.1 66415.0 72504.6 83766.6 85078.0 85308.0 12011.1 12113.3 12150.9 12244.9 12479.4 23584.4 23617.5 23626.8 23639.8 23757.5 8272.6 8497.7 8506.1 8627.5 8984.6 4526.4 4529.5 4536.2 4580.6 4611.2 4004.3 4083.4 4122.2 4127.3 4279.4 697.0 698.6 709.0 709.8 743.4 786.1 799.6 836.8 840.1 850.6 10273.7 10913.6 11212.0 11255.5 11376.8 844.5 847.9 851.9 854.2 873.0 5007.4 5415.0 5476.2 5488.6 5553.4 102594.5 116720.0 118924.4 120138.0 121550.4 105845.0 109606.3 109653.0 111305.0 112548.0 57020.7 82823.0 92749.5 95883.0 98327.5 10484.4 10874.2 10974.3 11003.2 11028.4 54580.5 55827.4 55969.7 56280.7 56628.2 72507.3 76921.6 77602.6 78241.6 78514.6 14603.6 14617.1 14692.8 14817.1 14824.7 15605.5 16078.6 16262.7 16422.3 16467.8 14792.2 14899.6 15602.5 15784.1 15840.8 12953.4 13704.2 13746.6 13894.7 14892.2 15110.5 15550.0 15552.1 15559.9 15660.1 12424.9 12574.6 12857.5 12975.4 13415.0 12862.3 12928.7 13138.7 13297.5 13341.1 04:32:27 INFO - PROCESS | 21515 | -------- Summary: end -------- 04:32:27 INFO - PROCESS | 21515 | 04:32:28 INFO - TEST-INFO | 21515: exit 0 04:32:28 INFO - TEST-OK | dromaeo_css | took 1112164ms 04:32:28 INFO - TEST-START | kraken 04:32:28 INFO - operating with platform_type : linux_ 04:32:28 INFO - Initialising browser for kraken test... 04:32:28 INFO - TEST-INFO | started process 21783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4DA_lN/profile http://localhost:51977/getInfo.html) 04:32:33 INFO - PROCESS | 21783 | __metrics Screen width/height:1600/1200 04:32:33 INFO - PROCESS | 21783 | colorDepth:24 04:32:33 INFO - PROCESS | 21783 | Browser inner width/height: 1024/697 04:32:33 INFO - PROCESS | 21783 | __metrics 04:32:34 ERROR - PROCESS | 21783 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:32:35 INFO - TEST-INFO | 21783: exit 0 04:32:35 INFO - Browser initialized. 04:32:35 INFO - Running cycle 1/1 for kraken test... 04:32:35 INFO - TEST-INFO | started process 21912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4DA_lN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:47 INFO - PROCESS | 21912 | RSS: Main: 152670208 04:32:47 INFO - PROCESS | 21912 | 04:32:49 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:50 INFO - PROCESS | 21912 | RSS: Main: 157679616 04:32:50 INFO - PROCESS | 21912 | 04:32:53 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-dft) 04:32:53 INFO - PROCESS | 21912 | RSS: Main: 156254208 04:32:53 INFO - PROCESS | 21912 | 04:32:56 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-fft) 04:32:57 INFO - PROCESS | 21912 | RSS: Main: 157339648 04:32:57 INFO - PROCESS | 21912 | 04:32:59 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-oscillator) 04:32:59 INFO - PROCESS | 21912 | RSS: Main: 156647424 04:32:59 INFO - PROCESS | 21912 | 04:33:02 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:02 INFO - PROCESS | 21912 | RSS: Main: 156606464 04:33:02 INFO - PROCESS | 21912 | 04:33:05 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:06 INFO - PROCESS | 21912 | RSS: Main: 156364800 04:33:06 INFO - PROCESS | 21912 | 04:33:09 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:10 INFO - PROCESS | 21912 | RSS: Main: 156811264 04:33:10 INFO - PROCESS | 21912 | 04:33:13 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51977/tests/kraken/driver.html?testName=json-parse-financial) 04:33:13 INFO - PROCESS | 21912 | RSS: Main: 157511680 04:33:13 INFO - PROCESS | 21912 | 04:33:15 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:16 INFO - PROCESS | 21912 | RSS: Main: 157413376 04:33:16 INFO - PROCESS | 21912 | 04:33:17 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:18 INFO - PROCESS | 21912 | RSS: Main: 156950528 04:33:18 INFO - PROCESS | 21912 | 04:33:20 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:21 INFO - PROCESS | 21912 | RSS: Main: 157208576 04:33:21 INFO - PROCESS | 21912 | 04:33:23 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:24 INFO - PROCESS | 21912 | RSS: Main: 157294592 04:33:24 INFO - PROCESS | 21912 | 04:33:26 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:27 INFO - PROCESS | 21912 | RSS: Main: 157384704 04:33:27 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51977/tests/kraken/driver.html?testName=ai-astar) 04:33:29 INFO - PROCESS | 21912 | RSS: Main: 158187520 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | __start_tp_report 04:33:29 INFO - PROCESS | 21912 | _x_x_mozilla_page_load 04:33:29 INFO - PROCESS | 21912 | _x_x_mozilla_page_load_details 04:33:29 INFO - PROCESS | 21912 | |i|pagename|runs| 04:33:29 INFO - PROCESS | 21912 | |0;ai-astar;98;112;105;109;110;113;112;110;111;110 04:33:29 INFO - PROCESS | 21912 | |1;audio-beat-detection;149;116;148;169;119;144;152;120;176;121 04:33:29 INFO - PROCESS | 21912 | |2;audio-dft;163;163;162;162;165;165;165;163;162;164 04:33:29 INFO - PROCESS | 21912 | |3;audio-fft;75;76;75;184;76;76;75;78;170;76 04:33:29 INFO - PROCESS | 21912 | |4;audio-oscillator;85;85;151;84;83;84;152;84;84;143 04:33:29 INFO - PROCESS | 21912 | |5;imaging-gaussian-blur;118;118;116;118;117;117;117;117;118;117 04:33:29 INFO - PROCESS | 21912 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;147;146 04:33:29 INFO - PROCESS | 21912 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 04:33:29 INFO - PROCESS | 21912 | |8;json-parse-financial;52;52;52;52;56;52;52;51;53;53 04:33:29 INFO - PROCESS | 21912 | |9;json-stringify-tinderbox;60;60;61;59;60;59;59;60;60;60 04:33:29 INFO - PROCESS | 21912 | |10;stanford-crypto-aes;74;73;74;82;74;72;72;73;71;82 04:33:29 INFO - PROCESS | 21912 | |11;stanford-crypto-ccm;127;120;124;119;118;118;134;117;152;117 04:33:29 INFO - PROCESS | 21912 | |12;stanford-crypto-pbkdf2;157;156;157;157;153;156;156;152;156;155 04:33:29 INFO - PROCESS | 21912 | |13;stanford-crypto-sha256-iterative;63;63;63;70;62;62;62;62;62;63 04:33:29 INFO - PROCESS | 21912 | __end_tp_report 04:33:29 INFO - PROCESS | 21912 | __start_cc_report 04:33:29 INFO - PROCESS | 21912 | _x_x_mozilla_cycle_collect,859 04:33:29 INFO - PROCESS | 21912 | __end_cc_report 04:33:29 INFO - PROCESS | 21912 | __startTimestamp1471520009488__endTimestamp 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | ------- Summary: start ------- 04:33:29 INFO - PROCESS | 21912 | Number of tests: 14 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.50 stddev:4.45 (4.0%) stddev-sans-first:2.33 04:33:29 INFO - PROCESS | 21912 | Values: 98.0 112.0 105.0 109.0 110.0 113.0 112.0 110.0 111.0 110.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:148.50 stddev:21.60 (14.5%) stddev-sans-first:22.74 04:33:29 INFO - PROCESS | 21912 | Values: 149.0 116.0 148.0 169.0 119.0 144.0 152.0 120.0 176.0 121.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.26 (0.8%) stddev-sans-first:1.33 04:33:29 INFO - PROCESS | 21912 | Values: 163.0 163.0 162.0 162.0 165.0 165.0 165.0 163.0 162.0 164.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:42.77 (56.3%) stddev-sans-first:44.68 04:33:29 INFO - PROCESS | 21912 | Values: 75.0 76.0 75.0 184.0 76.0 76.0 75.0 78.0 170.0 76.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.00 stddev:31.26 (37.2%) stddev-sans-first:32.43 04:33:29 INFO - PROCESS | 21912 | Values: 85.0 85.0 151.0 84.0 83.0 84.0 152.0 84.0 84.0 143.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 04:33:29 INFO - PROCESS | 21912 | Values: 118.0 118.0 116.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:33:29 INFO - PROCESS | 21912 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:33:29 INFO - PROCESS | 21912 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:1.35 (2.6%) stddev-sans-first:1.42 04:33:29 INFO - PROCESS | 21912 | Values: 52.0 52.0 52.0 52.0 56.0 52.0 52.0 51.0 53.0 53.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 04:33:29 INFO - PROCESS | 21912 | Values: 60.0 60.0 61.0 59.0 60.0 59.0 59.0 60.0 60.0 60.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:3.97 (5.4%) stddev-sans-first:4.21 04:33:29 INFO - PROCESS | 21912 | Values: 74.0 73.0 74.0 82.0 74.0 72.0 72.0 73.0 71.0 82.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:122.00 stddev:11.06 (9.1%) stddev-sans-first:11.69 04:33:29 INFO - PROCESS | 21912 | Values: 127.0 120.0 124.0 119.0 118.0 118.0 134.0 117.0 152.0 117.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.00 stddev:1.72 (1.1%) stddev-sans-first:1.73 04:33:29 INFO - PROCESS | 21912 | Values: 157.0 156.0 157.0 157.0 153.0 156.0 156.0 152.0 156.0 155.0 04:33:29 INFO - PROCESS | 21912 | 04:33:29 INFO - PROCESS | 21912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.44 (3.9%) stddev-sans-first:2.59 04:33:29 INFO - PROCESS | 21912 | Values: 63.0 63.0 63.0 70.0 62.0 62.0 62.0 62.0 62.0 63.0 04:33:29 INFO - PROCESS | 21912 | -------- Summary: end -------- 04:33:29 INFO - PROCESS | 21912 | 04:33:30 INFO - TEST-INFO | 21912: exit 0 04:33:30 INFO - TEST-OK | kraken | took 62179ms 04:33:30 INFO - SUITE-END | took 1174s 04:33:30 INFO - Completed test suite (00:19:34) 04:33:30 INFO - javascript benchmark 04:33:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7975.862650829517, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.75116866235, 3319.236575587613, 3325.418051840927, 3334.2831291272373, 3354.8825791097315, 5799.565032622554, 5846.853828654286, 5855.502282305998, 5859.296884373875, 5871.559633027518, 5832.9708351458185, 5903.409659034105, 5905.143754155655, 5905.586608937376, 5917.289925208981, 5217.71302578359, 5339.359276886779, 5340.599455040868, 5363.892722145555, 5390.4879036491475, 5201.063808514466, 5213.348331458567, 5255.658382205163, 5262.079136151158, 5302.575793936476, 5245.4754524547625, 5247.239150323201, 5276.023935571912, 5342.439043900393, 5391.218273350361, 5303.920441193385, 5322.2282768998475, 5328.387235467893, 5338.252644629755, 5346.946530534684, 5060.063888180662, 5161.406438259611, 5218.556422704075, 5249.212618107276, 5283.86790330241, 5814.796482123148, 5821.330546987108, 5835.5915085944, 5837.416258374171, 5858.062709966385, 6249.843753906143, 6284.780032698834, 6303.401176888188, 6312.368763123651, 6320.71556779946, 6041.78853740117, 6134.834601026134, 6309.3491183127135, 6349.873002539969, 6352.650604216767, 5840.415958404168, 5892.587518873681, 5906.70466476683, 5912.556558258105, 5921.052631578927, 6367.235931688227, 6380.776672816429, 6388.425041746265, 6401.199850018747, 6405.3594640535575, 5866.090755932837, 6036.185115009505, 6109.633421994695, 6174.567780255339, 6175.475084617858, 6120.690942950841, 6251.28110267316, 6289.0, 6290.370962903765, 6309.810705678837, 6199.194104766351, 6219.315875253718, 6242.406971337716, 6243.937560624336, 6245.125682404467, 5934.495567876693, 6086.02623580225, 6195.349488303754, 6203.069539569011, 6216.875662486725, 4673.065386922561, 4700.412448443944, 4703.082898834763, 4739.715617062987, 4744.027474367746, 4174.269502837052, 4183.6653067754505, 4191.497020357577, 4201.978990105091, 4202.957970420318, 5829.125631155276, 5835.912461313083, 5846.152307915413, 5911.113332999998, 5916.940830591639, 6229.470495007885, 6325.272593651697, 6355.951268040814, 6358.395952384609, 6376.107344971708, 5976.581639285295, 5981.880362392815, 5991.64050156992, 6011.6693581853415, 6086.756529738849, 4963.925541116886, 5139.974300128551, 5231.0584094862525, 5237.580993520509, 5257.474252574789, 6411.807645770635, 6505.4795616350575, 6516.804495865132, 6518.739250430024, 6528.869422611521, 6181.629102253879, 6236.812895613139, 6257.906131407942, 6259.937400625936, 6264.780732674334, 6236.75052997875, 6346.079818426395, 6456.580322279036, 6495.0, 6507.934920650733, 6069.666168360783, 6140.938590614037, 6147.477464415575, 6162.753489860355, 6178.66017369031, 6250.749970001149, 6255.749770009149, 6262.0, 6271.655058971618, 6272.121902933684, 5960.225170727777, 6112.816615501542, 6143.631382117087, 6151.3541078186145, 6159.938400616115, 6052.939470605414, 6154.630722156685, 6165.599236049642, 6169.352218017044, 6178.289496707936, 6011.789587364421, 6042.214512113397, 6075.2193691118, 6097.664628445478, 6140.293866205265, 5932.584719069624, 5937.762489500372, 6188.916964450387, 6211.627302361872, 6248.718807653758, 5834.824955251349, 5896.498797602252, 5923.0, 5928.49607783326, 5942.10868369748], "value": 5738.783085580694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.1637948682101, 631.4853394483496, 667.3893387550395, 669.6986356139736, 706.1420374245291, 45274.0, 46244.53755462445, 46303.536964630344, 46359.30461043087, 46384.304235436495, 47680.523194768044, 47918.0, 48249.517504824944, 48393.51606483934, 48636.75681621596, 9020.503872287021, 9122.08779122089, 9167.862482062741, 9168.40405373652, 9193.08069193082, 9085.318601104911, 9126.726198214064, 9166.954165229197, 9195.494247816367, 9201.815963680723, 9102.499362535058, 9139.131782480687, 9169.770755731093, 9189.862152067692, 9230.630774769035, 9082.77293067672, 9185.265178785681, 9192.080791920787, 9210.631574737003, 9246.491442970633, 9085.182333590008, 9117.954410227907, 9156.084391560857, 9178.586963586587, 9205.217556507705, 44710.77644611789, 44734.552654473366, 44789.55210447886, 44905.77547112276, 44945.550544494465, 3259.2992506610954, 3893.06566424059, 3897.142628621699, 3995.700322475826, 4039.252738243405, 36300.273994519965, 36830.263394731955, 37159.628403715884, 39700.20599588021, 40174.79912600418, 4749.121412538691, 4893.510648935114, 4947.678400903966, 4964.67729597575, 4978.228374601942, 416561.0, 419287.0, 424169.0, 424281.0, 424343.87828060973, 70950.64524677343, 71821.0, 72096.27903721, 72102.63948680223, 72116.63941680259, 39791.80104099461, 42117.1576568473, 42207.36688949668, 76051.23948760552, 76585.23414765781, 19710.901445492967, 19716.40850774479, 19736.70394944077, 19774.209031638573, 19838.50403739918, 15139.167345796088, 15281.083135011935, 15305.617359565877, 15314.234288285541, 15337.0797752133, 22641.54716905653, 22818.885905570365, 22837.657435138488, 23071.307860764206, 23172.420689482897, 8276.379271554657, 8397.270886961762, 8460.915390846136, 8534.53060081689, 8556.914430855737, 1083.6044843632176, 1106.3859557945418, 1115.185914282562, 1135.2167004766684, 1182.9467673954694, 35463.82268088643, 35543.82228088895, 36133.45799813005, 36345.0, 38259.42610860839, 1128.3906690387264, 1147.7761836441814, 1152.2970987697497, 1261.5269274022241, 1262.7600755856542, 17628.471145865387, 17773.644527109645, 17795.0, 17906.462806115836, 17914.55213619644, 644547.0, 651742.0, 656229.0, 658434.0, 660162.0, 64164.0, 64690.0, 64850.0, 64904.0, 64944.72693455706, 1446.1612264886342, 1488.2038109611306, 1497.7378958682186, 1502.9849701503065, 1504.2102895979478, 33467.832660837514, 34815.65184348124, 34961.0, 35151.82424087863, 35422.0, 57116.0, 57801.421985779605, 57882.0, 57905.42094579169, 57912.710436447545, 558292.0, 561235.0, 561995.0, 563086.0, 563115.0, 31765.523517146798, 31927.0, 32062.35875282528, 32166.67833321637, 32465.0, 53164.73417632887, 53190.0, 54441.0, 54698.17952730792, 54987.0, 46081.0, 47334.76332618315, 47999.280010799164, 48022.75988620034, 48176.5182348172, 47201.0, 48688.75655621699, 48696.513034870615, 48754.512454876414, 49004.2649360267, 39881.40177897276, 45733.0, 45977.77011114923, 46846.0, 47553.0, 39222.803885980386, 40532.7041132599, 40723.796381017906, 40816.0, 41858.37212441755, 31061.223469413446, 31628.0, 31750.21944071148, 31836.84081579577, 31936.68063319337], "value": 22419.49654734124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.98770036898867, 412.1530255325307, 424.51817187492196, 425.478788484107, 437.2021061562649, 19192.520186995316, 20145.496362590944, 20535.28126515572, 20604.793952060474, 21184.57630847384, 19590.510237244074, 20231.696524552142, 20456.181752729874, 20806.47983800406, 20899.791002089976, 5975.492083172925, 6133.693315334238, 6193.659348735818, 6196.008638617799, 6196.194494715681, 5986.161937328778, 6035.3059398169335, 6037.698115094249, 6082.482988945945, 6109.450149486545, 5916.497097746696, 5998.6400815950965, 6007.669578173199, 6029.788957386492, 6031.065184896326, 5940.04959206527, 5946.464818166364, 5999.910001349983, 6008.0, 6014.458698717114, 5303.787848486056, 5335.306410166692, 5343.278657381243, 5348.786048558053, 5357.624966252364, 23758.881205594033, 24753.133640322503, 24797.62803557948, 24866.751332486623, 24921.875390622932, 2587.1721049264243, 2591.06721580231, 2700.540908045637, 2823.830570165776, 3119.9688003119904, 15250.542483725507, 15663.295151718201, 15811.209439527978, 15828.52514424569, 16304.184790760415, 2012.3560460652598, 2111.123883588309, 2113.3976816607346, 2136.8504204705678, 2152.160657343637, 67002.0, 70616.293837062, 75921.62039189824, 77196.61401693012, 87637.0, 11273.379964102052, 11373.0, 11609.187356885106, 11623.186376953532, 11628.127890408254, 16384.26270817816, 16433.342666293214, 16466.75299870503, 16477.0, 16516.50450486487, 8569.657213711382, 8620.698275560326, 8830.514321712368, 8970.058143894928, 9187.127222913812, 8605.913940860637, 8616.827663446697, 8741.825163496695, 8862.379633425599, 8971.775705607282, 5007.173816320339, 5008.323876276656, 5052.115879721034, 5061.936993231389, 5142.151544995108, 2022.7572691277142, 2027.1891243502716, 2030.4822270320974, 2086.5201003769216, 2139.229877244191, 961.3078583419926, 1025.0825511167463, 1032.5972870580479, 1038.4755698372426, 1124.5756670937017, 20423.387298381072, 20805.687914681293, 20820.479488012617, 21013.739175649203, 21265.89367053155, 1050.3382868792612, 1079.9352038877691, 1093.4040947683532, 1096.276457538037, 1118.7147277444362, 11240.662780116609, 11275.548978040786, 11364.090872730161, 11513.53945842157, 11656.53373865036, 522194.0, 544893.0, 546921.0, 562359.0, 565541.0, 95330.0, 95409.52295238618, 95753.52123239479, 95859.0, 103948.0, 1034.9275550711377, 1040.953157107932, 1053.7365658585354, 1054.9208809339177, 1062.888396718349, 17856.46430607084, 18623.81376186275, 18848.717269241246, 19075.523111921757, 19092.522686932938, 44938.55061449343, 45785.313220301054, 45931.31103033524, 47433.28850067321, 48450.38243766707, 61323.69338153281, 62073.68963155336, 64446.0, 65639.0, 67238.0, 13551.186928784304, 13599.388027538587, 13667.521636742666, 13821.101628394123, 13856.376463059389, 14730.189839558927, 15158.469453569072, 15306.923465382602, 15368.462103826312, 15565.676917462142, 12190.451429685863, 12393.380330983595, 13055.543055992996, 13084.738305234032, 13334.39995200199, 12373.195742276723, 12640.494380225056, 12749.17130386522, 13215.801762973371, 13647.86352136466, 12452.81320780171, 12638.747225055264, 13247.735045299232, 13308.201507909556, 13571.321433928066, 13549.796753048515, 13618.727625447635, 13628.386722597308, 13636.454541818217, 13687.178769273876, 12914.418851151908, 13048.151870128411, 13057.151285166434, 13216.66958326011, 13243.20540767557], "value": 10221.352642067795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.2669481996054, 1583.849534294242, 1757.58696706274, 1868.327402135231, 1913.5790126172237, 8735.73792786216, 9375.343725939187, 9538.0, 10135.44255065971, 10164.847527287087, 9596.376235544685, 9866.950665246664, 9873.901260987388, 9927.900720992788, 9947.452890091043, 2483.6522886795865, 2508.761667641571, 2531.911383101592, 2535.6703628528267, 2544.8727563621746, 2526.090607381341, 2591.391023109568, 2599.54507961107, 2599.753023462768, 2601.8048646351504, 2541.733118022609, 2552.2343297010916, 2572.6655534780452, 2576.4589436218416, 2582.935426614331, 2514.899404023846, 2521.344450442889, 2521.4957008598353, 2539.873006349675, 2542.898284068635, 2494.451220731436, 2499.3751562109474, 2502.249325202432, 2504.0734928076545, 2533.505966336565, 9806.509674516246, 9883.505824708736, 9973.850392244121, 9982.251331150193, 9999.450030248334, 5861.20873682056, 5988.071848863433, 5988.880222395528, 6036.305824830113, 6048.7882924097885, 3706.944395834065, 3756.6619004289746, 3807.1053302473897, 3854.939891529824, 3945.802709864524, 1230.7353918907388, 1291.6706239908858, 1293.333933024493, 1297.1762930539176, 1330.2816479101273, 13774.380152893043, 13856.93071534646, 13868.86131138696, 13910.095843770123, 13912.652183695489, 5053.5957123430035, 5068.493150684902, 5077.593792496666, 5093.0, 5324.254604355393, 11563.537458501734, 11645.6506304811, 11742.119341049456, 11744.354060526754, 11766.0, 5861.120831875252, 5901.468867801918, 5903.291605007426, 5905.970470147708, 5916.437938395846, 4840.564349208588, 5192.3769147702515, 5280.313559237351, 5315.123004704258, 5452.182172674131, 4362.454693163355, 4402.405675233803, 4453.35426363182, 4502.684812063189, 4541.8183272669385, 1366.5558693424678, 1411.400154934149, 1418.44680574576, 1422.9217393043482, 1425.0238586568234, 1042.4735508568124, 1069.2622090757352, 1071.4000159910474, 1072.9356238625708, 1090.3948308688755, 6563.409293163638, 6584.8024559263295, 6655.134832471747, 6722.9663851680425, 6769.559978601375, 477.7229207059897, 478.4808482796205, 488.4017079078172, 489.3858207949001, 499.455593403185, 4582.9770851146195, 4610.0, 4652.97673511637, 4692.0850434165695, 4751.382320298339, 12078.0, 12288.447019884126, 12399.938000310121, 12431.191972521758, 12437.93781031089, 11550.480228389742, 12134.453949572115, 12157.878421215852, 12284.877151228553, 12299.077569182347, 9102.59038343263, 9196.0, 9286.164245217962, 9292.53537323131, 9311.068893110634, 6426.4216220540375, 6444.806655800334, 6596.901046484402, 6696.263411024686, 6744.123263975848, 10997.725056873322, 11059.778804424028, 11083.72290692739, 11226.775464490502, 11284.887151128383, 11248.718782030188, 11345.48945297447, 11362.772744545227, 11397.202195846212, 11492.620885493794, 7804.9609751950875, 8366.079731229438, 8368.581570921308, 8427.199416055464, 8622.310215182895, 9699.612015519582, 9756.951215243878, 9806.75483112928, 9811.018898110417, 9824.901750982399, 8104.0, 8131.512109273463, 8178.754637360888, 8229.506229626242, 8301.086880443027, 8451.704190353308, 8476.660933562589, 8520.957395212985, 8534.658613655385, 8624.353173512138, 7800.375969922279, 7896.526208427513, 7963.044434667645, 8036.959815200887, 8038.276555110068, 5517.503424691797, 5708.5147762439, 5727.36998930109, 5748.080307150836, 5857.677827719346, 5821.359650438533, 5823.097419899922, 5906.940930590639, 5949.434803693643, 5991.940080599138], "value": 5063.285758427493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.4767786092626, 345.1044539420204, 345.2421933855187, 353.8872928616164, 359.7841295222865, 5863.149843272723, 5904.3800400957925, 5911.46796788289, 5918.7632494700265, 5957.731902064406, 5775.393583673716, 5786.363500014995, 5790.855228619286, 5791.942080579193, 5797.594168408203, 4095.610916962884, 4415.712978656377, 4458.2866741321395, 4487.19230538503, 4513.736153876904, 4476.239039363316, 4480.602877460559, 4485.215087359716, 4508.66185036122, 4510.210713125206, 4465.598096171344, 4465.620422264112, 4473.239549276631, 4486.528914463967, 4492.303692927601, 4276.465441819772, 4354.3468479728135, 4416.205083085043, 4437.778111094464, 4460.130274596455, 3889.4749208856724, 3891.9805400973096, 3896.337622604164, 3897.649211570972, 3905.3987864975225, 5620.325560932673, 5648.43515648436, 5650.0959846424375, 5672.4894759471845, 5674.914876276859, 5008.874778130539, 5152.046871328778, 5157.948420515784, 5161.4322424533275, 5182.533571978503, 6062.514683902428, 6064.241969753781, 6091.634501929899, 6091.695415229266, 6104.206453161105, 4219.282721937278, 4356.194104090721, 4391.209582275189, 4392.71447355924, 4416.889577760549, 6164.167837341991, 6219.067139929001, 6233.096201050867, 6253.96873015632, 6253.968730156365, 4445.866624001285, 4451.376807246988, 4462.955370446319, 4471.7987690554, 4473.507914129443, 4392.1874453226255, 4468.322412316484, 4476.865694029184, 4508.143452743968, 4535.365048893158, 5112.923306150411, 5133.0, 5167.560757335594, 5171.4052883918075, 5181.248718935733, 6156.846078847975, 6157.630542167484, 6167.167432396659, 6174.938250617526, 6183.381661833871, 1543.104999100519, 1543.3749331520753, 1554.6113471632093, 1560.5786437661768, 1564.0146707574156, 1019.1490105761771, 1021.3208216536069, 1028.290479569095, 1059.433203236265, 1094.3051162511863, 5886.117082437669, 5900.1149827526215, 5900.76396944126, 5904.911426328608, 5908.852278692981, 6206.252217053957, 6212.565120441525, 6266.185395898504, 6285.0, 6337.176167098248, 5681.772729090872, 5792.177163072352, 5901.232839730807, 5905.498032667186, 5911.438413350725, 3313.784604000732, 3363.209645733251, 3373.40965331071, 3375.7974521528786, 3379.7803142795638, 6364.204474440695, 6451.903221451588, 6472.385123413268, 6540.345965403421, 6564.277929427759, 6319.178506794087, 6333.46165575922, 6354.332795056453, 6363.840903977438, 6381.744730210832, 6316.873662526724, 6418.807435776934, 6422.3577642235405, 6537.280899101095, 6546.574472659262, 6118.449339559461, 6143.508519318533, 6220.191375121205, 6231.189945307081, 6267.4045965633195, 5870.5010074142465, 6151.415615516519, 6179.567430280017, 6189.442950134509, 6196.442320191204, 6344.953082741296, 6391.424771770563, 6418.775342862978, 6440.262888272559, 6470.417662410406, 4486.618637415726, 4512.706674066175, 4515.819367225406, 4533.478649955166, 4566.429196350457, 5961.076033214858, 6137.754489820357, 6166.537509686702, 6213.347598502092, 6245.970059730696, 6024.367441418588, 6031.155638210566, 6084.269887613515, 6112.17485639433, 6125.785597504066, 5798.94201057984, 6011.6693581853415, 6056.273247210363, 6082.239720034996, 6092.872818528586, 5743.59794814359, 5874.94125058744, 5906.379830117948, 5951.702414879325, 6028.517718582415, 6156.661383623944, 6167.938320616737, 6174.598651087665, 6186.0, 6201.6899155041165, 5823.708814559171, 5953.791617293374, 5989.0, 5995.2206213192, 6000.039993601003], "value": 4630.199081966362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.8293058457724, 830.5764060329234, 851.5146366571055, 869.8695195720637, 917.8531434970406, 16937.407190748327, 18083.095845207736, 18232.81767182328, 18234.726479102806, 18344.81655183448, 15878.920605396957, 15911.44309949152, 15968.121753303563, 16016.35934562616, 16029.198540072979, 888.7511496780912, 902.1474706402453, 914.2548822709504, 919.7010971434311, 920.1120918313826, 908.0420156734642, 915.7664795477177, 918.2241006349624, 919.8298314811781, 920.2132176988679, 948.393028461785, 948.800751842114, 950.1875896108832, 951.7906060666643, 953.2707478778705, 948.9762755931088, 950.5199874063588, 951.7715748220412, 952.4618590496417, 953.8998405167462, 695.6521739130435, 698.3121625199175, 699.3740602161088, 700.1073631120312, 700.831800367908, 16435.26041328143, 16555.834441655672, 16602.08688522131, 16650.33398664052, 16705.498835034967, 15647.0, 15809.288582013836, 16234.51296461108, 16375.508734737978, 16375.754363684555, 13933.233672148028, 13964.441422343094, 14017.71964560703, 14129.293535323193, 14315.713685726332, 4110.445089912883, 4221.535631080578, 4228.238916994939, 4321.416608757841, 4354.107407981356, 66415.0, 72504.63747681228, 83766.58116709438, 85078.0, 85308.0, 12011.099167562468, 12113.273203607636, 12150.878491215151, 12244.938775306244, 12479.438425270884, 23584.41038974005, 23617.527649446914, 23626.763732362455, 23639.7636023641, 23757.524849502912, 8272.586370681442, 8497.702580409656, 8506.064332923374, 8627.525486098324, 8984.55077246135, 4526.434195725535, 4529.5243999380245, 4536.183486972377, 4580.633549316047, 4611.1930412177735, 4004.2992476316526, 4083.4079058536345, 4122.216778812016, 4127.277726397869, 4279.379489973936, 696.989545156823, 698.5773606967813, 709.021550260637, 709.7728726807372, 743.4201322968094, 786.103841620553, 799.580220384303, 836.8159005018886, 840.1010918317464, 850.5577099908013, 10273.743156421, 10913.618023369303, 11212.0, 11255.493502792395, 11376.772464550662, 844.5059640110481, 847.9319277078602, 851.9105493923173, 854.2183901729971, 872.9825403492022, 5007.4241462231585, 5414.972925135349, 5476.17857321397, 5488.615796894259, 5553.416891226444, 102594.48702756439, 116720.0, 118924.40537797255, 120138.0, 121550.39224803996, 105845.0, 109606.32755707024, 109653.0, 111305.0, 112548.0, 57020.714896425256, 82823.0, 92749.53625231965, 95883.0411695888, 98327.50836245916, 10484.370937743759, 10874.238803283693, 10974.286671366335, 11003.22977391575, 11028.44857757125, 54580.454195459126, 55827.441725582226, 55969.720151398986, 56280.71859640839, 56628.15057774219, 72507.27492725005, 76921.61539192268, 77602.61198693971, 78241.60879195567, 78514.6074269625, 14603.634909127357, 14617.122972621677, 14692.779608306098, 14817.110973341634, 14824.703505930036, 15605.45380911708, 16078.59803504875, 16262.67474650524, 16422.343106275614, 16467.752983705013, 14792.186429746036, 14899.553013409615, 15602.453914113406, 15784.13187274711, 15840.76238856395, 12953.41709623088, 13704.177749335071, 13746.587602371945, 13894.652633684238, 14892.180930048951, 15110.54668359951, 15550.0, 15552.066875987477, 15559.910806243453, 15660.13869237203, 12424.875751242373, 12574.559890404158, 12857.549985750455, 12975.416106275428, 13415.0, 12862.292573908524, 12928.741425171633, 13138.737225255632, 13297.534586289434, 13341.132826366254], "value": 8349.057498944547, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 112.0, 105.0, 109.0, 110.0, 113.0, 112.0, 110.0, 111.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 148.0, 169.0, 119.0, 144.0, 152.0, 120.0, 176.0, 121.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 165.0, 165.0, 165.0, 163.0, 162.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 184.0, 76.0, 76.0, 75.0, 78.0, 170.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 151.0, 84.0, 83.0, 84.0, 152.0, 84.0, 84.0, 143.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 56.0, 52.0, 52.0, 51.0, 53.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 82.0, 74.0, 72.0, 72.0, 73.0, 71.0, 82.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 124.0, 119.0, 118.0, 118.0, 134.0, 117.0, 152.0, 117.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 157.0, 157.0, 153.0, 156.0, 156.0, 152.0, 156.0, 155.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 70.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 63.2, "unit": "score"}]}]} 04:33:30 INFO - Return code: 0 04:33:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:30 ERROR - # TBPL SUCCESS # 04:33:30 INFO - Running post-action listener: _resource_record_post_action 04:33:30 INFO - [mozharness: 2016-08-18 11:33:30.813956Z] Finished run-tests step (success) 04:33:30 INFO - Running post-run listener: _resource_record_post_run 04:33:30 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 324091904; Read time: 0; Write time: 462836 04:33:30 INFO - TinderboxPrint: CPU usage
13.2% 04:33:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:33:30 INFO - TinderboxPrint: I/O write bytes / time
324,091,904 / 462,836 04:33:30 INFO - TinderboxPrint: CPU idle
8,250.4 (86.7%) 04:33:30 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 04:33:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 79110144; Read time: 0; Write time: 102360 04:33:30 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 244981760; Read time: 0; Write time: 360476 04:33:31 INFO - Running post-run listener: _upload_blobber_files 04:33:31 INFO - Blob upload gear active. 04:33:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:31 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:33:31 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:33:31 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:33:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:33 INFO - (blobuploader) - INFO - Done attempting. 04:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:33:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:34 INFO - (blobuploader) - INFO - Done attempting. 04:33:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:37 INFO - (blobuploader) - INFO - Done attempting. 04:33:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:37 INFO - Return code: 0 04:33:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fea708cc6d6b04897d23d8356515b58d24336b3f056c4c8a686d1e91fdfa28b0af1efb86dc3fbe5c7c8e9702c5ca285923bfdf99e5df6afb47f1aa296ed0631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049845ddfb2ff70a92c2e4b5ffa8f4659675e942dbaf48caf53187f5397cc5a011435e1e44da9927d6e5c22a3925027058138966eaa5ed6ad20680f858a5ab54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89efc2ab5c8d0d096f35596fc2d8422f5bccf1ecd7a6231b7b098a76693743aaf393c607f0dc03c2610c45657e74e6aa73a4ef898f3f778628bd61ff7862a47c"} 04:33:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:37 INFO - Contents: 04:33:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fea708cc6d6b04897d23d8356515b58d24336b3f056c4c8a686d1e91fdfa28b0af1efb86dc3fbe5c7c8e9702c5ca285923bfdf99e5df6afb47f1aa296ed0631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049845ddfb2ff70a92c2e4b5ffa8f4659675e942dbaf48caf53187f5397cc5a011435e1e44da9927d6e5c22a3925027058138966eaa5ed6ad20680f858a5ab54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89efc2ab5c8d0d096f35596fc2d8422f5bccf1ecd7a6231b7b098a76693743aaf393c607f0dc03c2610c45657e74e6aa73a4ef898f3f778628bd61ff7862a47c"} 04:33:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:37 INFO - Copying logs to upload dir... 04:33:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1685.915298 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 6 secs) (at 2016-08-18 04:33:37.760778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-08-18 04:33:37.764390) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376 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/1fea708cc6d6b04897d23d8356515b58d24336b3f056c4c8a686d1e91fdfa28b0af1efb86dc3fbe5c7c8e9702c5ca285923bfdf99e5df6afb47f1aa296ed0631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049845ddfb2ff70a92c2e4b5ffa8f4659675e942dbaf48caf53187f5397cc5a011435e1e44da9927d6e5c22a3925027058138966eaa5ed6ad20680f858a5ab54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89efc2ab5c8d0d096f35596fc2d8422f5bccf1ecd7a6231b7b098a76693743aaf393c607f0dc03c2610c45657e74e6aa73a4ef898f3f778628bd61ff7862a47c"} build_url:https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/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/1fea708cc6d6b04897d23d8356515b58d24336b3f056c4c8a686d1e91fdfa28b0af1efb86dc3fbe5c7c8e9702c5ca285923bfdf99e5df6afb47f1aa296ed0631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049845ddfb2ff70a92c2e4b5ffa8f4659675e942dbaf48caf53187f5397cc5a011435e1e44da9927d6e5c22a3925027058138966eaa5ed6ad20680f858a5ab54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89efc2ab5c8d0d096f35596fc2d8422f5bccf1ecd7a6231b7b098a76693743aaf393c607f0dc03c2610c45657e74e6aa73a4ef898f3f778628bd61ff7862a47c"}' ========= master_lag: 2.49 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-08-18 04:33:40.265149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:33:40.265452) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471518043.277497-1494184376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003875 ========= master_lag: 0.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:33:40.614674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 04:33:40.614944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 04:33:40.615478) ========= ========= Total master_lag: 3.14 =========