builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1471518330.62 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.621414) ========= 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.621762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.622037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.710619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.710873) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-08-18 04:05:32 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104482 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.841177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.841442) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015951 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.893886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:30.894213) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 04:05:32,197 truncating revision to first 12 chars 2016-08-18 04:05:32,197 Setting DEBUG logging. 2016-08-18 04:05:32,197 attempt 1/10 2016-08-18 04:05:32,197 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:32,499 unpacking tar archive at: mozilla-aurora-d23f68f5cb77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.534953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.535279) ========= script_repo_revision: d23f68f5cb77934e673700bfaaaf607893a2df9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.535751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.536048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:05:31.548424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 8 secs) (at 2016-08-18 04:05:31.548759) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232 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-034', 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.942612Z] 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:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - [mozharness: 2016-08-18 11:05:33.409961Z] Finished clobber step (success) 04:05:33 INFO - [mozharness: 2016-08-18 11:05:33.410062Z] Running read-buildbot-config step. 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: read_buildbot_config 04:05:33 INFO - Using buildbot properties: 04:05:33 INFO - { 04:05:33 INFO - "project": "", 04:05:33 INFO - "product": "firefox", 04:05:33 INFO - "script_repo_revision": "production", 04:05:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:05:33 INFO - "repository": "", 04:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:05:33 INFO - "buildid": "20160817221914", 04:05:33 INFO - "pgo_build": "True", 04:05:33 INFO - "basedir": "/builds/slave/test", 04:05:33 INFO - "buildnumber": 486, 04:05:33 INFO - "slavename": "talos-linux64-ix-034", 04:05:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:33 INFO - "platform": "ubuntu64_hw", 04:05:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:05:33 INFO - "branch": "mozilla-aurora", 04:05:33 INFO - "repo_path": "releases/mozilla-aurora", 04:05:33 INFO - "revision": "d23f68f5cb77934e673700bfaaaf607893a2df9b", 04:05:33 INFO - "stage_platform": "linux64-pgo", 04:05:33 INFO - "builduid": "8a42d84b4c664f7f898715475fc754b5", 04:05:33 INFO - "slavebuilddir": "test" 04:05:33 INFO - } 04:05:33 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:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - [mozharness: 2016-08-18 11:05:33.412512Z] Finished read-buildbot-config step (success) 04:05:33 INFO - [mozharness: 2016-08-18 11:05:33.412601Z] Running download-and-extract step. 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: download_and_extract 04:05:33 INFO - mkdir: /builds/slave/test/build/tests 04:05:33 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:33 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:33 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:33 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:33 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:33 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: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.test_packages.json 04:05:33 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:05:33 INFO - retry: Failed, sleeping 30 seconds before retrying 04:06:03 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: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.test_packages.json 04:06:03 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:06:03 INFO - retry: Failed, sleeping 60 seconds before retrying 04:07:03 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: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.test_packages.json 04:07:03 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:07:03 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:03 INFO - Caught exception: HTTP Error 404: Not Found 04:07:03 INFO - Caught exception: HTTP Error 404: Not Found 04:07:03 INFO - Caught exception: HTTP Error 404: Not Found 04:07:03 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:03 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:03 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:04 INFO - Downloaded 1361 bytes. 04:07:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:07:04 INFO - Using the following test package requirements: 04:07:04 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:07:04 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:04 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:07:04 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'jsshell-linux-x86_64.zip'], 04:07:04 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:04 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:07:04 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:07:04 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:07:04 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:04 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:04 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:04 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:04 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:04 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:04 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:04 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:04 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:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:07:04 INFO - retry: Failed, sleeping 30 seconds before retrying 04:07:34 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:34 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:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:07:34 INFO - retry: Failed, sleeping 60 seconds before retrying 04:08:34 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:34 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:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:08:34 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:34 INFO - Caught exception: HTTP Error 404: Not Found 04:08:34 INFO - Caught exception: HTTP Error 404: Not Found 04:08:34 INFO - Caught exception: HTTP Error 404: Not Found 04:08:34 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:34 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:34 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:35 INFO - Downloaded 21766304 bytes. 04:08:35 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:35 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:36 INFO - Return code: 0 04:08:36 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:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:08:36 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:06 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:06 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:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:09:06 INFO - retry: Failed, sleeping 60 seconds before retrying 04:10:06 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:06 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:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:10:06 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:06 INFO - Caught exception: HTTP Error 404: Not Found 04:10:06 INFO - Caught exception: HTTP Error 404: Not Found 04:10:06 INFO - Caught exception: HTTP Error 404: Not Found 04:10:06 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:06 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:06 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:07 INFO - Downloaded 21766304 bytes. 04:10:07 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:07 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:09 INFO - Return code: 0 04:10:09 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:09 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:09 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:09 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:09 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: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.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: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.talos.tests.zip 04:10:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:10:09 INFO - retry: Failed, sleeping 30 seconds before retrying 04:10: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.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: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.talos.tests.zip 04:10:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:10:39 INFO - retry: Failed, sleeping 60 seconds before retrying 04:11: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.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: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.talos.tests.zip 04:11:39 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:11:39 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:39 INFO - Caught exception: HTTP Error 404: Not Found 04:11:39 INFO - Caught exception: HTTP Error 404: Not Found 04:11:39 INFO - Caught exception: HTTP Error 404: Not Found 04:11:39 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:39 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:39 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:40 INFO - Downloaded 14413723 bytes. 04:11:40 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:40 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:40 INFO - Return code: 0 04:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:40 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:40 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:40 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:40 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:40 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:40 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:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:11:40 INFO - retry: Failed, sleeping 30 seconds before retrying 04:12:10 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:10 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:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:12:10 INFO - retry: Failed, sleeping 60 seconds before retrying 04:13:10 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:10 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:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:13:10 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:10 INFO - Caught exception: HTTP Error 404: Not Found 04:13:10 INFO - Caught exception: HTTP Error 404: Not Found 04:13:10 INFO - Caught exception: HTTP Error 404: Not Found 04:13:10 INFO - trying https://queue.taskcluster.net/v1/task/TwtcBMXDRs2Kz51iIRVNAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:13:10 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:10 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:15 INFO - Downloaded 63746489 bytes. 04:13:15 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:15 INFO - mkdir: /builds/slave/test/properties 04:13:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:15 INFO - Contents: 04:13:15 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:16 INFO - Running post-action listener: _resource_record_post_action 04:13:16 INFO - Running post-action listener: set_extra_try_arguments 04:13:16 INFO - [mozharness: 2016-08-18 11:13:16.449385Z] Finished download-and-extract step (success) 04:13:16 INFO - [mozharness: 2016-08-18 11:13:16.449662Z] Running populate-webroot step. 04:13:16 INFO - Running pre-action listener: _resource_record_pre_action 04:13:16 INFO - Running main action method: populate_webroot 04:13:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:16 INFO - '--tppagecycles', 04:13:16 INFO - '7'], 04:13:16 INFO - 'tests': ['tsvgm']}}, 04:13:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['damp', 'tps']}, 04:13:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'tests': ['damp', 'tps']}, 04:13:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['dromaeo_dom']}, 04:13:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['basic_compositor_video']}, 04:13:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['a11yr', 04:13:16 INFO - 'ts_paint', 04:13:16 INFO - 'tpaint', 04:13:16 INFO - 'sessionrestore', 04:13:16 INFO - 'sessionrestore_no_auto_restore', 04:13:16 INFO - 'tabpaint']}, 04:13:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:16 INFO - 'ts_paint', 04:13:16 INFO - 'tpaint', 04:13:16 INFO - 'sessionrestore', 04:13:16 INFO - 'sessionrestore_no_auto_restore', 04:13:16 INFO - 'tabpaint']}, 04:13:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:16 INFO - 'ts_paint', 04:13:16 INFO - 'tpaint', 04:13:16 INFO - 'sessionrestore', 04:13:16 INFO - 'sessionrestore_no_auto_restore', 04:13:16 INFO - 'tabpaint']}, 04:13:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:16 INFO - 'ts_paint', 04:13:16 INFO - 'tpaint', 04:13:16 INFO - 'sessionrestore', 04:13:16 INFO - 'sessionrestore_no_auto_restore', 04:13:16 INFO - 'tabpaint']}, 04:13:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['a11yr', 04:13:16 INFO - 'ts_paint', 04:13:16 INFO - 'tpaint', 04:13:16 INFO - 'sessionrestore', 04:13:16 INFO - 'sessionrestore_no_auto_restore', 04:13:16 INFO - 'tabpaint']}, 04:13:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['a11yr', 04:13:16 INFO - 'ts_paint', 04:13:16 INFO - 'tpaint', 04:13:16 INFO - 'sessionrestore', 04:13:16 INFO - 'sessionrestore_no_auto_restore', 04:13:16 INFO - 'tabpaint']}, 04:13:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['tsvgx', 04:13:16 INFO - 'tsvgr_opacity', 04:13:16 INFO - 'tart', 04:13:16 INFO - 'tscrollx', 04:13:16 INFO - 'cart']}, 04:13:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:16 INFO - 'tsvgr_opacity', 04:13:16 INFO - 'tart', 04:13:16 INFO - 'tscrollx', 04:13:16 INFO - 'cart']}, 04:13:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'talos_options': ['--disable-e10s'], 04:13:16 INFO - 'tests': ['tp5o']}, 04:13:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'tests': ['tp5o']}, 04:13:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'talos_options': ['--disable-e10s', 04:13:16 INFO - '--xperf_path', 04:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:16 INFO - 'tests': ['tp5n']}, 04:13:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:16 INFO - 'talos_options': ['--xperf_path', 04:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:16 INFO - 'tests': ['tp5n']}}, 04:13:16 INFO - 'talos.zip': {'path': '', 04:13:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:16 INFO - Running post-action listener: _resource_record_post_action 04:13:16 INFO - [mozharness: 2016-08-18 11:13:16.465454Z] Finished populate-webroot step (success) 04:13:16 INFO - [mozharness: 2016-08-18 11:13:16.465550Z] Running create-virtualenv step. 04:13:16 INFO - Running pre-action listener: _resource_record_pre_action 04:13:16 INFO - Running main action method: create_virtualenv 04:13:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:16 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:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:16 INFO - Using real prefix '/usr' 04:13:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:19 INFO - Installing pip.................done. 04:13:19 INFO - Return code: 0 04:13:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:19 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 04:13:19 INFO - 'HOME': '/home/cltbld', 04:13:19 INFO - 'LANG': 'en_US.UTF-8', 04:13:19 INFO - 'LANGUAGE': 'en_US:en', 04:13:19 INFO - 'LOGNAME': 'cltbld', 04:13:19 INFO - 'MAIL': '/var/mail/cltbld', 04:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:19 INFO - 'MOZ_NO_REMOTE': '1', 04:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:19 INFO - 'NO_EM_RESTART': '1', 04:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:19 INFO - 'PWD': '/builds/slave/test', 04:13:19 INFO - 'SHELL': '/bin/bash', 04:13:19 INFO - 'SHLVL': '1', 04:13:19 INFO - 'TERM': 'linux', 04:13:19 INFO - 'TMOUT': '86400', 04:13:19 INFO - 'USER': 'cltbld', 04:13:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:19 INFO - '_': '/tools/buildbot/bin/python'} 04:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:19 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:19 INFO - Cleaning up... 04:13:19 INFO - Return code: 0 04:13:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:19 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 04:13:19 INFO - 'HOME': '/home/cltbld', 04:13:19 INFO - 'LANG': 'en_US.UTF-8', 04:13:19 INFO - 'LANGUAGE': 'en_US:en', 04:13:19 INFO - 'LOGNAME': 'cltbld', 04:13:19 INFO - 'MAIL': '/var/mail/cltbld', 04:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:19 INFO - 'MOZ_NO_REMOTE': '1', 04:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:19 INFO - 'NO_EM_RESTART': '1', 04:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:19 INFO - 'PWD': '/builds/slave/test', 04:13:19 INFO - 'SHELL': '/bin/bash', 04:13:19 INFO - 'SHLVL': '1', 04:13:19 INFO - 'TERM': 'linux', 04:13:19 INFO - 'TMOUT': '86400', 04:13:19 INFO - 'USER': 'cltbld', 04:13:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:19 INFO - '_': '/tools/buildbot/bin/python'} 04:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:19 INFO - Downloading/unpacking psutil>=3.1.1 04:13:19 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:19 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:19 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:19 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:19 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:19 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:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:22 INFO - Installing collected packages: psutil 04:13:22 INFO - Running setup.py install for psutil 04:13:22 INFO - building 'psutil._psutil_linux' extension 04:13:22 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:22 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:22 INFO - building 'psutil._psutil_posix' extension 04:13:22 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:22 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:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:23 INFO - Successfully installed psutil 04:13:23 INFO - Cleaning up... 04:13:23 INFO - Return code: 0 04:13:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 04:13:23 INFO - 'HOME': '/home/cltbld', 04:13:23 INFO - 'LANG': 'en_US.UTF-8', 04:13:23 INFO - 'LANGUAGE': 'en_US:en', 04:13:23 INFO - 'LOGNAME': 'cltbld', 04:13:23 INFO - 'MAIL': '/var/mail/cltbld', 04:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:23 INFO - 'MOZ_NO_REMOTE': '1', 04:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:23 INFO - 'NO_EM_RESTART': '1', 04:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:23 INFO - 'PWD': '/builds/slave/test', 04:13:23 INFO - 'SHELL': '/bin/bash', 04:13:23 INFO - 'SHLVL': '1', 04:13:23 INFO - 'TERM': 'linux', 04:13:23 INFO - 'TMOUT': '86400', 04:13:23 INFO - 'USER': 'cltbld', 04:13:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:23 INFO - '_': '/tools/buildbot/bin/python'} 04:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:23 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:23 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:23 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:23 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:23 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:23 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:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:25 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:25 INFO - Installing collected packages: mozsystemmonitor 04:13:25 INFO - Running setup.py install for mozsystemmonitor 04:13:25 INFO - Successfully installed mozsystemmonitor 04:13:25 INFO - Cleaning up... 04:13:25 INFO - Return code: 0 04:13:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:25 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 04:13:25 INFO - 'HOME': '/home/cltbld', 04:13:25 INFO - 'LANG': 'en_US.UTF-8', 04:13:25 INFO - 'LANGUAGE': 'en_US:en', 04:13:25 INFO - 'LOGNAME': 'cltbld', 04:13:25 INFO - 'MAIL': '/var/mail/cltbld', 04:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:25 INFO - 'MOZ_NO_REMOTE': '1', 04:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:25 INFO - 'NO_EM_RESTART': '1', 04:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:25 INFO - 'PWD': '/builds/slave/test', 04:13:25 INFO - 'SHELL': '/bin/bash', 04:13:25 INFO - 'SHLVL': '1', 04:13:25 INFO - 'TERM': 'linux', 04:13:25 INFO - 'TMOUT': '86400', 04:13:25 INFO - 'USER': 'cltbld', 04:13:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:25 INFO - '_': '/tools/buildbot/bin/python'} 04:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:25 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:25 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:25 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:25 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:25 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:25 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:28 INFO - warning: no files found matching '*.txt' 04:13:28 INFO - no previously-included directories found matching 'build' 04:13:28 INFO - no previously-included directories found matching 'dist' 04:13:28 INFO - no previously-included directories found matching '.git*' 04:13:28 INFO - Installing collected packages: jsonschema, functools32 04:13:28 INFO - Running setup.py install for functools32 04:13:28 INFO - warning: no files found matching '*.txt' 04:13:28 INFO - no previously-included directories found matching 'build' 04:13:28 INFO - no previously-included directories found matching 'dist' 04:13:28 INFO - no previously-included directories found matching '.git*' 04:13:28 INFO - Successfully installed jsonschema functools32 04:13:28 INFO - Cleaning up... 04:13:28 INFO - Return code: 0 04:13:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:28 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 04:13:28 INFO - 'HOME': '/home/cltbld', 04:13:28 INFO - 'LANG': 'en_US.UTF-8', 04:13:28 INFO - 'LANGUAGE': 'en_US:en', 04:13:28 INFO - 'LOGNAME': 'cltbld', 04:13:28 INFO - 'MAIL': '/var/mail/cltbld', 04:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:28 INFO - 'MOZ_NO_REMOTE': '1', 04:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:28 INFO - 'NO_EM_RESTART': '1', 04:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:28 INFO - 'PWD': '/builds/slave/test', 04:13:28 INFO - 'SHELL': '/bin/bash', 04:13:28 INFO - 'SHLVL': '1', 04:13:28 INFO - 'TERM': 'linux', 04:13:28 INFO - 'TMOUT': '86400', 04:13:28 INFO - 'USER': 'cltbld', 04:13:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:28 INFO - '_': '/tools/buildbot/bin/python'} 04:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:13:28 INFO - Cleaning up... 04:13:28 INFO - Return code: 0 04:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:28 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 04:13:28 INFO - 'HOME': '/home/cltbld', 04:13:28 INFO - 'LANG': 'en_US.UTF-8', 04:13:28 INFO - 'LANGUAGE': 'en_US:en', 04:13:28 INFO - 'LOGNAME': 'cltbld', 04:13:28 INFO - 'MAIL': '/var/mail/cltbld', 04:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:28 INFO - 'MOZ_NO_REMOTE': '1', 04:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:28 INFO - 'NO_EM_RESTART': '1', 04:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:28 INFO - 'PWD': '/builds/slave/test', 04:13:28 INFO - 'SHELL': '/bin/bash', 04:13:28 INFO - 'SHLVL': '1', 04:13:28 INFO - 'TERM': 'linux', 04:13:28 INFO - 'TMOUT': '86400', 04:13:28 INFO - 'USER': 'cltbld', 04:13:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:28 INFO - '_': '/tools/buildbot/bin/python'} 04:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:28 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:28 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:28 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:28 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:28 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:28 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 blobuploader-1.2.4.tar.gz 04:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:30 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:30 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 - 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:30 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:30 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:30 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:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:31 INFO - Downloading docopt-0.6.1.tar.gz 04:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:31 INFO - Running setup.py install for blobuploader 04:13:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:31 INFO - Running setup.py install for requests 04:13:31 INFO - Running setup.py install for docopt 04:13:32 INFO - Successfully installed blobuploader requests docopt 04:13:32 INFO - Cleaning up... 04:13:32 INFO - Return code: 0 04:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:32 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 04:13:32 INFO - 'HOME': '/home/cltbld', 04:13:32 INFO - 'LANG': 'en_US.UTF-8', 04:13:32 INFO - 'LANGUAGE': 'en_US:en', 04:13:32 INFO - 'LOGNAME': 'cltbld', 04:13:32 INFO - 'MAIL': '/var/mail/cltbld', 04:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:32 INFO - 'MOZ_NO_REMOTE': '1', 04:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:32 INFO - 'NO_EM_RESTART': '1', 04:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:32 INFO - 'PWD': '/builds/slave/test', 04:13:32 INFO - 'SHELL': '/bin/bash', 04:13:32 INFO - 'SHLVL': '1', 04:13:32 INFO - 'TERM': 'linux', 04:13:32 INFO - 'TMOUT': '86400', 04:13:32 INFO - 'USER': 'cltbld', 04:13:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:32 INFO - '_': '/tools/buildbot/bin/python'} 04:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:32 INFO - Running setup.py (path:/tmp/pip-d2ey6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:32 INFO - Running setup.py (path:/tmp/pip-K0Ll6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:32 INFO - Running setup.py (path:/tmp/pip-mQOglD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:32 INFO - Running setup.py (path:/tmp/pip-ZROYnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:32 INFO - Running setup.py (path:/tmp/pip-Tpsqp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:32 INFO - Running setup.py (path:/tmp/pip-Fb8QM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:32 INFO - Running setup.py (path:/tmp/pip-ng7KP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:32 INFO - Running setup.py (path:/tmp/pip-GsZzII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:32 INFO - Running setup.py (path:/tmp/pip-YgyUk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:32 INFO - Running setup.py (path:/tmp/pip-fo6zwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:33 INFO - Running setup.py (path:/tmp/pip-ahLoI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:33 INFO - Running setup.py (path:/tmp/pip-0SvLWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:33 INFO - Running setup.py (path:/tmp/pip-y4og1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:33 INFO - Running setup.py (path:/tmp/pip-WD3nAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:33 INFO - Running setup.py (path:/tmp/pip-ZliZdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:33 INFO - Running setup.py (path:/tmp/pip-ALWFaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:33 INFO - Running setup.py (path:/tmp/pip-MxBpnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:33 INFO - Running setup.py install for manifestparser 04:13:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for mozcrash 04:13:33 INFO - Running setup.py install for mozdebug 04:13:33 INFO - Running setup.py install for mozdevice 04:13:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:33 INFO - Running setup.py install for mozfile 04:13:34 INFO - Running setup.py install for mozhttpd 04:13:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for mozinfo 04:13:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for mozInstall 04:13:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for mozleak 04:13:34 INFO - Running setup.py install for mozlog 04:13:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for moznetwork 04:13:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for mozprocess 04:13:34 INFO - Running setup.py install for mozprofile 04:13:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for mozrunner 04:13:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Running setup.py install for mozscreenshot 04:13:35 INFO - Running setup.py install for moztest 04:13:35 INFO - Running setup.py install for mozversion 04:13:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:35 INFO - Cleaning up... 04:13:35 INFO - Return code: 0 04:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 04:13:35 INFO - 'HOME': '/home/cltbld', 04:13:35 INFO - 'LANG': 'en_US.UTF-8', 04:13:35 INFO - 'LANGUAGE': 'en_US:en', 04:13:35 INFO - 'LOGNAME': 'cltbld', 04:13:35 INFO - 'MAIL': '/var/mail/cltbld', 04:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:35 INFO - 'MOZ_NO_REMOTE': '1', 04:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:35 INFO - 'NO_EM_RESTART': '1', 04:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:35 INFO - 'PWD': '/builds/slave/test', 04:13:35 INFO - 'SHELL': '/bin/bash', 04:13:35 INFO - 'SHLVL': '1', 04:13:35 INFO - 'TERM': 'linux', 04:13:35 INFO - 'TMOUT': '86400', 04:13:35 INFO - 'USER': 'cltbld', 04:13:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:35 INFO - '_': '/tools/buildbot/bin/python'} 04:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:35 INFO - Running setup.py (path:/tmp/pip-xcvG63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:35 INFO - Running setup.py (path:/tmp/pip-lpYoyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:35 INFO - Running setup.py (path:/tmp/pip-Wotusn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:35 INFO - Running setup.py (path:/tmp/pip-wY6GMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:35 INFO - Running setup.py (path:/tmp/pip-MqK6BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:35 INFO - Running setup.py (path:/tmp/pip-Qo_AaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:35 INFO - Running setup.py (path:/tmp/pip-4oOJSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:36 INFO - Running setup.py (path:/tmp/pip-KJEtRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:36 INFO - Running setup.py (path:/tmp/pip-uxkjwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:36 INFO - Running setup.py (path:/tmp/pip-G5Qi3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:36 INFO - Running setup.py (path:/tmp/pip-UkbV9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:36 INFO - Running setup.py (path:/tmp/pip-PPNYJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:36 INFO - Running setup.py (path:/tmp/pip-XvN5o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:36 INFO - Running setup.py (path:/tmp/pip-Fu4_2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:36 INFO - Running setup.py (path:/tmp/pip-jAsArr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:36 INFO - Running setup.py (path:/tmp/pip-kTfWcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:36 INFO - Running setup.py (path:/tmp/pip-tE3w4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:38 INFO - Downloading blessings-1.6.tar.gz 04:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:38 INFO - Installing collected packages: blessings 04:13:38 INFO - Running setup.py install for blessings 04:13:38 INFO - Successfully installed blessings 04:13:38 INFO - Cleaning up... 04:13:38 INFO - Return code: 0 04:13:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 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:39 INFO - Reading from file tmpfile_stdout 04:13:39 INFO - Current package versions: 04:13:39 INFO - argparse == 1.2.1 04:13:39 INFO - blessings == 1.6 04:13:39 INFO - blobuploader == 1.2.4 04:13:39 INFO - docopt == 0.6.1 04:13:39 INFO - functools32 == 3.2.3-2 04:13:39 INFO - jsonschema == 2.5.1 04:13:39 INFO - manifestparser == 1.1 04:13:39 INFO - mozInstall == 1.12 04:13:39 INFO - mozcrash == 0.17 04:13:39 INFO - mozdebug == 0.1 04:13:39 INFO - mozdevice == 0.48 04:13:39 INFO - mozfile == 1.2 04:13:39 INFO - mozhttpd == 0.7 04:13:39 INFO - mozinfo == 0.9 04:13:39 INFO - mozleak == 0.1 04:13:39 INFO - mozlog == 3.3 04:13:39 INFO - moznetwork == 0.27 04:13:39 INFO - mozprocess == 0.23 04:13:39 INFO - mozprofile == 0.28 04:13:39 INFO - mozrunner == 6.12 04:13:39 INFO - mozscreenshot == 0.1 04:13:39 INFO - mozsystemmonitor == 0.3 04:13:39 INFO - moztest == 0.7 04:13:39 INFO - mozversion == 1.4 04:13:39 INFO - psutil == 3.1.1 04:13:39 INFO - requests == 1.2.3 04:13:39 INFO - wsgiref == 0.1.2 04:13:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 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 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 04:13:39 INFO - 'HOME': '/home/cltbld', 04:13:39 INFO - 'LANG': 'en_US.UTF-8', 04:13:39 INFO - 'LANGUAGE': 'en_US:en', 04:13:39 INFO - 'LOGNAME': 'cltbld', 04:13:39 INFO - 'MAIL': '/var/mail/cltbld', 04:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:39 INFO - 'MOZ_NO_REMOTE': '1', 04:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:39 INFO - 'NO_EM_RESTART': '1', 04:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:39 INFO - 'PWD': '/builds/slave/test', 04:13:39 INFO - 'SHELL': '/bin/bash', 04:13:39 INFO - 'SHLVL': '1', 04:13:39 INFO - 'TERM': 'linux', 04:13:39 INFO - 'TMOUT': '86400', 04:13:39 INFO - 'USER': 'cltbld', 04:13:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:39 INFO - '_': '/tools/buildbot/bin/python'} 04:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Cleaning up... 04:13:39 INFO - Return code: 0 04:13:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13: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:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', '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:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:39 INFO - Using env: {'DISPLAY': ':0', 04:13:39 INFO - 'HOME': '/home/cltbld', 04:13:39 INFO - 'LANG': 'en_US.UTF-8', 04:13:39 INFO - 'LANGUAGE': 'en_US:en', 04:13:39 INFO - 'LOGNAME': 'cltbld', 04:13:39 INFO - 'MAIL': '/var/mail/cltbld', 04:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:39 INFO - 'MOZ_NO_REMOTE': '1', 04:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:39 INFO - 'NO_EM_RESTART': '1', 04:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:39 INFO - 'PWD': '/builds/slave/test', 04:13:39 INFO - 'SHELL': '/bin/bash', 04:13:39 INFO - 'SHLVL': '1', 04:13:39 INFO - 'TERM': 'linux', 04:13:39 INFO - 'TMOUT': '86400', 04:13:39 INFO - 'USER': 'cltbld', 04:13:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:39 INFO - '_': '/tools/buildbot/bin/python'} 04:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:39 INFO - Cleaning up... 04:13:39 INFO - Return code: 0 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - Running post-action listener: _start_resource_monitoring 04:13:39 INFO - Starting resource monitoring. 04:13:39 INFO - [mozharness: 2016-08-18 11:13:39.594145Z] Finished create-virtualenv step (success) 04:13:39 INFO - [mozharness: 2016-08-18 11:13:39.594626Z] Running install step. 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: install 04:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:39 INFO - Reading from file tmpfile_stdout 04:13:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:39 INFO - Reading from file tmpfile_stdout 04:13:39 INFO - Output received: 04:13:39 INFO - Usage: mozinstall [options] installer 04:13:39 INFO - Options: 04:13:39 INFO - -h, --help show this help message and exit 04:13:39 INFO - -d DEST, --destination=DEST 04:13:39 INFO - Directory to install application into. [default: 04:13:39 INFO - "/builds/slave/test"] 04:13:39 INFO - --app=APP Application being installed. [default: firefox] 04:13:39 INFO - mkdir: /builds/slave/test/build/application 04:13:39 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:39 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.874780Z] Finished install step (success) 04:13:55 INFO - [mozharness: 2016-08-18 11:13:55.875121Z] 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 0x296c570>, '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 0x296d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296d900>, '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:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:55 INFO - Return code: 0 04:13:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:55 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-034', '--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:55 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-034 --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:55 INFO - Using env: {'DISPLAY': ':0', 04:13:55 INFO - 'HOME': '/home/cltbld', 04:13:55 INFO - 'LANG': 'en_US.UTF-8', 04:13:55 INFO - 'LANGUAGE': 'en_US:en', 04:13:55 INFO - 'LOGNAME': 'cltbld', 04:13:55 INFO - 'MAIL': '/var/mail/cltbld', 04:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:55 INFO - 'MOZ_NO_REMOTE': '1', 04:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:55 INFO - 'NO_EM_RESTART': '1', 04:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:55 INFO - 'PWD': '/builds/slave/test', 04:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:55 INFO - 'SHELL': '/bin/bash', 04:13:55 INFO - 'SHLVL': '1', 04:13:55 INFO - 'TERM': 'linux', 04:13:55 INFO - 'TMOUT': '86400', 04:13:55 INFO - 'USER': 'cltbld', 04:13:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232', 04:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:55 INFO - '_': '/tools/buildbot/bin/python'} 04:13:55 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-034', '--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:41237' 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 12692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcQekG/profile http://localhost:41237/getInfo.html) 04:14:00 INFO - PROCESS | 12692 | __metrics Screen width/height:1600/1200 04:14:00 INFO - PROCESS | 12692 | colorDepth:24 04:14:00 INFO - PROCESS | 12692 | Browser inner width/height: 1024/697 04:14:00 INFO - PROCESS | 12692 | __metrics 04:14:01 ERROR - PROCESS | 12692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:14:01 INFO - TEST-INFO | 12692: exit 0 04:14:01 INFO - Browser initialized. 04:14:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:01 INFO - TEST-INFO | started process 12819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcQekG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:13 INFO - PROCESS | 12819 | RSS: Main: 152387584 04:14:13 INFO - PROCESS | 12819 | 04:15:03 INFO - PROCESS | 12819 | 1471518903312 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:11 INFO - PROCESS | 12819 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41237/tests/dromaeo/cssquery-ext.html) 04:17:13 INFO - PROCESS | 12819 | RSS: Main: 156672000 04:17:13 INFO - PROCESS | 12819 | 04:20:15 INFO - PROCESS | 12819 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-ext.html (next: http://localhost:41237/tests/dromaeo/cssquery-jquery.html) 04:20:15 INFO - PROCESS | 12819 | RSS: Main: 153661440 04:20:15 INFO - PROCESS | 12819 | 04:23:17 INFO - PROCESS | 12819 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41237/tests/dromaeo/cssquery-mootools.html) 04:23:18 INFO - PROCESS | 12819 | RSS: Main: 153808896 04:23:18 INFO - PROCESS | 12819 | 04:26:19 INFO - PROCESS | 12819 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41237/tests/dromaeo/cssquery-prototype.html) 04:26:20 INFO - PROCESS | 12819 | RSS: Main: 152526848 04:26:20 INFO - PROCESS | 12819 | 04:29:22 INFO - PROCESS | 12819 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41237/tests/dromaeo/cssquery-yui.html) 04:29:23 INFO - PROCESS | 12819 | RSS: Main: 154996736 04:29:23 INFO - PROCESS | 12819 | 04:32:25 INFO - PROCESS | 12819 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-yui.html (next: http://localhost:41237/tests/dromaeo/cssquery-dojo.html) 04:32:26 INFO - PROCESS | 12819 | RSS: Main: 155090944 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | __start_tp_report 04:32:26 INFO - PROCESS | 12819 | _x_x_mozilla_page_load 04:32:26 INFO - PROCESS | 12819 | _x_x_mozilla_page_load_details 04:32:26 INFO - PROCESS | 12819 | |i|pagename|runs| 04:32:26 INFO - PROCESS | 12819 | |0;dojo.html;3318.1704573856537;3328.201231704392;3328.75034372422;3362.915927101824;3365.5961284645846;5813.476787089161;5891.263592050994;5916.8224953251365;5923.970380148104;5948.226730525031;5882.382349853257;5967.612105213158;5970.134330522083;5977.910331345033;5988.760449582022;5309.548688361494;5356.143017117262;5382.058139825534;5409.891802163955;5461.781528738846;5154.8711282218055;5155.123628983063;5201.661891977028;5234.42421333653;5288.180332048539;5297.735113244342;5324.387695415038;5355.250264962909;5363.195520671891;5399.757010934517;5366.812161574346;5381.650192737459;5395.028894798935;5400.432954539776;5405.837824865261;5069.873253168664;5082.974585127087;5225.08561001827;5318.042752304584;5398.460153984609;5594.4964953154;5717.685527295997;5757.136429535562;5767.077267637158;5822.330432000332;6195.628262304276;6262.436380725757;6276.372362763733;6276.686165691697;6286.994080947026;6062.454379105901;6160.322364539897;6312.116303717483;6312.242530896322;6320.146780184708;5794;5921.822345329604;5923.437273459014;5929.822105336847;5941.940580594182;6476.834169849472;6482.35176482348;6500.447461965691;6503.187101612299;6504.577202481823;5955;6081.452669259699;6148.754049837957;6225.750969961241;6237.407446292595;6155.569110162246;6266.060090986297;6305.653189074553;6310.968445157745;6317.178766760292;6260;6269.404406581368;6279.686015699288;6280.183576135073;6304.148939893147;5946.494547963385;6170.7223174957235;6281.371862813682;6287.717052732638;6301.243850737941;4769;4775.737334446639;4792.976035119802;4806.303086052572;4811.566958973709;4267.466566679165;4280.743155410685;4295.849645262463;4310.030243195256;4320.222359975234;5789.797357092481;5981.401859813984;6055.969720151371;6071.089336599545;6088.939110608926;6381.649009304533;6384.6169229846355;6403.519736019817;6416.615003099829;6427.517936154807;6097.390260973956;6136.325004249529;6142.754289828446;6146.446819786241;6149.077638354193;5051.318072060225;5192.870178245574;5208.427073021964;5228.9738551307;5293.417724050351;6498;6657.3342665733035;6664.233613134455;6665.266820649725;6670.699818508082;6337.271213810471;6394.4564712;6395.168628078506;6406.967965160145;6413.4869210463985;6176.969115154396;6427.83930401725;6584.473242140713;6604.537682362381;6659.866802664016;6127.632342059491;6221.720022599085;6234.501239900706;6238.15784869055;6277.874442511033;6426.839329016625;6431.871362572629;6432.517561183024;6434.742610295536;6436.774712885027;5939.316978547522;6110.649890384283;6198.132261483306;6244;6259.937400625936;6118;6118.47992920589;6120.8730439461915;6152.200213972155;6173.104899789595;6107.4869830629705;6134.110553969738;6147.692615369124;6154.569180157346;6155.784547540815;5886.823395298148;6111.834843226209;6177.382261773787;6208.534359923115;6272.74909003653;5988.520918326436;6127.9837278401355;6128.930927367261;6132.850133029843;6140.4473597376455 04:32:26 INFO - PROCESS | 12819 | |1;ext.html;584.4330998931038;648.3127884442491;659.5251418978334;672.9938741581334;711.4770643576974;40080.198396032065;45325.77337113314;45458.545414545886;45771.31343029857;45998.310025349645;46296.30555541661;46846.297305540356;46872.765636171855;46950;46956.76521617387;9049.3665443419;9093.454392736425;9167.770805729844;9174.816503669923;9178.724638260863;8952.820943581124;9141.5886285117;9162.587683554222;9163.450192988443;9177.449353038839;9145.496997665126;9194.77013074675;9208.907910920905;9233.169014788667;9241.953790231073;9158.129977652112;9184.12750788674;9207.631694732203;9219.86170207444;9227.630894764201;8938.240249578794;9080.77298067547;9103.180713735796;9121.817563648756;9150.03924587922;42981.35527967083;43389.78305108486;43448.78275608633;43519.78240108779;43663;3807.961920380816;4007.5391329997133;4067.5525692173837;4144.316187829005;4675.438947326308;34069;34338.82830585856;34372.6562734372;34643.82678086594;34724.47913281303;4782.593479554242;4833.130036593412;4850.320955066293;4853.538913803219;4887.266909963499;403620;403877;405012;406978;407649;61479.692601536706;62254;62322;62367;62394.0640890387;39396;39914;40042.199156016715;42238.15523689509;65802.67098664476;19194.13626386816;19373.51566210828;19435.514112147026;19461.90269048646;19496;14483.565493035227;14499.92750036243;14508.202048887202;14551.636209094646;14637.194954277616;20738;20941.47646308824;20941.790582094287;20965;20986.47533811667;7426.814329641802;7620.5808680523105;7735.7679269622;7767.417443691633;7798.454108212371;1036.1296510930854;1074.462768615692;1075.1130317488103;1211.2187638972814;1252.311228824143;33845.83077084599;34051.318973620386;34515.13712157216;34938.47592286118;35326.64673353285;1148.075798981811;1177.252444697606;1225.583301677434;1226.3500344817262;1269.796832506813;17830.821691783174;17913.739828513117;18001.10822130488;18007.400712106224;18147.36716465434;624742;629539;631643;632598;633051;43516.3472547912;43697.12605747867;43962.7801860995;43988.78005609952;44064.11871762611;1453.869151776324;1464.6777708904024;1472.7422701027492;1483.0804900961473;1514.1596413990342;33133.83433082916;33560.83219583886;33669.66012503611;33992.15019624529;33998.83000584981;56868.71565642145;57024;57254.42745572491;57276.713616431654;57355.42644573501;506381;507982;509427;509845;509901;28742;28821.855890720413;28890.133296001153;28911.855440722662;29115;52172.73913630407;52905.7354713224;53095.46904530905;54049.72975135099;54332;44573.88565285894;45185.548144518136;45347.31979020251;46005;46950.53049469461;44329.77835110804;46372;46437.174374078226;46675.53324466712;47270.29094563653;38136.618633813305;44177;44261.55738442703;44849.77575112104;44950.55049449464;38399.80800095982;39510;39731;39926.2014759709;40322.991925202106;30001;32324.515132273504;32497.187570309987;32976.505352420216;33034.83482582668 04:32:26 INFO - PROCESS | 12819 | |2;jquery.html;403.2298310227466;411.33774622857175;427.7711424387952;430.5135197227133;430.69420711294987;19999;20991.68512472312;21861.125554977803;21920.780792192072;22056.117755289768;16836.83163168368;20080.59838803223;20556.588868222625;20724.585508289863;21336.253231136914;5241.633085684004;5567.415421380758;5571.804986825462;5575.0522411189995;5578.107502799553;5454.863628409302;5577.776888924458;5606.831795046155;5945.256842894638;6144.293406258271;6243.56295059346;6263.655498947556;6294.24469063713;6309.652969086698;6318.083877837711;6086.239220097488;6149.200603921461;6173.166622505949;6214.285357183937;6308.495320374359;5878.735456904406;6052.485538729214;6055.848603784896;6057.636541807506;6060.515158787286;25177;25260.115895943552;25316.367090822692;25657.486850263078;25933.092341767948;2502.1117503286255;2524.709658389272;2694.1513423271804;2732.385213327005;2885.7258560436726;10641.946790266;10898.346099234072;11148.498317575648;11175;11335;1845.9538511537185;2009.156154415149;2018.5155562665002;2024.7469066366705;2095.1409921932086;90077.09922900752;90276;90430;91827.08172918252;92197.5390123045;11875.28748275089;12045.939770301267;12095.395230238453;12251.877481225252;12278.32469214184;16648.500544983668;16660.08369539687;16867.493975180765;17100.14499275056;17113;7108.431325493948;7245.565266083946;8872.911270887338;8988.14612611814;8999.82000359989;8873.334499912533;8904.24313933323;8988.32587555936;9235.953820230856;9252;5046.949530504721;5107.412647545506;5121.359830021247;5157.974210128926;5324.41431442541;2024.8481363897472;2125.851190416656;2133.605283022646;2142.625040617917;2179.1719146724145;980.8185485685028;1015.223354134088;1018.1193267823279;1039.6309310194922;1143.7197886517856;20303.796962030487;21274.468138296666;21307.78692213089;21341.78658213429;21440.78559214388;1049.9842502362471;1052.1898138433364;1069.2248120112856;1101.779644071189;1133.7505748735266;11716.70708232301;11759.764804703858;11885.940570297093;11994.580189693319;12024.639260822189;499030;505929;506379;508198;521797;91199;92225;96511.51744241374;102953;103221;1013.4071568132578;1044.7492601775518;1056.984145237822;1058.6241884131177;1065.733566608348;19382.515437114183;19563.608727825078;19642.41072767762;19800.108995095543;19817.306394276133;45460.54539454563;46548.53451465442;48193.518064818905;48819;49481;67170.66414668091;67531.3246867525;67618;68489.3151068483;68851.96722049073;6010.819675409744;6692;9162.037986011639;9428.811423771624;9472.289578281794;13647.044706870822;13925.791113133513;14314.928425357806;14487.348069336695;14494.565163045125;11681.415929203677;11729.120315976164;11891.167618266983;11919.702007449883;12721.491140354652;11764.058875289786;12192.634220973385;12394.3183124929;12780.744385112059;12912.612621621367;12222.266664000188;12451.377431128589;12722.427490762753;12728.23630582168;12794.552190673281;9249.676261330822;9302.302327325342;9440.489521676498;9538.332316737762;9541.093596108358;10292.639757608447;11854.585089521825;12144.392780361124;12155.81766273489;12201.450934708137 04:32:26 INFO - PROCESS | 12819 | |3;mootools.html;1579.5182469346848;1626.3575887524428;1807.3583877723408;1844.400569814809;1897.3833504111167;8655.653773849039;9148.771280717985;9356.01761815009;10120;10127.037931396524;9232.815343693122;9415.058494150582;9566.856497152548;9617.663381781638;9661.710148695533;2510.548101341758;2534.8352357096824;2538.213153922281;2540.1236573382153;2559.321779728364;2462.384403899025;2527.3428908483834;2548.1336345642476;2553.157458038843;2555.297293244354;2567.14000809729;2570.2160840943507;2603.4532748122824;2610.6214598883244;2612.294680436281;2508.134693530738;2530.101813856073;2533.759292867184;2562.884670189846;2565.8332208406396;2496.7253602103756;2501.837380570257;2502.174282486775;2514.9497010059695;2538.1243471002476;9777.90222097777;9800.803983920354;9808.411495310233;9823.214142868554;9848.852267215998;5746.913796293059;5832.125181222808;5875.618084824473;5891.086881533369;5895.941040589625;3638.07229156566;3702.8703995360033;3735.62643735627;3799.3146647751637;3841.4045822897497;1151.2862025544216;1156.115571587736;1165.5279611757253;1241.9130660853743;1242.372601836076;13514.32428378577;13684.794728079087;13706.903447724158;13767.724645507034;13811.17132972025;4986.601071914238;5244.475552444725;5257.290265814143;5262.394824595221;5303.867403314948;11901.583444579399;11916.76166476683;11948.402579871146;11987.460564274628;12032.097592680584;5889.646621202742;5906.173135760997;5907.172995780594;5921.851953701106;5929.555283353766;4819.132556139928;5237.8428647140645;5283.524482796567;5299.072662284085;5381.112116500812;4424.646028317727;4459.487158976759;4461.888452788707;4546.386237857847;4620.353150558924;1404.6067101211677;1450.724362371146;1465.1794994802945;1465.2234315812423;1468.0237641968185;868.2966796894409;884.6682494064726;990.945497997617;1021.1473419694489;1024.626011505795;6334.461570766444;6491.578047426902;6610.471162307004;6675.037869728119;6677.098591690156;468.20405310971483;475.0167153991205;1021.99489002556;1125.4935279124263;1139.1058019454854;4407.294832826732;4416.1609294233995;4469.396631454712;4618.838340658061;4645.39609850724;11441.485133169028;11832.645020649394;12339.568115115928;12385.071119666061;12404.75190496185;11813.11401644863;12265.754684906253;12323.568675096329;12350.876491235153;12402.317872517098;8744.169303916118;8811.691590794291;8819.779505512286;8849.292056635453;8925.821483570293;6289.685515724104;6458.354164583504;6494.155759751202;6545.934540654723;6640.269570347161;10577;11055.557777688802;11117.16621253393;11156.553737850396;11191.44042797873;10435.32170408921;11248.437578120898;11428.25716328436;11443.885561144281;11562.364069976233;7779.183185765413;7908.327792137733;8046.87929681067;8075.636596353295;8499.277561407349;9488;9542.284328675516;9543.618255269712;9549.9045009549;9580.712578622653;8206.507609543447;8370.707025254087;8407.2433480987;8457.323414126979;8515.787105322417;8221.54781487024;8324.6670133194;8366.163383661586;8378.078411374621;8474.491530508189;7910.52536847791;7923.20767923203;7955.24425179607;8011.439199255996;8039.758807235792;5524.530414914777;5722.998475266895;5729.68486733217;5812.3025236971835;5865.765369385177;5631.577631677558;5728.856778580569;5777.22007528995;5883.441073098049;5902.734376952962 04:32:26 INFO - PROCESS | 12819 | |4;prototype.html;343.685527742116;348.0428820742957;348.39205586251995;350.0688169469212;352.3006831439592;5734.827955161341;5809.912851307228;5820.759007782008;5824.708764561776;5867.7066146692705;5759.416160555838;5773.422657734224;5787.363390027104;5799.101139323411;5806.245188125537;4111.321631930736;4454.866354009385;4480.775961201944;4497.415336006315;4499.1451624191295;4472.955270447303;4477.507474177838;4484.4842843072975;4485;4497.53830005248;4476.507584165739;4493.438320209973;4495.348174514694;4497.685162038659;4513.255312873388;4331.9783401083105;4414.933775993362;4444.866654000369;4454.643628509712;4473.552644735533;3978.1049263915675;3980.1840622672285;3990.1421194443333;3992.4210989406374;4009.8797036088963;5646.6894320812335;5647.491725744702;5693.868372395166;5706;5708.857278568069;4991.82855457877;5180.922286165711;5191.118928994407;5191.402988656278;5197.480251974772;6084.205159477965;6096.359882212392;6106.908396374058;6109.786157484511;6112.205413296288;4320.935185972213;4371.344298355272;4407.625351845097;4438.711483753578;4439.289713645833;6211.844703882394;6240.719167637421;6258.186435763367;6268.749250030039;6302.46429053531;4448.866534003985;4450.5104438511735;4472.955270447319;4491.955080449219;4495.595396414338;4402.823887044547;4539.6368290536675;4550.977245113753;4560.156371071363;4561.384213131185;5101.948980510221;5173.456787037307;5179.792808287626;5180.326557547494;5185.274061631375;6106.328303886569;6157.275962730443;6161.7227224775;6180.47465965389;6186.876262474725;1525.9313330900136;1543.2592355669117;1573.8819588530905;1576.8896177267711;1580.1151355240872;998.1465846701111;998.3760149906309;1034.5189486888632;1054.583439541377;1063.7659714862718;5820;5849.94150058494;5885.852853678693;5896.587238893322;5950.72710009493;6239.875202496016;6262.405071518198;6267.2479302484;6337.714802833883;6346.143270658402;5678.290213723285;5833.82498525045;5899.911501327398;5900.20347253124;5917.142014407973;3330.4504756715355;3356.2280675444786;3387.187075101958;3390.7456940729544;3393.1846462142635;6228.318354044382;6448.806535803933;6476.579022363531;6506;6515.413612774873;6446.548741588138;6481.513886458534;6507.251666058369;6515.153030106056;6571.178602674666;6332.4934005279465;6464.935350646528;6532.836679082966;6629.237637671633;6657.933420665829;6255.343188965275;6302.590331628429;6347.365263473615;6382.234131904202;6425.58233714807;6079.270487541523;6294.4964402846745;6298.905516417349;6304.211973503312;6328.208973878265;6500.70746816385;6506.219253689587;6520.53288010194;6559.639219842955;6561.114249576437;4444.599986001275;4482.843100491467;4497;4500.9099818004115;4503.324501324828;6177.660228687465;6327.651979141007;6342.302346741762;6419.293877673359;6454.838629034311;6172.22847144107;6204.7828326008375;6218.5647004709235;6219.47134493555;6242.906356404748;5984.790532331347;6092.69536523181;6124.816255512342;6171.166892469639;6182.536309776695;5926.703664816656;5985.581009329305;6100.633961962297;6131.356207598316;6141.201643786279;6202.844928876814;6207.937920620736;6222.751089956351;6261.96869015652;6291.150694656163;5953;6107.297660768891;6112.930237208382;6127.325994140552;6139.26328840542 04:32:26 INFO - PROCESS | 12819 | |5;yui.html;779.4271210660164;806.8663527743519;817.272627361648;851.3529717414765;917.9311551633629;13908.860911390882;14714.190719510423;17210.225539850704;17698.38055668052;17702.64594708105;15337;15542.68914621707;15548.922255388707;15594.376224951016;15598.922005389957;887.0818702642766;909.8635204719279;919.9494027828467;921.2767977137948;922.2207234886511;910.0444533240104;914.3416739947228;918.609590923858;922.0963455813308;922.6032805893464;977.1498796047449;979.56409397818;979.8236317462854;979.9069088436587;985.344745744083;968.428627110005;972.4408465132577;972.751948253198;973.9513024348789;974.1135566634364;716.1907045039072;716.2837162837163;716.9211386747454;716.9856602867966;718.4575645387699;16904.746428803577;17032.318707251696;17052.744208836877;17122.229499672543;17143.314267429287;16402.09788461634;16419.86149639772;16498.767522346487;16696.165191740485;16965.491035268962;13527;13889.236092014935;13959.441622335095;13979.23114228717;14178.929105354511;4114.753114813091;4124.319487284594;4165.500139983191;4188.895277618053;4271.103068355649;92000.53999729958;92066.5396673019;92513.53743231308;94337.52831235869;95952.52023739976;11474.139439542068;11541.422928853524;12084.79152084802;12143.332116733487;12294.569690060984;24632.13787517464;24778.876105619718;24863.5027299453;25000;25138.12016579411;8887.688930887389;8985.281177505914;9044.683436079706;9177.08229177077;9234.261259099256;4907.68100073494;5013.824516141917;5085.364329458817;5177.404598471148;5256.816011439581;3890.2025084857537;4023.839046438168;4028.254772867029;4030.0730831908827;4036.5357983832237;699.4264702943537;728.7048745258179;747.2676776758807;752.8531936272484;760.2663429790279;764.6253335865497;838.3125836813754;848.8481698893276;854.7563944275852;863.3611127765408;10408.375497470177;11157.776844463066;11315.60395386174;11551.595694150665;11653;774.7172282116986;788.8027993001749;791.8574656561874;795.8090058385945;802.4583406200791;4878.365812444359;4978.128827455181;5006.1739812930455;5037.874053148701;5106.131957567222;76825.6158719214;80050.19949800428;106220;126688.36655816661;140743;92433;118895;119254;121401;121851.39074304572;96545;99614;101098.49450752846;104743;111172.99999999838;9456.763580910532;9528.094830991045;9555.426674399558;9642.180414664832;9655.758606034906;59419.702901485216;59534;60205.39794601998;60213;60543.69728151507;51418.228726569876;65408;85254.57372713096;88009;89192.5540372294;13520.526781562598;13701.109427887155;13715.314234288446;13756.724865502834;13989;14929.925350373178;15338.923305383401;16040.358385664442;16260.756088658916;16381.836181638031;13525.18848869071;13617.863821362056;14046.48987046355;14208.076475029504;14451.92774036123;13280.468781248643;13414.061015728805;13604.183748974698;14011.299435028412;14244.943169911272;14328.71342573122;14362.425502979764;14365.92817035908;14478;14572.708545829237;11560;11797.29216247028;12088.51645934188;12130.090243231616;12226.20529665569;11910.344931028876;11992.672137739744;12087.214331068453;12118.272903625812;12188.878111218773 04:32:26 INFO - PROCESS | 12819 | __end_tp_report 04:32:26 INFO - PROCESS | 12819 | __start_cc_report 04:32:26 INFO - PROCESS | 12819 | _x_x_mozilla_cycle_collect,318 04:32:26 INFO - PROCESS | 12819 | __end_cc_report 04:32:26 INFO - PROCESS | 12819 | __startTimestamp1471519946173__endTimestamp 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | ------- Summary: start ------- 04:32:26 INFO - PROCESS | 12819 | Number of tests: 6 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | [#0] dojo.html Cycles:165 Average:5844.95 Median:6118.48 stddev:695.09 (11.4%) stddev-sans-first:668.36 04:32:26 INFO - PROCESS | 12819 | Values: 3318.2 3328.2 3328.8 3362.9 3365.6 5813.5 5891.3 5916.8 5924.0 5948.2 5882.4 5967.6 5970.1 5977.9 5988.8 5309.5 5356.1 5382.1 5409.9 5461.8 5154.9 5155.1 5201.7 5234.4 5288.2 5297.7 5324.4 5355.3 5363.2 5399.8 5366.8 5381.7 5395.0 5400.4 5405.8 5069.9 5083.0 5225.1 5318.0 5398.5 5594.5 5717.7 5757.1 5767.1 5822.3 6195.6 6262.4 6276.4 6276.7 6287.0 6062.5 6160.3 6312.1 6312.2 6320.1 5794.0 5921.8 5923.4 5929.8 5941.9 6476.8 6482.4 6500.4 6503.2 6504.6 5955.0 6081.5 6148.8 6225.8 6237.4 6155.6 6266.1 6305.7 6311.0 6317.2 6260.0 6269.4 6279.7 6280.2 6304.1 5946.5 6170.7 6281.4 6287.7 6301.2 4769.0 4775.7 4793.0 4806.3 4811.6 4267.5 4280.7 4295.8 4310.0 4320.2 5789.8 5981.4 6056.0 6071.1 6088.9 6381.6 6384.6 6403.5 6416.6 6427.5 6097.4 6136.3 6142.8 6146.4 6149.1 5051.3 5192.9 5208.4 5229.0 5293.4 6498.0 6657.3 6664.2 6665.3 6670.7 6337.3 6394.5 6395.2 6407.0 6413.5 6177.0 6427.8 6584.5 6604.5 6659.9 6127.6 6221.7 6234.5 6238.2 6277.9 6426.8 6431.9 6432.5 6434.7 6436.8 5939.3 6110.6 6198.1 6244.0 6259.9 6118.0 6118.5 6120.9 6152.2 6173.1 6107.5 6134.1 6147.7 6154.6 6155.8 5886.8 6111.8 6177.4 6208.5 6272.7 5988.5 6128.0 6128.9 6132.9 6140.4 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | [#1] ext.html Cycles:180 Average:67199.44 Median:44219.28 stddev:139125.86 (314.6%) stddev-sans-first:139426.24 04:32:26 INFO - PROCESS | 12819 | Values: 584.4 648.3 659.5 673.0 711.5 40080.2 45325.8 45458.5 45771.3 45998.3 46296.3 46846.3 46872.8 46950.0 46956.8 9049.4 9093.5 9167.8 9174.8 9178.7 8952.8 9141.6 9162.6 9163.5 9177.4 9145.5 9194.8 9208.9 9233.2 9242.0 9158.1 9184.1 9207.6 9219.9 9227.6 8938.2 9080.8 9103.2 9121.8 9150.0 42981.4 43389.8 43448.8 43519.8 43663.0 3808.0 4007.5 4067.6 4144.3 4675.4 34069.0 34338.8 34372.7 34643.8 34724.5 4782.6 4833.1 4850.3 4853.5 4887.3 403620.0 403877.0 405012.0 406978.0 407649.0 61479.7 62254.0 62322.0 62367.0 62394.1 39396.0 39914.0 40042.2 42238.2 65802.7 19194.1 19373.5 19435.5 19461.9 19496.0 14483.6 14499.9 14508.2 14551.6 14637.2 20738.0 20941.5 20941.8 20965.0 20986.5 7426.8 7620.6 7735.8 7767.4 7798.5 1036.1 1074.5 1075.1 1211.2 1252.3 33845.8 34051.3 34515.1 34938.5 35326.6 1148.1 1177.3 1225.6 1226.4 1269.8 17830.8 17913.7 18001.1 18007.4 18147.4 624742.0 629539.0 631643.0 632598.0 633051.0 43516.3 43697.1 43962.8 43988.8 44064.1 1453.9 1464.7 1472.7 1483.1 1514.2 33133.8 33560.8 33669.7 33992.2 33998.8 56868.7 57024.0 57254.4 57276.7 57355.4 506381.0 507982.0 509427.0 509845.0 509901.0 28742.0 28821.9 28890.1 28911.9 29115.0 52172.7 52905.7 53095.5 54049.7 54332.0 44573.9 45185.5 45347.3 46005.0 46950.5 44329.8 46372.0 46437.2 46675.5 47270.3 38136.6 44177.0 44261.6 44849.8 44950.6 38399.8 39510.0 39731.0 39926.2 40323.0 30001.0 32324.5 32497.2 32976.5 33034.8 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | [#2] jquery.html Cycles:180 Average:30958.98 Median:12279.11 stddev:84047.43 (684.5%) stddev-sans-first:84251.89 04:32:26 INFO - PROCESS | 12819 | Values: 403.2 411.3 427.8 430.5 430.7 19999.0 20991.7 21861.1 21920.8 22056.1 16836.8 20080.6 20556.6 20724.6 21336.3 5241.6 5567.4 5571.8 5575.1 5578.1 5454.9 5577.8 5606.8 5945.3 6144.3 6243.6 6263.7 6294.2 6309.7 6318.1 6086.2 6149.2 6173.2 6214.3 6308.5 5878.7 6052.5 6055.8 6057.6 6060.5 25177.0 25260.1 25316.4 25657.5 25933.1 2502.1 2524.7 2694.2 2732.4 2885.7 10641.9 10898.3 11148.5 11175.0 11335.0 1846.0 2009.2 2018.5 2024.7 2095.1 90077.1 90276.0 90430.0 91827.1 92197.5 11875.3 12045.9 12095.4 12251.9 12278.3 16648.5 16660.1 16867.5 17100.1 17113.0 7108.4 7245.6 8872.9 8988.1 8999.8 8873.3 8904.2 8988.3 9236.0 9252.0 5046.9 5107.4 5121.4 5158.0 5324.4 2024.8 2125.9 2133.6 2142.6 2179.2 980.8 1015.2 1018.1 1039.6 1143.7 20303.8 21274.5 21307.8 21341.8 21440.8 1050.0 1052.2 1069.2 1101.8 1133.8 11716.7 11759.8 11885.9 11994.6 12024.6 499030.0 505929.0 506379.0 508198.0 521797.0 91199.0 92225.0 96511.5 102953.0 103221.0 1013.4 1044.7 1057.0 1058.6 1065.7 19382.5 19563.6 19642.4 19800.1 19817.3 45460.5 46548.5 48193.5 48819.0 49481.0 67170.7 67531.3 67618.0 68489.3 68852.0 6010.8 6692.0 9162.0 9428.8 9472.3 13647.0 13925.8 14314.9 14487.3 14494.6 11681.4 11729.1 11891.2 11919.7 12721.5 11764.1 12192.6 12394.3 12780.7 12912.6 12222.3 12451.4 12722.4 12728.2 12794.6 9249.7 9302.3 9440.5 9538.3 9541.1 10292.6 11854.6 12144.4 12155.8 12201.5 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | [#3] mootools.html Cycles:180 Average:6404.01 Median:4632.87 stddev:3670.15 (79.2%) stddev-sans-first:3662.53 04:32:26 INFO - PROCESS | 12819 | Values: 1579.5 1626.4 1807.4 1844.4 1897.4 8655.7 9148.8 9356.0 10120.0 10127.0 9232.8 9415.1 9566.9 9617.7 9661.7 2510.5 2534.8 2538.2 2540.1 2559.3 2462.4 2527.3 2548.1 2553.2 2555.3 2567.1 2570.2 2603.5 2610.6 2612.3 2508.1 2530.1 2533.8 2562.9 2565.8 2496.7 2501.8 2502.2 2514.9 2538.1 9777.9 9800.8 9808.4 9823.2 9848.9 5746.9 5832.1 5875.6 5891.1 5895.9 3638.1 3702.9 3735.6 3799.3 3841.4 1151.3 1156.1 1165.5 1241.9 1242.4 13514.3 13684.8 13706.9 13767.7 13811.2 4986.6 5244.5 5257.3 5262.4 5303.9 11901.6 11916.8 11948.4 11987.5 12032.1 5889.6 5906.2 5907.2 5921.9 5929.6 4819.1 5237.8 5283.5 5299.1 5381.1 4424.6 4459.5 4461.9 4546.4 4620.4 1404.6 1450.7 1465.2 1465.2 1468.0 868.3 884.7 990.9 1021.1 1024.6 6334.5 6491.6 6610.5 6675.0 6677.1 468.2 475.0 1022.0 1125.5 1139.1 4407.3 4416.2 4469.4 4618.8 4645.4 11441.5 11832.6 12339.6 12385.1 12404.8 11813.1 12265.8 12323.6 12350.9 12402.3 8744.2 8811.7 8819.8 8849.3 8925.8 6289.7 6458.4 6494.2 6545.9 6640.3 10577.0 11055.6 11117.2 11156.6 11191.4 10435.3 11248.4 11428.3 11443.9 11562.4 7779.2 7908.3 8046.9 8075.6 8499.3 9488.0 9542.3 9543.6 9549.9 9580.7 8206.5 8370.7 8407.2 8457.3 8515.8 8221.5 8324.7 8366.2 8378.1 8474.5 7910.5 7923.2 7955.2 8011.4 8039.8 5524.5 5723.0 5729.7 5812.3 5865.8 5631.6 5728.9 5777.2 5883.4 5902.7 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | [#4] prototype.html Cycles:180 Average:5159.99 Median:5858.82 stddev:1534.00 (26.2%) stddev-sans-first:1495.10 04:32:26 INFO - PROCESS | 12819 | Values: 343.7 348.0 348.4 350.1 352.3 5734.8 5809.9 5820.8 5824.7 5867.7 5759.4 5773.4 5787.4 5799.1 5806.2 4111.3 4454.9 4480.8 4497.4 4499.1 4473.0 4477.5 4484.5 4485.0 4497.5 4476.5 4493.4 4495.3 4497.7 4513.3 4332.0 4414.9 4444.9 4454.6 4473.6 3978.1 3980.2 3990.1 3992.4 4009.9 5646.7 5647.5 5693.9 5706.0 5708.9 4991.8 5180.9 5191.1 5191.4 5197.5 6084.2 6096.4 6106.9 6109.8 6112.2 4320.9 4371.3 4407.6 4438.7 4439.3 6211.8 6240.7 6258.2 6268.7 6302.5 4448.9 4450.5 4473.0 4492.0 4495.6 4402.8 4539.6 4551.0 4560.2 4561.4 5101.9 5173.5 5179.8 5180.3 5185.3 6106.3 6157.3 6161.7 6180.5 6186.9 1525.9 1543.3 1573.9 1576.9 1580.1 998.1 998.4 1034.5 1054.6 1063.8 5820.0 5849.9 5885.9 5896.6 5950.7 6239.9 6262.4 6267.2 6337.7 6346.1 5678.3 5833.8 5899.9 5900.2 5917.1 3330.5 3356.2 3387.2 3390.7 3393.2 6228.3 6448.8 6476.6 6506.0 6515.4 6446.5 6481.5 6507.3 6515.2 6571.2 6332.5 6464.9 6532.8 6629.2 6657.9 6255.3 6302.6 6347.4 6382.2 6425.6 6079.3 6294.5 6298.9 6304.2 6328.2 6500.7 6506.2 6520.5 6559.6 6561.1 4444.6 4482.8 4497.0 4500.9 4503.3 6177.7 6327.7 6342.3 6419.3 6454.8 6172.2 6204.8 6218.6 6219.5 6242.9 5984.8 6092.7 6124.8 6171.2 6182.5 5926.7 5985.6 6100.6 6131.4 6141.2 6202.8 6207.9 6222.8 6262.0 6291.2 5953.0 6107.3 6112.9 6127.3 6139.3 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - PROCESS | 12819 | [#5] yui.html Cycles:180 Average:22786.03 Median:4119.54 stddev:33044.10 (802.1%) stddev-sans-first:33095.48 04:32:26 INFO - PROCESS | 12819 | Values: 779.4 806.9 817.3 851.4 917.9 13908.9 14714.2 17210.2 17698.4 17702.6 15337.0 15542.7 15548.9 15594.4 15598.9 887.1 909.9 919.9 921.3 922.2 910.0 914.3 918.6 922.1 922.6 977.1 979.6 979.8 979.9 985.3 968.4 972.4 972.8 974.0 974.1 716.2 716.3 716.9 717.0 718.5 16904.7 17032.3 17052.7 17122.2 17143.3 16402.1 16419.9 16498.8 16696.2 16965.5 13527.0 13889.2 13959.4 13979.2 14178.9 4114.8 4124.3 4165.5 4188.9 4271.1 92000.5 92066.5 92513.5 94337.5 95952.5 11474.1 11541.4 12084.8 12143.3 12294.6 24632.1 24778.9 24863.5 25000.0 25138.1 8887.7 8985.3 9044.7 9177.1 9234.3 4907.7 5013.8 5085.4 5177.4 5256.8 3890.2 4023.8 4028.3 4030.1 4036.5 699.4 728.7 747.3 752.9 760.3 764.6 838.3 848.8 854.8 863.4 10408.4 11157.8 11315.6 11551.6 11653.0 774.7 788.8 791.9 795.8 802.5 4878.4 4978.1 5006.2 5037.9 5106.1 76825.6 80050.2 106220.0 126688.4 140743.0 92433.0 118895.0 119254.0 121401.0 121851.4 96545.0 99614.0 101098.5 104743.0 111173.0 9456.8 9528.1 9555.4 9642.2 9655.8 59419.7 59534.0 60205.4 60213.0 60543.7 51418.2 65408.0 85254.6 88009.0 89192.6 13520.5 13701.1 13715.3 13756.7 13989.0 14929.9 15338.9 16040.4 16260.8 16381.8 13525.2 13617.9 14046.5 14208.1 14451.9 13280.5 13414.1 13604.2 14011.3 14244.9 14328.7 14362.4 14365.9 14478.0 14572.7 11560.0 11797.3 12088.5 12130.1 12226.2 11910.3 11992.7 12087.2 12118.3 12188.9 04:32:26 INFO - PROCESS | 12819 | -------- Summary: end -------- 04:32:26 INFO - PROCESS | 12819 | 04:32:26 INFO - TEST-INFO | 12819: exit 0 04:32:26 INFO - TEST-OK | dromaeo_css | took 1110755ms 04:32:26 INFO - TEST-START | kraken 04:32:26 INFO - operating with platform_type : linux_ 04:32:26 INFO - Initialising browser for kraken test... 04:32:26 INFO - TEST-INFO | started process 13083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTuL4uc/profile http://localhost:41237/getInfo.html) 04:32:31 INFO - PROCESS | 13083 | __metrics Screen width/height:1600/1200 04:32:31 INFO - PROCESS | 13083 | colorDepth:24 04:32:31 INFO - PROCESS | 13083 | Browser inner width/height: 1024/697 04:32:31 INFO - PROCESS | 13083 | __metrics 04:32:31 ERROR - PROCESS | 13083 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:32:32 INFO - TEST-INFO | 13083: exit 0 04:32:32 INFO - Browser initialized. 04:32:32 INFO - Running cycle 1/1 for kraken test... 04:32:32 INFO - TEST-INFO | started process 13208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTuL4uc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:44 INFO - PROCESS | 13208 | RSS: Main: 152485888 04:32:44 INFO - PROCESS | 13208 | 04:32:47 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:47 INFO - PROCESS | 13208 | RSS: Main: 157700096 04:32:47 INFO - PROCESS | 13208 | 04:32:50 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-dft) 04:32:51 INFO - PROCESS | 13208 | RSS: Main: 156270592 04:32:51 INFO - PROCESS | 13208 | 04:32:53 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-fft) 04:32:54 INFO - PROCESS | 13208 | RSS: Main: 156917760 04:32:54 INFO - PROCESS | 13208 | 04:32:56 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-oscillator) 04:32:57 INFO - PROCESS | 13208 | RSS: Main: 156708864 04:32:57 INFO - PROCESS | 13208 | 04:32:59 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:00 INFO - PROCESS | 13208 | RSS: Main: 157229056 04:33:00 INFO - PROCESS | 13208 | 04:33:03 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41237/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:03 INFO - PROCESS | 13208 | RSS: Main: 156348416 04:33:03 INFO - PROCESS | 13208 | 04:33:07 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41237/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:07 INFO - PROCESS | 13208 | RSS: Main: 156663808 04:33:07 INFO - PROCESS | 13208 | 04:33:10 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41237/tests/kraken/driver.html?testName=json-parse-financial) 04:33:11 INFO - PROCESS | 13208 | RSS: Main: 157175808 04:33:11 INFO - PROCESS | 13208 | 04:33:12 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:13 INFO - PROCESS | 13208 | RSS: Main: 157564928 04:33:13 INFO - PROCESS | 13208 | 04:33:15 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:15 INFO - PROCESS | 13208 | RSS: Main: 156438528 04:33:15 INFO - PROCESS | 13208 | 04:33:17 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:18 INFO - PROCESS | 13208 | RSS: Main: 156590080 04:33:18 INFO - PROCESS | 13208 | 04:33:21 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:21 INFO - PROCESS | 13208 | RSS: Main: 156610560 04:33:21 INFO - PROCESS | 13208 | 04:33:24 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:25 INFO - PROCESS | 13208 | RSS: Main: 157360128 04:33:25 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41237/tests/kraken/driver.html?testName=ai-astar) 04:33:26 INFO - PROCESS | 13208 | RSS: Main: 158425088 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | __start_tp_report 04:33:26 INFO - PROCESS | 13208 | _x_x_mozilla_page_load 04:33:26 INFO - PROCESS | 13208 | _x_x_mozilla_page_load_details 04:33:26 INFO - PROCESS | 13208 | |i|pagename|runs| 04:33:26 INFO - PROCESS | 13208 | |0;ai-astar;99;112;105;108;109;110;112;112;111;110 04:33:26 INFO - PROCESS | 13208 | |1;audio-beat-detection;142;117;147;179;122;147;147;118;180;117 04:33:26 INFO - PROCESS | 13208 | |2;audio-dft;162;161;163;162;163;164;163;166;162;162 04:33:26 INFO - PROCESS | 13208 | |3;audio-fft;76;77;76;182;78;76;75;77;162;76 04:33:26 INFO - PROCESS | 13208 | |4;audio-oscillator;83;84;143;84;83;83;141;83;84;130 04:33:26 INFO - PROCESS | 13208 | |5;imaging-gaussian-blur;117;117;117;121;117;118;119;118;117;116 04:33:26 INFO - PROCESS | 13208 | |6;imaging-darkroom;147;147;146;147;146;147;147;147;146;146 04:33:26 INFO - PROCESS | 13208 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;96;96 04:33:26 INFO - PROCESS | 13208 | |8;json-parse-financial;53;53;51;55;52;56;53;53;53;61 04:33:26 INFO - PROCESS | 13208 | |9;json-stringify-tinderbox;60;60;59;61;63;60;59;59;60;60 04:33:26 INFO - PROCESS | 13208 | |10;stanford-crypto-aes;78;72;75;74;73;73;73;73;72;72 04:33:26 INFO - PROCESS | 13208 | |11;stanford-crypto-ccm;118;123;123;117;118;124;120;117;155;128 04:33:26 INFO - PROCESS | 13208 | |12;stanford-crypto-pbkdf2;161;156;166;153;157;156;153;153;157;154 04:33:26 INFO - PROCESS | 13208 | |13;stanford-crypto-sha256-iterative;62;63;67;68;61;65;62;61;64;63 04:33:26 INFO - PROCESS | 13208 | __end_tp_report 04:33:26 INFO - PROCESS | 13208 | __start_cc_report 04:33:26 INFO - PROCESS | 13208 | _x_x_mozilla_cycle_collect,866 04:33:26 INFO - PROCESS | 13208 | __end_cc_report 04:33:26 INFO - PROCESS | 13208 | __startTimestamp1471520006923__endTimestamp 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | ------- Summary: start ------- 04:33:26 INFO - PROCESS | 13208 | Number of tests: 14 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.50 stddev:4.08 (3.7%) stddev-sans-first:2.32 04:33:26 INFO - PROCESS | 13208 | Values: 99.0 112.0 105.0 108.0 109.0 110.0 112.0 112.0 111.0 110.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:147.00 stddev:23.83 (16.2%) stddev-sans-first:25.28 04:33:26 INFO - PROCESS | 13208 | Values: 142.0 117.0 147.0 179.0 122.0 147.0 147.0 118.0 180.0 117.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 04:33:26 INFO - PROCESS | 13208 | Values: 162.0 161.0 163.0 162.0 163.0 164.0 163.0 166.0 162.0 162.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:40.60 (53.4%) stddev-sans-first:42.45 04:33:26 INFO - PROCESS | 13208 | Values: 76.0 77.0 76.0 182.0 78.0 76.0 75.0 77.0 162.0 76.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:83.00 stddev:26.57 (32.0%) stddev-sans-first:27.48 04:33:26 INFO - PROCESS | 13208 | Values: 83.0 84.0 143.0 84.0 83.0 83.0 141.0 83.0 84.0 130.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.50 stddev:1.42 (1.2%) stddev-sans-first:1.48 04:33:26 INFO - PROCESS | 13208 | Values: 117.0 117.0 117.0 121.0 117.0 118.0 119.0 118.0 117.0 116.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:33:26 INFO - PROCESS | 13208 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:33:26 INFO - PROCESS | 13208 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.00 stddev:2.83 (5.3%) stddev-sans-first:2.98 04:33:26 INFO - PROCESS | 13208 | Values: 53.0 53.0 51.0 55.0 52.0 56.0 53.0 53.0 53.0 61.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.20 (2.0%) stddev-sans-first:1.27 04:33:26 INFO - PROCESS | 13208 | Values: 60.0 60.0 59.0 61.0 63.0 60.0 59.0 59.0 60.0 60.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.00 stddev:1.84 (2.5%) stddev-sans-first:1.00 04:33:26 INFO - PROCESS | 13208 | Values: 78.0 72.0 75.0 74.0 73.0 73.0 73.0 73.0 72.0 72.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:123.00 stddev:11.37 (9.2%) stddev-sans-first:11.83 04:33:26 INFO - PROCESS | 13208 | Values: 118.0 123.0 123.0 117.0 118.0 124.0 120.0 117.0 155.0 128.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:156.50 stddev:4.14 (2.6%) stddev-sans-first:4.08 04:33:26 INFO - PROCESS | 13208 | Values: 161.0 156.0 166.0 153.0 157.0 156.0 153.0 153.0 157.0 154.0 04:33:26 INFO - PROCESS | 13208 | 04:33:26 INFO - PROCESS | 13208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:2.41 (3.8%) stddev-sans-first:2.49 04:33:26 INFO - PROCESS | 13208 | Values: 62.0 63.0 67.0 68.0 61.0 65.0 62.0 61.0 64.0 63.0 04:33:26 INFO - PROCESS | 13208 | -------- Summary: end -------- 04:33:26 INFO - PROCESS | 13208 | 04:33:27 INFO - TEST-INFO | 13208: exit 0 04:33:27 INFO - TEST-OK | kraken | took 60970ms 04:33:27 INFO - SUITE-END | took 1171s 04:33:28 INFO - Completed test suite (00:19:31) 04:33:28 INFO - javascript benchmark 04:33:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7895.58818339205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.1704573856537, 3328.201231704392, 3328.75034372422, 3362.915927101824, 3365.5961284645846, 5813.476787089161, 5891.263592050994, 5916.8224953251365, 5923.970380148104, 5948.226730525031, 5882.382349853257, 5967.612105213158, 5970.134330522083, 5977.910331345033, 5988.760449582022, 5309.548688361494, 5356.143017117262, 5382.058139825534, 5409.891802163955, 5461.781528738846, 5154.8711282218055, 5155.123628983063, 5201.661891977028, 5234.42421333653, 5288.180332048539, 5297.735113244342, 5324.387695415038, 5355.250264962909, 5363.195520671891, 5399.757010934517, 5366.812161574346, 5381.650192737459, 5395.028894798935, 5400.432954539776, 5405.837824865261, 5069.873253168664, 5082.974585127087, 5225.08561001827, 5318.042752304584, 5398.460153984609, 5594.4964953154, 5717.685527295997, 5757.136429535562, 5767.077267637158, 5822.330432000332, 6195.628262304276, 6262.436380725757, 6276.372362763733, 6276.686165691697, 6286.994080947026, 6062.454379105901, 6160.322364539897, 6312.116303717483, 6312.242530896322, 6320.146780184708, 5794.0, 5921.822345329604, 5923.437273459014, 5929.822105336847, 5941.940580594182, 6476.834169849472, 6482.35176482348, 6500.447461965691, 6503.187101612299, 6504.577202481823, 5955.0, 6081.452669259699, 6148.754049837957, 6225.750969961241, 6237.407446292595, 6155.569110162246, 6266.060090986297, 6305.653189074553, 6310.968445157745, 6317.178766760292, 6260.0, 6269.404406581368, 6279.686015699288, 6280.183576135073, 6304.148939893147, 5946.494547963385, 6170.7223174957235, 6281.371862813682, 6287.717052732638, 6301.243850737941, 4769.0, 4775.737334446639, 4792.976035119802, 4806.303086052572, 4811.566958973709, 4267.466566679165, 4280.743155410685, 4295.849645262463, 4310.030243195256, 4320.222359975234, 5789.797357092481, 5981.401859813984, 6055.969720151371, 6071.089336599545, 6088.939110608926, 6381.649009304533, 6384.6169229846355, 6403.519736019817, 6416.615003099829, 6427.517936154807, 6097.390260973956, 6136.325004249529, 6142.754289828446, 6146.446819786241, 6149.077638354193, 5051.318072060225, 5192.870178245574, 5208.427073021964, 5228.9738551307, 5293.417724050351, 6498.0, 6657.3342665733035, 6664.233613134455, 6665.266820649725, 6670.699818508082, 6337.271213810471, 6394.4564712, 6395.168628078506, 6406.967965160145, 6413.4869210463985, 6176.969115154396, 6427.83930401725, 6584.473242140713, 6604.537682362381, 6659.866802664016, 6127.632342059491, 6221.720022599085, 6234.501239900706, 6238.15784869055, 6277.874442511033, 6426.839329016625, 6431.871362572629, 6432.517561183024, 6434.742610295536, 6436.774712885027, 5939.316978547522, 6110.649890384283, 6198.132261483306, 6244.0, 6259.937400625936, 6118.0, 6118.47992920589, 6120.8730439461915, 6152.200213972155, 6173.104899789595, 6107.4869830629705, 6134.110553969738, 6147.692615369124, 6154.569180157346, 6155.784547540815, 5886.823395298148, 6111.834843226209, 6177.382261773787, 6208.534359923115, 6272.74909003653, 5988.520918326436, 6127.9837278401355, 6128.930927367261, 6132.850133029843, 6140.4473597376455], "value": 5796.057679058091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4330998931038, 648.3127884442491, 659.5251418978334, 672.9938741581334, 711.4770643576974, 40080.198396032065, 45325.77337113314, 45458.545414545886, 45771.31343029857, 45998.310025349645, 46296.30555541661, 46846.297305540356, 46872.765636171855, 46950.0, 46956.76521617387, 9049.3665443419, 9093.454392736425, 9167.770805729844, 9174.816503669923, 9178.724638260863, 8952.820943581124, 9141.5886285117, 9162.587683554222, 9163.450192988443, 9177.449353038839, 9145.496997665126, 9194.77013074675, 9208.907910920905, 9233.169014788667, 9241.953790231073, 9158.129977652112, 9184.12750788674, 9207.631694732203, 9219.86170207444, 9227.630894764201, 8938.240249578794, 9080.77298067547, 9103.180713735796, 9121.817563648756, 9150.03924587922, 42981.35527967083, 43389.78305108486, 43448.78275608633, 43519.78240108779, 43663.0, 3807.961920380816, 4007.5391329997133, 4067.5525692173837, 4144.316187829005, 4675.438947326308, 34069.0, 34338.82830585856, 34372.6562734372, 34643.82678086594, 34724.47913281303, 4782.593479554242, 4833.130036593412, 4850.320955066293, 4853.538913803219, 4887.266909963499, 403620.0, 403877.0, 405012.0, 406978.0, 407649.0, 61479.692601536706, 62254.0, 62322.0, 62367.0, 62394.0640890387, 39396.0, 39914.0, 40042.199156016715, 42238.15523689509, 65802.67098664476, 19194.13626386816, 19373.51566210828, 19435.514112147026, 19461.90269048646, 19496.0, 14483.565493035227, 14499.92750036243, 14508.202048887202, 14551.636209094646, 14637.194954277616, 20738.0, 20941.47646308824, 20941.790582094287, 20965.0, 20986.47533811667, 7426.814329641802, 7620.5808680523105, 7735.7679269622, 7767.417443691633, 7798.454108212371, 1036.1296510930854, 1074.462768615692, 1075.1130317488103, 1211.2187638972814, 1252.311228824143, 33845.83077084599, 34051.318973620386, 34515.13712157216, 34938.47592286118, 35326.64673353285, 1148.075798981811, 1177.252444697606, 1225.583301677434, 1226.3500344817262, 1269.796832506813, 17830.821691783174, 17913.739828513117, 18001.10822130488, 18007.400712106224, 18147.36716465434, 624742.0, 629539.0, 631643.0, 632598.0, 633051.0, 43516.3472547912, 43697.12605747867, 43962.7801860995, 43988.78005609952, 44064.11871762611, 1453.869151776324, 1464.6777708904024, 1472.7422701027492, 1483.0804900961473, 1514.1596413990342, 33133.83433082916, 33560.83219583886, 33669.66012503611, 33992.15019624529, 33998.83000584981, 56868.71565642145, 57024.0, 57254.42745572491, 57276.713616431654, 57355.42644573501, 506381.0, 507982.0, 509427.0, 509845.0, 509901.0, 28742.0, 28821.855890720413, 28890.133296001153, 28911.855440722662, 29115.0, 52172.73913630407, 52905.7354713224, 53095.46904530905, 54049.72975135099, 54332.0, 44573.88565285894, 45185.548144518136, 45347.31979020251, 46005.0, 46950.53049469461, 44329.77835110804, 46372.0, 46437.174374078226, 46675.53324466712, 47270.29094563653, 38136.618633813305, 44177.0, 44261.55738442703, 44849.77575112104, 44950.55049449464, 38399.80800095982, 39510.0, 39731.0, 39926.2014759709, 40322.991925202106, 30001.0, 32324.515132273504, 32497.187570309987, 32976.505352420216, 33034.83482582668], "value": 21430.95233393842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.2298310227466, 411.33774622857175, 427.7711424387952, 430.5135197227133, 430.69420711294987, 19999.0, 20991.68512472312, 21861.125554977803, 21920.780792192072, 22056.117755289768, 16836.83163168368, 20080.59838803223, 20556.588868222625, 20724.585508289863, 21336.253231136914, 5241.633085684004, 5567.415421380758, 5571.804986825462, 5575.0522411189995, 5578.107502799553, 5454.863628409302, 5577.776888924458, 5606.831795046155, 5945.256842894638, 6144.293406258271, 6243.56295059346, 6263.655498947556, 6294.24469063713, 6309.652969086698, 6318.083877837711, 6086.239220097488, 6149.200603921461, 6173.166622505949, 6214.285357183937, 6308.495320374359, 5878.735456904406, 6052.485538729214, 6055.848603784896, 6057.636541807506, 6060.515158787286, 25177.0, 25260.115895943552, 25316.367090822692, 25657.486850263078, 25933.092341767948, 2502.1117503286255, 2524.709658389272, 2694.1513423271804, 2732.385213327005, 2885.7258560436726, 10641.946790266, 10898.346099234072, 11148.498317575648, 11175.0, 11335.0, 1845.9538511537185, 2009.156154415149, 2018.5155562665002, 2024.7469066366705, 2095.1409921932086, 90077.09922900752, 90276.0, 90430.0, 91827.08172918252, 92197.5390123045, 11875.28748275089, 12045.939770301267, 12095.395230238453, 12251.877481225252, 12278.32469214184, 16648.500544983668, 16660.08369539687, 16867.493975180765, 17100.14499275056, 17113.0, 7108.431325493948, 7245.565266083946, 8872.911270887338, 8988.14612611814, 8999.82000359989, 8873.334499912533, 8904.24313933323, 8988.32587555936, 9235.953820230856, 9252.0, 5046.949530504721, 5107.412647545506, 5121.359830021247, 5157.974210128926, 5324.41431442541, 2024.8481363897472, 2125.851190416656, 2133.605283022646, 2142.625040617917, 2179.1719146724145, 980.8185485685028, 1015.223354134088, 1018.1193267823279, 1039.6309310194922, 1143.7197886517856, 20303.796962030487, 21274.468138296666, 21307.78692213089, 21341.78658213429, 21440.78559214388, 1049.9842502362471, 1052.1898138433364, 1069.2248120112856, 1101.779644071189, 1133.7505748735266, 11716.70708232301, 11759.764804703858, 11885.940570297093, 11994.580189693319, 12024.639260822189, 499030.0, 505929.0, 506379.0, 508198.0, 521797.0, 91199.0, 92225.0, 96511.51744241374, 102953.0, 103221.0, 1013.4071568132578, 1044.7492601775518, 1056.984145237822, 1058.6241884131177, 1065.733566608348, 19382.515437114183, 19563.608727825078, 19642.41072767762, 19800.108995095543, 19817.306394276133, 45460.54539454563, 46548.53451465442, 48193.518064818905, 48819.0, 49481.0, 67170.66414668091, 67531.3246867525, 67618.0, 68489.3151068483, 68851.96722049073, 6010.819675409744, 6692.0, 9162.037986011639, 9428.811423771624, 9472.289578281794, 13647.044706870822, 13925.791113133513, 14314.928425357806, 14487.348069336695, 14494.565163045125, 11681.415929203677, 11729.120315976164, 11891.167618266983, 11919.702007449883, 12721.491140354652, 11764.058875289786, 12192.634220973385, 12394.3183124929, 12780.744385112059, 12912.612621621367, 12222.266664000188, 12451.377431128589, 12722.427490762753, 12728.23630582168, 12794.552190673281, 9249.676261330822, 9302.302327325342, 9440.489521676498, 9538.332316737762, 9541.093596108358, 10292.639757608447, 11854.585089521825, 12144.392780361124, 12155.81766273489, 12201.450934708137], "value": 9890.503303939799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.5182469346848, 1626.3575887524428, 1807.3583877723408, 1844.400569814809, 1897.3833504111167, 8655.653773849039, 9148.771280717985, 9356.01761815009, 10120.0, 10127.037931396524, 9232.815343693122, 9415.058494150582, 9566.856497152548, 9617.663381781638, 9661.710148695533, 2510.548101341758, 2534.8352357096824, 2538.213153922281, 2540.1236573382153, 2559.321779728364, 2462.384403899025, 2527.3428908483834, 2548.1336345642476, 2553.157458038843, 2555.297293244354, 2567.14000809729, 2570.2160840943507, 2603.4532748122824, 2610.6214598883244, 2612.294680436281, 2508.134693530738, 2530.101813856073, 2533.759292867184, 2562.884670189846, 2565.8332208406396, 2496.7253602103756, 2501.837380570257, 2502.174282486775, 2514.9497010059695, 2538.1243471002476, 9777.90222097777, 9800.803983920354, 9808.411495310233, 9823.214142868554, 9848.852267215998, 5746.913796293059, 5832.125181222808, 5875.618084824473, 5891.086881533369, 5895.941040589625, 3638.07229156566, 3702.8703995360033, 3735.62643735627, 3799.3146647751637, 3841.4045822897497, 1151.2862025544216, 1156.115571587736, 1165.5279611757253, 1241.9130660853743, 1242.372601836076, 13514.32428378577, 13684.794728079087, 13706.903447724158, 13767.724645507034, 13811.17132972025, 4986.601071914238, 5244.475552444725, 5257.290265814143, 5262.394824595221, 5303.867403314948, 11901.583444579399, 11916.76166476683, 11948.402579871146, 11987.460564274628, 12032.097592680584, 5889.646621202742, 5906.173135760997, 5907.172995780594, 5921.851953701106, 5929.555283353766, 4819.132556139928, 5237.8428647140645, 5283.524482796567, 5299.072662284085, 5381.112116500812, 4424.646028317727, 4459.487158976759, 4461.888452788707, 4546.386237857847, 4620.353150558924, 1404.6067101211677, 1450.724362371146, 1465.1794994802945, 1465.2234315812423, 1468.0237641968185, 868.2966796894409, 884.6682494064726, 990.945497997617, 1021.1473419694489, 1024.626011505795, 6334.461570766444, 6491.578047426902, 6610.471162307004, 6675.037869728119, 6677.098591690156, 468.20405310971483, 475.0167153991205, 1021.99489002556, 1125.4935279124263, 1139.1058019454854, 4407.294832826732, 4416.1609294233995, 4469.396631454712, 4618.838340658061, 4645.39609850724, 11441.485133169028, 11832.645020649394, 12339.568115115928, 12385.071119666061, 12404.75190496185, 11813.11401644863, 12265.754684906253, 12323.568675096329, 12350.876491235153, 12402.317872517098, 8744.169303916118, 8811.691590794291, 8819.779505512286, 8849.292056635453, 8925.821483570293, 6289.685515724104, 6458.354164583504, 6494.155759751202, 6545.934540654723, 6640.269570347161, 10577.0, 11055.557777688802, 11117.16621253393, 11156.553737850396, 11191.44042797873, 10435.32170408921, 11248.437578120898, 11428.25716328436, 11443.885561144281, 11562.364069976233, 7779.183185765413, 7908.327792137733, 8046.87929681067, 8075.636596353295, 8499.277561407349, 9488.0, 9542.284328675516, 9543.618255269712, 9549.9045009549, 9580.712578622653, 8206.507609543447, 8370.707025254087, 8407.2433480987, 8457.323414126979, 8515.787105322417, 8221.54781487024, 8324.6670133194, 8366.163383661586, 8378.078411374621, 8474.491530508189, 7910.52536847791, 7923.20767923203, 7955.24425179607, 8011.439199255996, 8039.758807235792, 5524.530414914777, 5722.998475266895, 5729.68486733217, 5812.3025236971835, 5865.765369385177, 5631.577631677558, 5728.856778580569, 5777.22007528995, 5883.441073098049, 5902.734376952962], "value": 5082.958127850196, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.685527742116, 348.0428820742957, 348.39205586251995, 350.0688169469212, 352.3006831439592, 5734.827955161341, 5809.912851307228, 5820.759007782008, 5824.708764561776, 5867.7066146692705, 5759.416160555838, 5773.422657734224, 5787.363390027104, 5799.101139323411, 5806.245188125537, 4111.321631930736, 4454.866354009385, 4480.775961201944, 4497.415336006315, 4499.1451624191295, 4472.955270447303, 4477.507474177838, 4484.4842843072975, 4485.0, 4497.53830005248, 4476.507584165739, 4493.438320209973, 4495.348174514694, 4497.685162038659, 4513.255312873388, 4331.9783401083105, 4414.933775993362, 4444.866654000369, 4454.643628509712, 4473.552644735533, 3978.1049263915675, 3980.1840622672285, 3990.1421194443333, 3992.4210989406374, 4009.8797036088963, 5646.6894320812335, 5647.491725744702, 5693.868372395166, 5706.0, 5708.857278568069, 4991.82855457877, 5180.922286165711, 5191.118928994407, 5191.402988656278, 5197.480251974772, 6084.205159477965, 6096.359882212392, 6106.908396374058, 6109.786157484511, 6112.205413296288, 4320.935185972213, 4371.344298355272, 4407.625351845097, 4438.711483753578, 4439.289713645833, 6211.844703882394, 6240.719167637421, 6258.186435763367, 6268.749250030039, 6302.46429053531, 4448.866534003985, 4450.5104438511735, 4472.955270447319, 4491.955080449219, 4495.595396414338, 4402.823887044547, 4539.6368290536675, 4550.977245113753, 4560.156371071363, 4561.384213131185, 5101.948980510221, 5173.456787037307, 5179.792808287626, 5180.326557547494, 5185.274061631375, 6106.328303886569, 6157.275962730443, 6161.7227224775, 6180.47465965389, 6186.876262474725, 1525.9313330900136, 1543.2592355669117, 1573.8819588530905, 1576.8896177267711, 1580.1151355240872, 998.1465846701111, 998.3760149906309, 1034.5189486888632, 1054.583439541377, 1063.7659714862718, 5820.0, 5849.94150058494, 5885.852853678693, 5896.587238893322, 5950.72710009493, 6239.875202496016, 6262.405071518198, 6267.2479302484, 6337.714802833883, 6346.143270658402, 5678.290213723285, 5833.82498525045, 5899.911501327398, 5900.20347253124, 5917.142014407973, 3330.4504756715355, 3356.2280675444786, 3387.187075101958, 3390.7456940729544, 3393.1846462142635, 6228.318354044382, 6448.806535803933, 6476.579022363531, 6506.0, 6515.413612774873, 6446.548741588138, 6481.513886458534, 6507.251666058369, 6515.153030106056, 6571.178602674666, 6332.4934005279465, 6464.935350646528, 6532.836679082966, 6629.237637671633, 6657.933420665829, 6255.343188965275, 6302.590331628429, 6347.365263473615, 6382.234131904202, 6425.58233714807, 6079.270487541523, 6294.4964402846745, 6298.905516417349, 6304.211973503312, 6328.208973878265, 6500.70746816385, 6506.219253689587, 6520.53288010194, 6559.639219842955, 6561.114249576437, 4444.599986001275, 4482.843100491467, 4497.0, 4500.9099818004115, 4503.324501324828, 6177.660228687465, 6327.651979141007, 6342.302346741762, 6419.293877673359, 6454.838629034311, 6172.22847144107, 6204.7828326008375, 6218.5647004709235, 6219.47134493555, 6242.906356404748, 5984.790532331347, 6092.69536523181, 6124.816255512342, 6171.166892469639, 6182.536309776695, 5926.703664816656, 5985.581009329305, 6100.633961962297, 6131.356207598316, 6141.201643786279, 6202.844928876814, 6207.937920620736, 6222.751089956351, 6261.96869015652, 6291.150694656163, 5953.0, 6107.297660768891, 6112.930237208382, 6127.325994140552, 6139.26328840542], "value": 4665.114174853636, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.4271210660164, 806.8663527743519, 817.272627361648, 851.3529717414765, 917.9311551633629, 13908.860911390882, 14714.190719510423, 17210.225539850704, 17698.38055668052, 17702.64594708105, 15337.0, 15542.68914621707, 15548.922255388707, 15594.376224951016, 15598.922005389957, 887.0818702642766, 909.8635204719279, 919.9494027828467, 921.2767977137948, 922.2207234886511, 910.0444533240104, 914.3416739947228, 918.609590923858, 922.0963455813308, 922.6032805893464, 977.1498796047449, 979.56409397818, 979.8236317462854, 979.9069088436587, 985.344745744083, 968.428627110005, 972.4408465132577, 972.751948253198, 973.9513024348789, 974.1135566634364, 716.1907045039072, 716.2837162837163, 716.9211386747454, 716.9856602867966, 718.4575645387699, 16904.746428803577, 17032.318707251696, 17052.744208836877, 17122.229499672543, 17143.314267429287, 16402.09788461634, 16419.86149639772, 16498.767522346487, 16696.165191740485, 16965.491035268962, 13527.0, 13889.236092014935, 13959.441622335095, 13979.23114228717, 14178.929105354511, 4114.753114813091, 4124.319487284594, 4165.500139983191, 4188.895277618053, 4271.103068355649, 92000.53999729958, 92066.5396673019, 92513.53743231308, 94337.52831235869, 95952.52023739976, 11474.139439542068, 11541.422928853524, 12084.79152084802, 12143.332116733487, 12294.569690060984, 24632.13787517464, 24778.876105619718, 24863.5027299453, 25000.0, 25138.12016579411, 8887.688930887389, 8985.281177505914, 9044.683436079706, 9177.08229177077, 9234.261259099256, 4907.68100073494, 5013.824516141917, 5085.364329458817, 5177.404598471148, 5256.816011439581, 3890.2025084857537, 4023.839046438168, 4028.254772867029, 4030.0730831908827, 4036.5357983832237, 699.4264702943537, 728.7048745258179, 747.2676776758807, 752.8531936272484, 760.2663429790279, 764.6253335865497, 838.3125836813754, 848.8481698893276, 854.7563944275852, 863.3611127765408, 10408.375497470177, 11157.776844463066, 11315.60395386174, 11551.595694150665, 11653.0, 774.7172282116986, 788.8027993001749, 791.8574656561874, 795.8090058385945, 802.4583406200791, 4878.365812444359, 4978.128827455181, 5006.1739812930455, 5037.874053148701, 5106.131957567222, 76825.6158719214, 80050.19949800428, 106220.0, 126688.36655816661, 140743.0, 92433.0, 118895.0, 119254.0, 121401.0, 121851.39074304572, 96545.0, 99614.0, 101098.49450752846, 104743.0, 111172.99999999838, 9456.763580910532, 9528.094830991045, 9555.426674399558, 9642.180414664832, 9655.758606034906, 59419.702901485216, 59534.0, 60205.39794601998, 60213.0, 60543.69728151507, 51418.228726569876, 65408.0, 85254.57372713096, 88009.0, 89192.5540372294, 13520.526781562598, 13701.109427887155, 13715.314234288446, 13756.724865502834, 13989.0, 14929.925350373178, 15338.923305383401, 16040.358385664442, 16260.756088658916, 16381.836181638031, 13525.18848869071, 13617.863821362056, 14046.48987046355, 14208.076475029504, 14451.92774036123, 13280.468781248643, 13414.061015728805, 13604.183748974698, 14011.299435028412, 14244.943169911272, 14328.71342573122, 14362.425502979764, 14365.92817035908, 14478.0, 14572.708545829237, 11560.0, 11797.29216247028, 12088.51645934188, 12130.090243231616, 12226.20529665569, 11910.344931028876, 11992.672137739744, 12087.214331068453, 12118.272903625812, 12188.878111218773], "value": 8315.640998228511, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 105.0, 108.0, 109.0, 110.0, 112.0, 112.0, 111.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 147.0, 179.0, 122.0, 147.0, 147.0, 118.0, 180.0, 117.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 163.0, 164.0, 163.0, 166.0, 162.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 182.0, 78.0, 76.0, 75.0, 77.0, 162.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 143.0, 84.0, 83.0, 83.0, 141.0, 83.0, 84.0, 130.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 121.0, 117.0, 118.0, 119.0, 118.0, 117.0, 116.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 51.0, 55.0, 52.0, 56.0, 53.0, 53.0, 53.0, 61.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 63.0, 60.0, 59.0, 59.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 75.0, 74.0, 73.0, 73.0, 73.0, 73.0, 72.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 123.0, 117.0, 118.0, 124.0, 120.0, 117.0, 155.0, 128.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 166.0, 153.0, 157.0, 156.0, 153.0, 153.0, 157.0, 154.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 67.0, 68.0, 61.0, 65.0, 62.0, 61.0, 64.0, 63.0], "value": 63.6, "unit": "score"}]}]} 04:33:28 INFO - Return code: 0 04:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:28 ERROR - # TBPL SUCCESS # 04:33:28 INFO - Running post-action listener: _resource_record_post_action 04:33:28 INFO - [mozharness: 2016-08-18 11:33:28.229174Z] Finished run-tests step (success) 04:33:28 INFO - Running post-run listener: _resource_record_post_run 04:33:28 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 327331840; Read time: 0; Write time: 255160 04:33:28 INFO - TinderboxPrint: CPU usage
13.2% 04:33:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:33:28 INFO - TinderboxPrint: I/O write bytes / time
327,331,840 / 255,160 04:33:28 INFO - TinderboxPrint: CPU idle
8,225.0 (86.8%) 04:33:28 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 04:33:28 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79138816; Read time: 0; Write time: 57100 04:33:28 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 247967744; Read time: 0; Write time: 198060 04:33:28 INFO - Running post-run listener: _upload_blobber_files 04:33:28 INFO - Blob upload gear active. 04:33:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:28 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:28 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:28 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:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:30 INFO - (blobuploader) - INFO - Done attempting. 04:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:30 INFO - (blobuploader) - INFO - Done attempting. 04:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:40 INFO - (blobuploader) - INFO - Done attempting. 04:33:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:40 INFO - Return code: 0 04:33:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc2ebfd354a9cbd397738978bd12a46603da485f6ddb7784987eee9bc9f8f2d568d70bbca0ed27c9e7412f5a10ddf098f463d5568936e806e3c2510ace543f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426cf3684787cad836253aafdfcf89c99712bd0e79e2073e14db64881477d700acc568fd3ba36530cbeddaf3601db770ee12b253bd81f3d3b6850428b1ab5ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/957fa901220df41fa96b2f8195c1eb187e716fd9771bb89b4645d87e0f9097f901a1748e915314eb9e83cd99e28ef23fc9987f4d88a4b671f672b79add9bca3a"} 04:33:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:40 INFO - Contents: 04:33:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc2ebfd354a9cbd397738978bd12a46603da485f6ddb7784987eee9bc9f8f2d568d70bbca0ed27c9e7412f5a10ddf098f463d5568936e806e3c2510ace543f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426cf3684787cad836253aafdfcf89c99712bd0e79e2073e14db64881477d700acc568fd3ba36530cbeddaf3601db770ee12b253bd81f3d3b6850428b1ab5ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/957fa901220df41fa96b2f8195c1eb187e716fd9771bb89b4645d87e0f9097f901a1748e915314eb9e83cd99e28ef23fc9987f4d88a4b671f672b79add9bca3a"} 04:33:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:40 INFO - Copying logs to upload dir... 04:33:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1687.393345 ========= master_lag: 1.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 8 secs) (at 2016-08-18 04:33:40.240940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 04:33:40.246430) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232 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/dc2ebfd354a9cbd397738978bd12a46603da485f6ddb7784987eee9bc9f8f2d568d70bbca0ed27c9e7412f5a10ddf098f463d5568936e806e3c2510ace543f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426cf3684787cad836253aafdfcf89c99712bd0e79e2073e14db64881477d700acc568fd3ba36530cbeddaf3601db770ee12b253bd81f3d3b6850428b1ab5ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/957fa901220df41fa96b2f8195c1eb187e716fd9771bb89b4645d87e0f9097f901a1748e915314eb9e83cd99e28ef23fc9987f4d88a4b671f672b79add9bca3a"} 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.010618 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/dc2ebfd354a9cbd397738978bd12a46603da485f6ddb7784987eee9bc9f8f2d568d70bbca0ed27c9e7412f5a10ddf098f463d5568936e806e3c2510ace543f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426cf3684787cad836253aafdfcf89c99712bd0e79e2073e14db64881477d700acc568fd3ba36530cbeddaf3601db770ee12b253bd81f3d3b6850428b1ab5ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/957fa901220df41fa96b2f8195c1eb187e716fd9771bb89b4645d87e0f9097f901a1748e915314eb9e83cd99e28ef23fc9987f4d88a4b671f672b79add9bca3a"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 04:33:40.611278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-08-18 04:33:40.611567) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471517459.821698-2086122232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 2.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-08-18 04:33:42.890976) ========= ========= Started reboot skipped (results: 3, elapsed: 8 secs) (at 2016-08-18 04:33:42.891272) ========= ========= Finished reboot skipped (results: 3, elapsed: 8 secs) (at 2016-08-18 04:33:51.274890) ========= ========= Total master_lag: 4.01 =========