builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1473341215.93 results: success (0) buildid: 20160908033016 builduid: e5827c1c5f3247ccaff903a7b16caa87 revision: c580c468fdb4a396bde95c2d2b69d2302e88d3ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:55.928589) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:55.929402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:55.930009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:55.945595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:55.946286) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-08 06:26:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-09-08 06:26:56 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.072168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.072961) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.123400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.123851) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c580c468fdb4a396bde95c2d2b69d2302e88d3ba --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 c580c468fdb4a396bde95c2d2b69d2302e88d3ba --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=a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-08 06:26:56,456 truncating revision to first 12 chars 2016-09-08 06:26:56,456 Setting DEBUG logging. 2016-09-08 06:26:56,456 attempt 1/10 2016-09-08 06:26:56,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c580c468fdb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 06:26:56,779 unpacking tar archive at: mozilla-aurora-c580c468fdb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.836942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.837301) ========= script_repo_revision: c580c468fdb4a396bde95c2d2b69d2302e88d3ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.837818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.838118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 06:26:56.848919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-08 06:26:56.849218) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:57 INFO - MultiFileLogger online at 20160908 06:26:57 in /builds/slave/test 06:26:57 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 06:26:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:57 INFO - {'append_to_log': False, 06:26:57 INFO - 'base_work_dir': '/builds/slave/test', 06:26:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:26:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:57 INFO - 'branch': 'Mozilla-Aurora', 06:26:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:57 INFO - 'config_files': ('talos/linux_config.py',), 06:26:57 INFO - 'default_actions': ('clobber', 06:26:57 INFO - 'read-buildbot-config', 06:26:57 INFO - 'download-and-extract', 06:26:57 INFO - 'populate-webroot', 06:26:57 INFO - 'create-virtualenv', 06:26:57 INFO - 'install', 06:26:57 INFO - 'run-tests'), 06:26:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:57 INFO - 'download_minidump_stackwalk': True, 06:26:57 INFO - 'download_symbols': 'ondemand', 06:26:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:57 INFO - 'installer_path': 'installer.exe', 06:26:57 INFO - 'log_level': 'info', 06:26:57 INFO - 'log_name': 'talos', 06:26:57 INFO - 'log_to_console': True, 06:26:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:57 INFO - 'opt_config_files': (), 06:26:57 INFO - 'pip_index': False, 06:26:57 INFO - 'sps_profile': False, 06:26:57 INFO - 'sps_profile_interval': 0, 06:26:57 INFO - 'suite': 'dromaeojs-e10s', 06:26:57 INFO - 'system_bits': '32', 06:26:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:57 INFO - 'title': 'talos-linux64-ix-064', 06:26:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:57 INFO - 'use_talos_json': True, 06:26:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:57 INFO - 'work_dir': 'build'} 06:26:57 INFO - [mozharness: 2016-09-08 13:26:57.274517Z] Running clobber step. 06:26:57 INFO - Running pre-action listener: _resource_record_pre_action 06:26:57 INFO - Running main action method: clobber 06:26:57 INFO - rmtree: /builds/slave/test/build 06:26:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:57 INFO - Running post-action listener: _resource_record_post_action 06:26:57 INFO - [mozharness: 2016-09-08 13:26:57.732837Z] Finished clobber step (success) 06:26:57 INFO - [mozharness: 2016-09-08 13:26:57.732938Z] Running read-buildbot-config step. 06:26:57 INFO - Running pre-action listener: _resource_record_pre_action 06:26:57 INFO - Running main action method: read_buildbot_config 06:26:57 INFO - Using buildbot properties: 06:26:57 INFO - { 06:26:57 INFO - "project": "", 06:26:57 INFO - "product": "firefox", 06:26:57 INFO - "script_repo_revision": "production", 06:26:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:26:57 INFO - "repository": "", 06:26:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:26:57 INFO - "buildid": "20160908033016", 06:26:57 INFO - "pgo_build": "True", 06:26:57 INFO - "basedir": "/builds/slave/test", 06:26:57 INFO - "buildnumber": 547, 06:26:57 INFO - "slavename": "talos-linux64-ix-064", 06:26:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:26:57 INFO - "platform": "ubuntu64_hw", 06:26:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:26:57 INFO - "branch": "mozilla-aurora", 06:26:57 INFO - "repo_path": "releases/mozilla-aurora", 06:26:57 INFO - "revision": "c580c468fdb4a396bde95c2d2b69d2302e88d3ba", 06:26:57 INFO - "stage_platform": "linux64-pgo", 06:26:57 INFO - "builduid": "e5827c1c5f3247ccaff903a7b16caa87", 06:26:57 INFO - "slavebuilddir": "test" 06:26:57 INFO - } 06:26:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 06:26:57 INFO - Running post-action listener: _resource_record_post_action 06:26:57 INFO - [mozharness: 2016-09-08 13:26:57.735601Z] Finished read-buildbot-config step (success) 06:26:57 INFO - [mozharness: 2016-09-08 13:26:57.735698Z] Running download-and-extract step. 06:26:57 INFO - Running pre-action listener: _resource_record_pre_action 06:26:57 INFO - Running main action method: download_and_extract 06:26:57 INFO - mkdir: /builds/slave/test/build/tests 06:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:57 INFO - https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:26:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:26:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:26:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:26:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:26:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:26:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:26:57 INFO - retry: Failed, sleeping 30 seconds before retrying 06:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:27:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:27:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:27:27 INFO - retry: Failed, sleeping 60 seconds before retrying 06:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:28:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:28:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:28:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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! 06:28:27 INFO - Caught exception: HTTP Error 404: Not Found 06:28:27 INFO - Caught exception: HTTP Error 404: Not Found 06:28:27 INFO - Caught exception: HTTP Error 404: Not Found 06:28:27 INFO - trying https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:28:27 INFO - Downloading https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:28:28 INFO - Downloaded 1361 bytes. 06:28:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:28:28 INFO - Using the following test package requirements: 06:28:28 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:28:28 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:28:28 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:28:28 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'jsshell-linux-x86_64.zip'], 06:28:28 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:28:28 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:28:28 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:28:28 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:28:28 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:28:28 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:28 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:28:28 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:28: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')]} 06:28:28 INFO - https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:28:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:28:28 INFO - retry: Failed, sleeping 30 seconds before retrying 06:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:28:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:28:58 INFO - retry: Failed, sleeping 60 seconds before retrying 06:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:29:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:29:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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! 06:29:58 INFO - Caught exception: HTTP Error 404: Not Found 06:29:58 INFO - Caught exception: HTTP Error 404: Not Found 06:29:58 INFO - Caught exception: HTTP Error 404: Not Found 06:29:58 INFO - trying https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:58 INFO - Downloading https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:29:59 INFO - Downloaded 21769736 bytes. 06:29:59 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'] 06:29:59 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 06:30:00 INFO - Return code: 0 06:30:00 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 06:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:00 INFO - https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:30:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:30:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:30:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:30:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:30:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:30:00 INFO - retry: Failed, sleeping 30 seconds before retrying 06:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:30:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:30:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:30:30 INFO - retry: Failed, sleeping 60 seconds before retrying 06:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:31:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:31:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:31:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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! 06:31:30 INFO - Caught exception: HTTP Error 404: Not Found 06:31:30 INFO - Caught exception: HTTP Error 404: Not Found 06:31:30 INFO - Caught exception: HTTP Error 404: Not Found 06:31:30 INFO - trying https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:31:30 INFO - Downloading https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:31:31 INFO - Downloaded 21769736 bytes. 06:31:31 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'] 06:31:31 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 06:31:32 INFO - Return code: 0 06:31: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')]} 06:31:32 INFO - https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:31:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:31:32 INFO - retry: Failed, sleeping 30 seconds before retrying 06:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:32:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:32:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:32:02 INFO - retry: Failed, sleeping 60 seconds before retrying 06:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:33:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:33:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:33:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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! 06:33:02 INFO - Caught exception: HTTP Error 404: Not Found 06:33:02 INFO - Caught exception: HTTP Error 404: Not Found 06:33:02 INFO - Caught exception: HTTP Error 404: Not Found 06:33:02 INFO - trying https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:33:03 INFO - Downloaded 14413740 bytes. 06:33:03 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'] 06:33:03 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 06:33:03 INFO - Return code: 0 06:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:03 INFO - https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:33:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:33:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:33:03 INFO - retry: Failed, sleeping 30 seconds before retrying 06:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:33:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:33:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:33:34 INFO - retry: Failed, sleeping 60 seconds before retrying 06:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:34:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:34:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3U85OqYTHeBRwlZVnmmsw/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! 06:34:34 INFO - Caught exception: HTTP Error 404: Not Found 06:34:34 INFO - Caught exception: HTTP Error 404: Not Found 06:34:34 INFO - Caught exception: HTTP Error 404: Not Found 06:34:34 INFO - trying https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:34 INFO - Downloading https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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 06:34:35 INFO - Downloaded 63898150 bytes. 06:34:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:35 INFO - mkdir: /builds/slave/test/properties 06:34:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:34:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:34:35 INFO - Contents: 06:34:35 INFO - build_url:https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:35 INFO - Running post-action listener: _resource_record_post_action 06:34:35 INFO - Running post-action listener: set_extra_try_arguments 06:34:35 INFO - [mozharness: 2016-09-08 13:34:35.879630Z] Finished download-and-extract step (success) 06:34:35 INFO - [mozharness: 2016-09-08 13:34:35.879861Z] Running populate-webroot step. 06:34:35 INFO - Running pre-action listener: _resource_record_pre_action 06:34:35 INFO - Running main action method: populate_webroot 06:34:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:34:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:34:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:34:35 INFO - '--tppagecycles', 06:34:35 INFO - '7'], 06:34:35 INFO - 'tests': ['tsvgm']}}, 06:34:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:34:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:34:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:34:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:34:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['damp', 'tps']}, 06:34:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'tests': ['damp', 'tps']}, 06:34:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['dromaeo_dom']}, 06:34:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:34:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['basic_compositor_video']}, 06:34:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:34:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['a11yr', 06:34:35 INFO - 'ts_paint', 06:34:35 INFO - 'tpaint', 06:34:35 INFO - 'sessionrestore', 06:34:35 INFO - 'sessionrestore_no_auto_restore', 06:34:35 INFO - 'tabpaint']}, 06:34:35 INFO - 'other-e10s': {'tests': ['a11yr', 06:34:35 INFO - 'ts_paint', 06:34:35 INFO - 'tpaint', 06:34:35 INFO - 'sessionrestore', 06:34:35 INFO - 'sessionrestore_no_auto_restore', 06:34:35 INFO - 'tabpaint']}, 06:34:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:34:35 INFO - 'ts_paint', 06:34:35 INFO - 'tpaint', 06:34:35 INFO - 'sessionrestore', 06:34:35 INFO - 'sessionrestore_no_auto_restore', 06:34:35 INFO - 'tabpaint']}, 06:34:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:34:35 INFO - 'ts_paint', 06:34:35 INFO - 'tpaint', 06:34:35 INFO - 'sessionrestore', 06:34:35 INFO - 'sessionrestore_no_auto_restore', 06:34:35 INFO - 'tabpaint']}, 06:34:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['a11yr', 06:34:35 INFO - 'ts_paint', 06:34:35 INFO - 'tpaint', 06:34:35 INFO - 'sessionrestore', 06:34:35 INFO - 'sessionrestore_no_auto_restore', 06:34:35 INFO - 'tabpaint']}, 06:34:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['a11yr', 06:34:35 INFO - 'ts_paint', 06:34:35 INFO - 'tpaint', 06:34:35 INFO - 'sessionrestore', 06:34:35 INFO - 'sessionrestore_no_auto_restore', 06:34:35 INFO - 'tabpaint']}, 06:34:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['tsvgx', 06:34:35 INFO - 'tsvgr_opacity', 06:34:35 INFO - 'tart', 06:34:35 INFO - 'tscrollx', 06:34:35 INFO - 'cart']}, 06:34:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:34:35 INFO - 'tsvgr_opacity', 06:34:35 INFO - 'tart', 06:34:35 INFO - 'tscrollx', 06:34:35 INFO - 'cart']}, 06:34:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'talos_options': ['--disable-e10s'], 06:34:35 INFO - 'tests': ['tp5o']}, 06:34:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'tests': ['tp5o']}, 06:34:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'talos_options': ['--disable-e10s', 06:34:35 INFO - '--xperf_path', 06:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:35 INFO - 'tests': ['tp5n']}, 06:34:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:35 INFO - 'talos_options': ['--xperf_path', 06:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:35 INFO - 'tests': ['tp5n']}}, 06:34:35 INFO - 'talos.zip': {'path': '', 06:34:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:34:35 INFO - Running post-action listener: _resource_record_post_action 06:34:35 INFO - [mozharness: 2016-09-08 13:34:35.899380Z] Finished populate-webroot step (success) 06:34:35 INFO - [mozharness: 2016-09-08 13:34:35.899468Z] Running create-virtualenv step. 06:34:35 INFO - Running pre-action listener: _resource_record_pre_action 06:34:35 INFO - Running main action method: create_virtualenv 06:34:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:34:35 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 06:34:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:34:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:34:35 INFO - Using real prefix '/usr' 06:34:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:34:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:34:38 INFO - Installing pip.................done. 06:34:38 INFO - Return code: 0 06:34:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:34:38 INFO - Using env: {'DISPLAY': ':0', 06:34:38 INFO - 'HOME': '/home/cltbld', 06:34:38 INFO - 'LANG': 'en_US.UTF-8', 06:34:38 INFO - 'LANGUAGE': 'en_US:en', 06:34:38 INFO - 'LOGNAME': 'cltbld', 06:34:38 INFO - 'MAIL': '/var/mail/cltbld', 06:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:38 INFO - 'MOZ_NO_REMOTE': '1', 06:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:38 INFO - 'NO_EM_RESTART': '1', 06:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:38 INFO - 'PWD': '/builds/slave/test', 06:34:38 INFO - 'SHELL': '/bin/bash', 06:34:38 INFO - 'SHLVL': '1', 06:34:38 INFO - 'TERM': 'linux', 06:34:38 INFO - 'TMOUT': '86400', 06:34:38 INFO - 'USER': 'cltbld', 06:34:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:38 INFO - '_': '/tools/buildbot/bin/python'} 06:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:38 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 06:34:38 INFO - Cleaning up... 06:34:38 INFO - Return code: 0 06:34:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:34:38 INFO - Using env: {'DISPLAY': ':0', 06:34:38 INFO - 'HOME': '/home/cltbld', 06:34:38 INFO - 'LANG': 'en_US.UTF-8', 06:34:38 INFO - 'LANGUAGE': 'en_US:en', 06:34:38 INFO - 'LOGNAME': 'cltbld', 06:34:38 INFO - 'MAIL': '/var/mail/cltbld', 06:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:38 INFO - 'MOZ_NO_REMOTE': '1', 06:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:38 INFO - 'NO_EM_RESTART': '1', 06:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:38 INFO - 'PWD': '/builds/slave/test', 06:34:38 INFO - 'SHELL': '/bin/bash', 06:34:38 INFO - 'SHLVL': '1', 06:34:38 INFO - 'TERM': 'linux', 06:34:38 INFO - 'TMOUT': '86400', 06:34:38 INFO - 'USER': 'cltbld', 06:34:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:38 INFO - '_': '/tools/buildbot/bin/python'} 06:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:38 INFO - Downloading/unpacking psutil>=3.1.1 06:34:38 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 06:34:38 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 06:34:38 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 06:34:38 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 06:34:38 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 06:34:38 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 06:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:40 INFO - Installing collected packages: psutil 06:34:40 INFO - Running setup.py install for psutil 06:34:40 INFO - building 'psutil._psutil_linux' extension 06:34:40 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 06:34:41 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 06:34:41 INFO - building 'psutil._psutil_posix' extension 06:34:41 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 06:34:41 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 06:34:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:41 INFO - Successfully installed psutil 06:34:41 INFO - Cleaning up... 06:34:41 INFO - Return code: 0 06:34:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:34:41 INFO - Using env: {'DISPLAY': ':0', 06:34:41 INFO - 'HOME': '/home/cltbld', 06:34:41 INFO - 'LANG': 'en_US.UTF-8', 06:34:41 INFO - 'LANGUAGE': 'en_US:en', 06:34:41 INFO - 'LOGNAME': 'cltbld', 06:34:41 INFO - 'MAIL': '/var/mail/cltbld', 06:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:41 INFO - 'MOZ_NO_REMOTE': '1', 06:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:41 INFO - 'NO_EM_RESTART': '1', 06:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:41 INFO - 'PWD': '/builds/slave/test', 06:34:41 INFO - 'SHELL': '/bin/bash', 06:34:41 INFO - 'SHLVL': '1', 06:34:41 INFO - 'TERM': 'linux', 06:34:41 INFO - 'TMOUT': '86400', 06:34:41 INFO - 'USER': 'cltbld', 06:34:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:41 INFO - '_': '/tools/buildbot/bin/python'} 06:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:34:43 INFO - Installing collected packages: mozsystemmonitor 06:34:43 INFO - Running setup.py install for mozsystemmonitor 06:34:43 INFO - Successfully installed mozsystemmonitor 06:34:43 INFO - Cleaning up... 06:34:43 INFO - Return code: 0 06:34:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:34:43 INFO - Using env: {'DISPLAY': ':0', 06:34:43 INFO - 'HOME': '/home/cltbld', 06:34:43 INFO - 'LANG': 'en_US.UTF-8', 06:34:43 INFO - 'LANGUAGE': 'en_US:en', 06:34:43 INFO - 'LOGNAME': 'cltbld', 06:34:43 INFO - 'MAIL': '/var/mail/cltbld', 06:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:43 INFO - 'MOZ_NO_REMOTE': '1', 06:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:43 INFO - 'NO_EM_RESTART': '1', 06:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:43 INFO - 'PWD': '/builds/slave/test', 06:34:43 INFO - 'SHELL': '/bin/bash', 06:34:43 INFO - 'SHLVL': '1', 06:34:43 INFO - 'TERM': 'linux', 06:34:43 INFO - 'TMOUT': '86400', 06:34:43 INFO - 'USER': 'cltbld', 06:34:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:43 INFO - '_': '/tools/buildbot/bin/python'} 06:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:34:43 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 06:34:43 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 06:34:43 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 06:34:43 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 06:34:43 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 06:34:43 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 06:34:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:34:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:34:45 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 06:34:45 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 06:34:45 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 06:34:45 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 06:34:45 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 06:34:45 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 06:34:46 INFO - Downloading functools32-3.2.3-2.tar.gz 06:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:34:46 INFO - warning: no files found matching '*.txt' 06:34:46 INFO - no previously-included directories found matching 'build' 06:34:46 INFO - no previously-included directories found matching 'dist' 06:34:46 INFO - no previously-included directories found matching '.git*' 06:34:46 INFO - Installing collected packages: jsonschema, functools32 06:34:46 INFO - Running setup.py install for functools32 06:34:46 INFO - warning: no files found matching '*.txt' 06:34:46 INFO - no previously-included directories found matching 'build' 06:34:46 INFO - no previously-included directories found matching 'dist' 06:34:46 INFO - no previously-included directories found matching '.git*' 06:34:46 INFO - Successfully installed jsonschema functools32 06:34:46 INFO - Cleaning up... 06:34:46 INFO - Return code: 0 06:34:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:34:46 INFO - Using env: {'DISPLAY': ':0', 06:34:46 INFO - 'HOME': '/home/cltbld', 06:34:46 INFO - 'LANG': 'en_US.UTF-8', 06:34:46 INFO - 'LANGUAGE': 'en_US:en', 06:34:46 INFO - 'LOGNAME': 'cltbld', 06:34:46 INFO - 'MAIL': '/var/mail/cltbld', 06:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:46 INFO - 'MOZ_NO_REMOTE': '1', 06:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:46 INFO - 'NO_EM_RESTART': '1', 06:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:46 INFO - 'PWD': '/builds/slave/test', 06:34:46 INFO - 'SHELL': '/bin/bash', 06:34:46 INFO - 'SHLVL': '1', 06:34:46 INFO - 'TERM': 'linux', 06:34:46 INFO - 'TMOUT': '86400', 06:34:46 INFO - 'USER': 'cltbld', 06:34:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:46 INFO - '_': '/tools/buildbot/bin/python'} 06:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:34:46 INFO - Cleaning up... 06:34:46 INFO - Return code: 0 06:34:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:34:46 INFO - Using env: {'DISPLAY': ':0', 06:34:46 INFO - 'HOME': '/home/cltbld', 06:34:46 INFO - 'LANG': 'en_US.UTF-8', 06:34:46 INFO - 'LANGUAGE': 'en_US:en', 06:34:46 INFO - 'LOGNAME': 'cltbld', 06:34:46 INFO - 'MAIL': '/var/mail/cltbld', 06:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:46 INFO - 'MOZ_NO_REMOTE': '1', 06:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:46 INFO - 'NO_EM_RESTART': '1', 06:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:46 INFO - 'PWD': '/builds/slave/test', 06:34:46 INFO - 'SHELL': '/bin/bash', 06:34:46 INFO - 'SHLVL': '1', 06:34:46 INFO - 'TERM': 'linux', 06:34:46 INFO - 'TMOUT': '86400', 06:34:46 INFO - 'USER': 'cltbld', 06:34:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:46 INFO - '_': '/tools/buildbot/bin/python'} 06:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:34:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:49 INFO - Downloading docopt-0.6.1.tar.gz 06:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:34:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:34:49 INFO - Running setup.py install for blobuploader 06:34:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:34:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:34:49 INFO - Running setup.py install for requests 06:34:49 INFO - Running setup.py install for docopt 06:34:50 INFO - Successfully installed blobuploader requests docopt 06:34:50 INFO - Cleaning up... 06:34:50 INFO - Return code: 0 06:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:50 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')]} 06:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:50 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')]} 06:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:50 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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:50 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 06:34:50 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 06:34:50 INFO - Using env: {'DISPLAY': ':0', 06:34:50 INFO - 'HOME': '/home/cltbld', 06:34:50 INFO - 'LANG': 'en_US.UTF-8', 06:34:50 INFO - 'LANGUAGE': 'en_US:en', 06:34:50 INFO - 'LOGNAME': 'cltbld', 06:34:50 INFO - 'MAIL': '/var/mail/cltbld', 06:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:50 INFO - 'MOZ_NO_REMOTE': '1', 06:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:50 INFO - 'NO_EM_RESTART': '1', 06:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:50 INFO - 'PWD': '/builds/slave/test', 06:34:50 INFO - 'SHELL': '/bin/bash', 06:34:50 INFO - 'SHLVL': '1', 06:34:50 INFO - 'TERM': 'linux', 06:34:50 INFO - 'TMOUT': '86400', 06:34:50 INFO - 'USER': 'cltbld', 06:34:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:50 INFO - '_': '/tools/buildbot/bin/python'} 06:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:50 INFO - Running setup.py (path:/tmp/pip-WwXDLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:50 INFO - Running setup.py (path:/tmp/pip-aQDZzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:50 INFO - Running setup.py (path:/tmp/pip-jINE74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:50 INFO - Running setup.py (path:/tmp/pip-X6pACX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:50 INFO - Running setup.py (path:/tmp/pip-VW_llp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:50 INFO - Running setup.py (path:/tmp/pip-CRU370-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:50 INFO - Running setup.py (path:/tmp/pip-Uzo9MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:50 INFO - Running setup.py (path:/tmp/pip-XI6nEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:50 INFO - Running setup.py (path:/tmp/pip-8ikfvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:50 INFO - Running setup.py (path:/tmp/pip-PulKis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:51 INFO - Running setup.py (path:/tmp/pip-fYVgCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:51 INFO - Running setup.py (path:/tmp/pip-443Ueb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:51 INFO - Running setup.py (path:/tmp/pip-qU7bOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:51 INFO - Running setup.py (path:/tmp/pip-SFLk_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:51 INFO - Running setup.py (path:/tmp/pip-8Od675-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:51 INFO - Running setup.py (path:/tmp/pip-eEuT44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:51 INFO - Running setup.py (path:/tmp/pip-kYdLvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:34:51 INFO - Running setup.py install for manifestparser 06:34:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:34:51 INFO - Running setup.py install for mozcrash 06:34:51 INFO - Running setup.py install for mozdebug 06:34:51 INFO - Running setup.py install for mozdevice 06:34:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:34:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:34:51 INFO - Running setup.py install for mozfile 06:34:52 INFO - Running setup.py install for mozhttpd 06:34:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Running setup.py install for mozinfo 06:34:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Running setup.py install for mozInstall 06:34:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Running setup.py install for mozleak 06:34:52 INFO - Running setup.py install for mozlog 06:34:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Running setup.py install for moznetwork 06:34:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Running setup.py install for mozprocess 06:34:52 INFO - Running setup.py install for mozprofile 06:34:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:34:52 INFO - Running setup.py install for mozrunner 06:34:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:34:53 INFO - Running setup.py install for mozscreenshot 06:34:53 INFO - Running setup.py install for moztest 06:34:53 INFO - Running setup.py install for mozversion 06:34:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:34:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:34:53 INFO - Cleaning up... 06:34:53 INFO - Return code: 0 06:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:53 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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:53 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 06:34:53 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 06:34:53 INFO - Using env: {'DISPLAY': ':0', 06:34:53 INFO - 'HOME': '/home/cltbld', 06:34:53 INFO - 'LANG': 'en_US.UTF-8', 06:34:53 INFO - 'LANGUAGE': 'en_US:en', 06:34:53 INFO - 'LOGNAME': 'cltbld', 06:34:53 INFO - 'MAIL': '/var/mail/cltbld', 06:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:53 INFO - 'MOZ_NO_REMOTE': '1', 06:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:53 INFO - 'NO_EM_RESTART': '1', 06:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:53 INFO - 'PWD': '/builds/slave/test', 06:34:53 INFO - 'SHELL': '/bin/bash', 06:34:53 INFO - 'SHLVL': '1', 06:34:53 INFO - 'TERM': 'linux', 06:34:53 INFO - 'TMOUT': '86400', 06:34:53 INFO - 'USER': 'cltbld', 06:34:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:53 INFO - '_': '/tools/buildbot/bin/python'} 06:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:53 INFO - Running setup.py (path:/tmp/pip-ZESO2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:53 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)) 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:53 INFO - Running setup.py (path:/tmp/pip-WccGG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:53 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)) 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:53 INFO - Running setup.py (path:/tmp/pip-lymhha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:53 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)) 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:53 INFO - Running setup.py (path:/tmp/pip-BJCIli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:53 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)) 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:53 INFO - Running setup.py (path:/tmp/pip-QmMjMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:53 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)) 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:53 INFO - Running setup.py (path:/tmp/pip-hWgnY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:53 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)) 06:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:53 INFO - Running setup.py (path:/tmp/pip-nlCuuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:54 INFO - Running setup.py (path:/tmp/pip-aG_TQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:54 INFO - Running setup.py (path:/tmp/pip-hIHpgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:54 INFO - Running setup.py (path:/tmp/pip-3QKZts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:54 INFO - Running setup.py (path:/tmp/pip-aS4guP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:54 INFO - Running setup.py (path:/tmp/pip-aedPZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:54 INFO - Running setup.py (path:/tmp/pip-rCC9MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:54 INFO - Running setup.py (path:/tmp/pip-M0ILpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:54 INFO - Running setup.py (path:/tmp/pip-QDi1I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:54 INFO - Running setup.py (path:/tmp/pip-gEuLoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:54 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)) 06:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:54 INFO - Running setup.py (path:/tmp/pip-YWGZCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:54 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)) 06:34:54 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)) 06:34:54 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)) 06:34:54 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)) 06:34:54 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)) 06:34:54 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)) 06:34:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:34:54 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 06:34:54 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 06:34:54 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 06:34:54 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 06:34:54 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 06:34:54 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 06:34:56 INFO - Downloading blessings-1.6.tar.gz 06:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:34:56 INFO - Installing collected packages: blessings 06:34:56 INFO - Running setup.py install for blessings 06:34:56 INFO - Successfully installed blessings 06:34:56 INFO - Cleaning up... 06:34:56 INFO - Return code: 0 06:34:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:57 INFO - Reading from file tmpfile_stdout 06:34:57 INFO - Current package versions: 06:34:57 INFO - argparse == 1.2.1 06:34:57 INFO - blessings == 1.6 06:34:57 INFO - blobuploader == 1.2.4 06:34:57 INFO - docopt == 0.6.1 06:34:57 INFO - functools32 == 3.2.3-2 06:34:57 INFO - jsonschema == 2.5.1 06:34:57 INFO - manifestparser == 1.1 06:34:57 INFO - mozInstall == 1.12 06:34:57 INFO - mozcrash == 0.17 06:34:57 INFO - mozdebug == 0.1 06:34:57 INFO - mozdevice == 0.48 06:34:57 INFO - mozfile == 1.2 06:34:57 INFO - mozhttpd == 0.7 06:34:57 INFO - mozinfo == 0.9 06:34:57 INFO - mozleak == 0.1 06:34:57 INFO - mozlog == 3.3 06:34:57 INFO - moznetwork == 0.27 06:34:57 INFO - mozprocess == 0.23 06:34:57 INFO - mozprofile == 0.28 06:34:57 INFO - mozrunner == 6.12 06:34:57 INFO - mozscreenshot == 0.1 06:34:57 INFO - mozsystemmonitor == 0.3 06:34:57 INFO - moztest == 0.7 06:34:57 INFO - mozversion == 1.4 06:34:57 INFO - psutil == 3.1.1 06:34:57 INFO - requests == 1.2.3 06:34:57 INFO - wsgiref == 0.1.2 06:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:57 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 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:57 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 06:34:57 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 06:34:57 INFO - Using env: {'DISPLAY': ':0', 06:34:57 INFO - 'HOME': '/home/cltbld', 06:34:57 INFO - 'LANG': 'en_US.UTF-8', 06:34:57 INFO - 'LANGUAGE': 'en_US:en', 06:34:57 INFO - 'LOGNAME': 'cltbld', 06:34:57 INFO - 'MAIL': '/var/mail/cltbld', 06:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:57 INFO - 'MOZ_NO_REMOTE': '1', 06:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:57 INFO - 'NO_EM_RESTART': '1', 06:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:57 INFO - 'PWD': '/builds/slave/test', 06:34:57 INFO - 'SHELL': '/bin/bash', 06:34:57 INFO - 'SHLVL': '1', 06:34:57 INFO - 'TERM': 'linux', 06:34:57 INFO - 'TMOUT': '86400', 06:34:57 INFO - 'USER': 'cltbld', 06:34:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:57 INFO - '_': '/tools/buildbot/bin/python'} 06:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 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)) 06:34:57 INFO - Cleaning up... 06:34:57 INFO - Return code: 0 06:34:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', '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 06:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:34:57 INFO - Using env: {'DISPLAY': ':0', 06:34:57 INFO - 'HOME': '/home/cltbld', 06:34:57 INFO - 'LANG': 'en_US.UTF-8', 06:34:57 INFO - 'LANGUAGE': 'en_US:en', 06:34:57 INFO - 'LOGNAME': 'cltbld', 06:34:57 INFO - 'MAIL': '/var/mail/cltbld', 06:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:57 INFO - 'MOZ_NO_REMOTE': '1', 06:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:57 INFO - 'NO_EM_RESTART': '1', 06:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:57 INFO - 'PWD': '/builds/slave/test', 06:34:57 INFO - 'SHELL': '/bin/bash', 06:34:57 INFO - 'SHLVL': '1', 06:34:57 INFO - 'TERM': 'linux', 06:34:57 INFO - 'TMOUT': '86400', 06:34:57 INFO - 'USER': 'cltbld', 06:34:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:57 INFO - '_': '/tools/buildbot/bin/python'} 06:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:34:57 INFO - Cleaning up... 06:34:57 INFO - Return code: 0 06:34:57 INFO - Running post-action listener: _resource_record_post_action 06:34:57 INFO - Running post-action listener: _start_resource_monitoring 06:34:57 INFO - Starting resource monitoring. 06:34:57 INFO - [mozharness: 2016-09-08 13:34:57.638762Z] Finished create-virtualenv step (success) 06:34:57 INFO - [mozharness: 2016-09-08 13:34:57.639188Z] Running install step. 06:34:57 INFO - Running pre-action listener: _resource_record_pre_action 06:34:57 INFO - Running main action method: install 06:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:57 INFO - Reading from file tmpfile_stdout 06:34:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:34:57 INFO - Reading from file tmpfile_stdout 06:34:57 INFO - Output received: 06:34:57 INFO - Usage: mozinstall [options] installer 06:34:57 INFO - Options: 06:34:57 INFO - -h, --help show this help message and exit 06:34:57 INFO - -d DEST, --destination=DEST 06:34:57 INFO - Directory to install application into. [default: 06:34:57 INFO - "/builds/slave/test"] 06:34:57 INFO - --app=APP Application being installed. [default: firefox] 06:34:57 INFO - mkdir: /builds/slave/test/build/application 06:34:57 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'] 06:34:57 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 06:35:14 INFO - Reading from file tmpfile_stdout 06:35:14 INFO - Output received: 06:35:14 INFO - /builds/slave/test/build/application/firefox/firefox 06:35:14 INFO - Running post-action listener: _resource_record_post_action 06:35:14 INFO - [mozharness: 2016-09-08 13:35:14.928875Z] Finished install step (success) 06:35:14 INFO - [mozharness: 2016-09-08 13:35:14.929154Z] Running run-tests step. 06:35:14 INFO - Running pre-action listener: _resource_record_pre_action 06:35:14 INFO - Running main action method: run_tests 06:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:35:14 INFO - Python 2.7.3 06:35:14 INFO - Return code: 0 06:35:14 INFO - grabbing minidump binary from tooltool 06:35:14 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')]} 06:35:14 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 0x1afa570>, '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 0x1afb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:35:14 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 06:35:14 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 06:35:14 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 06:35:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:35:15 INFO - Return code: 0 06:35:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:35:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:35:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:35:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:35:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:35:15 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/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 06:35:15 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/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 06:35:15 INFO - Using env: {'DISPLAY': ':0', 06:35:15 INFO - 'HOME': '/home/cltbld', 06:35:15 INFO - 'LANG': 'en_US.UTF-8', 06:35:15 INFO - 'LANGUAGE': 'en_US:en', 06:35:15 INFO - 'LOGNAME': 'cltbld', 06:35:15 INFO - 'MAIL': '/var/mail/cltbld', 06:35:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:15 INFO - 'MOZ_NO_REMOTE': '1', 06:35:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:15 INFO - 'NO_EM_RESTART': '1', 06:35:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:15 INFO - 'PWD': '/builds/slave/test', 06:35:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:15 INFO - 'SHELL': '/bin/bash', 06:35:15 INFO - 'SHLVL': '1', 06:35:15 INFO - 'TERM': 'linux', 06:35:15 INFO - 'TMOUT': '86400', 06:35:15 INFO - 'USER': 'cltbld', 06:35:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254', 06:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:15 INFO - '_': '/tools/buildbot/bin/python'} 06:35:15 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/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 06:35:15 INFO - mozversion application_buildid: 20160908033016 06:35:15 INFO - mozversion application_changeset: c580c468fdb4a396bde95c2d2b69d2302e88d3ba 06:35:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:35:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:35:15 INFO - mozversion application_name: Firefox 06:35:15 INFO - mozversion application_remotingname: firefox-dev 06:35:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:35:15 INFO - mozversion application_vendor: Mozilla 06:35:15 INFO - mozversion application_version: 50.0a2 06:35:15 INFO - mozversion platform_buildid: 20160908033016 06:35:15 INFO - mozversion platform_changeset: c580c468fdb4a396bde95c2d2b69d2302e88d3ba 06:35:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:35:15 INFO - mozversion platform_version: 50.0a2 06:35:15 INFO - using testdate: 1473341715 06:35:15 INFO - actual date: 1473341715 06:35:15 INFO - starting webserver on 'localhost:60910' 06:35:15 INFO - SUITE-START | Running 2 tests 06:35:15 INFO - TEST-START | dromaeo_css 06:35:15 INFO - operating with platform_type : linux_ 06:35:15 INFO - Initialising browser for dromaeo_css test... 06:35:15 INFO - TEST-INFO | started process 2921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9qYbjh/profile http://localhost:60910/getInfo.html) 06:35:20 INFO - PROCESS | 2921 | __metrics Screen width/height:1600/1200 06:35:20 INFO - PROCESS | 2921 | colorDepth:24 06:35:20 INFO - PROCESS | 2921 | Browser inner width/height: 1024/697 06:35:20 INFO - PROCESS | 2921 | __metrics 06:35:20 ERROR - PROCESS | 2921 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:35:21 INFO - TEST-INFO | 2921: exit 0 06:35:21 INFO - Browser initialized. 06:35:21 INFO - Running cycle 1/1 for dromaeo_css test... 06:35:21 INFO - TEST-INFO | started process 3053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9qYbjh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:33 INFO - PROCESS | 3053 | RSS: Main: 153083904 06:35:33 INFO - PROCESS | 3053 | 06:36:23 INFO - PROCESS | 3053 | 1473341783142 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] 06:38:31 INFO - PROCESS | 3053 | Cycle 1(1): loaded http://localhost:60910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60910/tests/dromaeo/cssquery-ext.html) 06:38:32 INFO - PROCESS | 3053 | RSS: Main: 160288768 06:38:32 INFO - PROCESS | 3053 | 06:41:34 INFO - PROCESS | 3053 | Cycle 1(1): loaded http://localhost:60910/tests/dromaeo/cssquery-ext.html (next: http://localhost:60910/tests/dromaeo/cssquery-jquery.html) 06:41:35 INFO - PROCESS | 3053 | RSS: Main: 155832320 06:41:35 INFO - PROCESS | 3053 | 06:44:37 INFO - PROCESS | 3053 | Cycle 1(1): loaded http://localhost:60910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60910/tests/dromaeo/cssquery-mootools.html) 06:44:37 INFO - PROCESS | 3053 | RSS: Main: 155754496 06:44:37 INFO - PROCESS | 3053 | 06:47:39 INFO - PROCESS | 3053 | Cycle 1(1): loaded http://localhost:60910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60910/tests/dromaeo/cssquery-prototype.html) 06:47:40 INFO - PROCESS | 3053 | RSS: Main: 154742784 06:47:40 INFO - PROCESS | 3053 | 06:50:42 INFO - PROCESS | 3053 | Cycle 1(1): loaded http://localhost:60910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60910/tests/dromaeo/cssquery-yui.html) 06:50:43 INFO - PROCESS | 3053 | RSS: Main: 157163520 06:50:43 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | Cycle 1(1): loaded http://localhost:60910/tests/dromaeo/cssquery-yui.html (next: http://localhost:60910/tests/dromaeo/cssquery-dojo.html) 06:53:45 INFO - PROCESS | 3053 | RSS: Main: 157581312 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | __start_tp_report 06:53:45 INFO - PROCESS | 3053 | _x_x_mozilla_page_load 06:53:45 INFO - PROCESS | 3053 | _x_x_mozilla_page_load_details 06:53:45 INFO - PROCESS | 3053 | |i|pagename|runs| 06:53:45 INFO - PROCESS | 3053 | |0;dojo.html;3210.1011716719318;3237.9838100809493;3243.7729358944866;3245.188702824294;3264.542963985041;5617.494425501704;5690.089585666295;5713.542916566675;5733.569982251327;5760.913586296209;5562.082256427695;5672.602917795745;5681;5732.684702341369;5745.741441635126;5153.433122356538;5169.302144210521;5223.164293713006;5263.31576895005;5287.603429742765;5104.974475127638;5142.820001299955;5144.948550514484;5180.766865491043;5196.168613021917;5201;5209.21861720743;5237.2144178373355;5239.842804715865;5307.787688492455;5279.128943724281;5304.257403963448;5316.494932981361;5328.946710532884;5331.786728530854;4976.900461990776;5059.266406371055;5100.464451232641;5193.065248255312;5201.219817027476;5638.379778224392;5712.343080545749;5727.9427205727825;5747.712614369265;5771.653700777967;6093.177421048191;6103.511719062509;6149.723262453201;6155.538334624921;6179.845503862394;5885.970570147165;5974.4921681657115;6031.638101713911;6196.721147548371;6228.626282423069;5689.857753556194;5694.1458781183155;5716.228309178249;5719.628224165457;5725.856853578653;6255.78104766331;6256.124142620037;6257.7809776658505;6262.968685156545;6286.811395658137;5647.491725744702;5873.207117039145;5928.881422371528;5936.762529498772;5980.790672326448;6093.634381937098;6110.572259941761;6112.144299798032;6119.785807496716;6125.1731016313115;5879.294484661782;5921.141434491975;5965.821025369246;5968.492678122321;5972.910406343908;5838.182654428383;5904.704764761745;5966.224390829165;5978.521718262528;5993.9700301498215;4667.253239481666;4676.602488788491;4684.250519916797;4698.060387922429;4708.411448568929;4179.393987871802;4180.226658068267;4185.665146788249;4200.978995105066;4215.388768628593;5666.235058267163;5783;5806.187133801272;5869.970650146807;5878.500327472213;6164.845878853064;6174.228221472316;6183.907241391383;6196.194494715658;6198.783042593487;5907.527397808165;5936.465718085393;5939.584229104008;5945.989181839098;5964.373740757158;5080.59355251579;5128.384593848762;5171.974140129275;5310.7610157543;5318.946810531923;6192.0711893215475;6276.6547839868335;6317.842053948688;6321.1150438938585;6321.873562528724;6035.366286540026;6085.847853803691;6102.4507794298725;6116.174316467309;6131;6150.600210986271;6205.069239613914;6240.28236752761;6299.433051025429;6305.747770089145;5978.9402105980125;6086.878262434815;6089.117078023751;6118.5411094169;6119.908201376894;6134.798221018219;6186.319504854552;6197.597156184834;6222.875542489215;6235.844103897258;5755.3381361144;5884.9705751470965;6039;6081.801424799517;6095.725692343944;5892.440218179266;5955.731992060281;6008.098785182257;6038.275406951194;6049.3950604939155;5942.821715348547;5994.310654274815;5995.850103747442;5998.610090344114;5998.940010599838;5837.532997360286;5841.1238314253205;6028.2766068072115;6047.274327080779;6052.84867878289;5717.799877004285;5750;5824.039033559416;5833.0375488044;5842.649441033552 06:53:45 INFO - PROCESS | 3053 | |1;ext.html;578.9565782566306;626.733638203763;639.095679613347;661.6757788683545;686.9003994420806;41679.583204167946;45421.31868021974;45623;45842.54157458425;45916.770416147956;47056.52943470564;47491.28763068548;47625.04749905;47695.28457073147;47845;9059.728208153749;9215.216706579915;9254.491002994833;9256.907430925672;9290.674826381079;9110.544472776335;9184.311176661744;9251.6299348026;9259.629614815432;9261.259099272042;9354.625814967427;9403.482808445568;9415.058494150599;9437.245020398352;9452.716418507456;9266.305027122959;9319.580618872167;9329.72010839676;9355.391899526508;9357.251419886392;9151.588178531982;9198.67804626835;9200.585973631203;9227.76930576741;9238.86141707875;44067.77966110181;44299.11401771979;44336.55663443357;44433.77783111064;44446;3449.2066824630474;3734.290484807878;3862.3627101528214;4256.36154576816;4284.700070995032;34936.475952860725;35178.64821351805;35349.29301413983;35860.82069589661;35875.92372228811;4273.1240095780295;4401.317795741666;4408.493023302329;4412.977935110336;4483.30508771141;380844;381824;383375;383399;383824.0808795966;63678.36321636817;64074.679626601566;64224.357756422774;64317;64358;38811.805940970116;39220.21559568793;39271.84004879702;42110.36834447486;67506.66246668735;19344.516387090152;19502.804971950383;19526;19546.70679939802;19592.510187245432;14928.178950157846;14998.400063997537;15029.624259393384;15050.623734406727;15058.472953446577;20745.688814667792;20757.584848302948;21042.684359734616;21178.258760943292;21235.15059397607;7744.57404842739;7822.256885595859;7842.254985776342;7845.137034926153;7899.526028438312;1045.6340280901775;1131.422974283105;1213.1265488848014;1233.4511142541662;1271.7965125579863;33956.660433395846;34080.659193408246;34084.82957585196;34325.828370857984;34504.82747586246;1141.6917432293235;1193.1111322064944;1203.7592481503734;1206.1918514595243;1238.7336722604684;17811.376601818873;18203.362882299058;18415;18456.07719614014;18539.536511587317;578768;582403;583704;586910;589491;65024.674876625315;65381.346186538474;65484.34515654878;65787.67106164535;65944;1450.4415799917108;1461.817272840895;1467.8385377608454;1471.3599584180915;1476.6677497562962;32756;33958.49062264019;33981.15047123842;34168.658313417545;34354.48468272928;61123;62214.37785622267;62686;68795.65602171957;68971;523004;527625;528548;530564.6943530515;532541;49102.26346604733;49518;49534.50465495299;50180.247296289854;50377.74811125921;53492;53572;54231.72884135554;54464.72767636136;54754.17868732052;45427;46548.30177547407;46805;47039.6415951786;47326.29010564776;44204.33693494536;46307.3053904185;46683.53316466928;46751;47471;43214.56785432105;44619.55380446284;45789;45929.77035114803;48318.27522587094;38846;39998.80000600095;40301.39547906842;41163.38254926239;41292.1741565173;30013;30786.69213307838;30826;31120.844395777876;31247.84376078196 06:53:45 INFO - PROCESS | 3053 | |2;jquery.html;385.9845606175753;390.05995550722747;407.2953789943398;412.5874125874125;431.2862213037422;19012.524686882836;19323.420297391065;21271.680924786142;21277.787222127794;21479.463013424673;19961.401157965247;20087.29694460694;20146.89926550369;20401.59196816063;20476.28333008345;5773.942260577403;6022.728977196037;6025.578209525335;6031.396860313956;6034.185384973016;5767.653940763567;5865.677387743673;5904;5932.7330270137945;5987.700614969256;5890.823275301726;5891.734871930752;5897.587168898179;5903.26209223847;5913.201717768089;5719.59962802604;5825.330087040003;5828.854278643025;5885.970570147122;5894.616849904743;5194.117000109953;5226.55574276187;5227.555657769094;5234.8691282717855;5259.579233661336;24675;24678.506429871482;24755.13357032513;25009.374765631004;25647.358816029562;2555.501677172952;2560.8719564021912;2676.330917270682;2891.2482754483776;3019.7282244597873;15445.845541544553;15795.36818527269;15807.956131506078;15810.446634367858;16258.430954916521;2000.8199262066485;2054.30153747725;2067.1937944201773;2115.481706981784;2162.48100455891;66015;84366.57816711;84953.57523212406;85558.57220713857;87816.56091719565;9343.205827504738;9417.529123543796;9777.315587908779;10807.243492955575;11196;13692.589222323346;14548.345324460424;15051.698966020618;15082.54752357431;15103.924480377747;8704.129587041372;8837.204651581389;8856.158664926821;8945.19493245611;9118.908810911938;8668.479891206547;8755.649774008969;8855.247303979233;8946.373753837299;9141;6875.3812156906115;6935.133108361455;7007.073054909941;7013.964930175316;7021.789346319619;2014.143988804752;2015.516276093727;2023.919043238254;2041.8979051047388;2101.621708092558;1041.4063983529468;1063.4044934836515;1089.199438412766;1111.7998760223238;1189.3993533265646;19332.226710931685;20343.18627254923;20846.166153354;20895.68656470154;20939.790602093784;1052.594751020847;1083.041508265191;1103.3710784852558;1111.216592302425;1188.085174415695;11550.249233799776;11886.524539018343;11982.460789264504;12051.638450846489;12061.276323420623;537975;545938;553602;560134;562041;88484.557577213;93129.5343523278;103369.19705120512;104411;109028;1060.9098226650667;1086.4513420722485;1109.5118148014847;1120.6638008597552;1121.657894342217;18976.905115474336;19114.52213694669;19212.231510739974;19331.323403680803;19347.613047739247;40862.182756345304;44845.32732008957;45842.770786145855;46071.76964115292;47885.76057119692;56377.43622563722;60604.393956059874;64234.67882660557;64256;69264.30735692578;8554.828903422022;8678.349123815866;8772.561371931506;8961.507117108622;9022.097790220925;12247.652758196413;13441.932790335986;13599.660008499866;13978.580642580739;15090.849091509384;11189.608363707232;11584.884151158381;12176.756464870476;12345.629631111082;12643.93678031604;12023.579174728842;12176.208546444454;12647.873521265037;12884.549040783528;12946.352682365656;9765.755856103655;11684.240524365889;12452.875471245172;12865.099443038898;12986.675333116747;9245.121713437213;9263.212626926786;9400.247980161708;9421.528923553931;9464.810703786023;11045.502952367324;11559.19085664029;12047.81928271059;12566.120371574269;12616.053795965523 06:53:45 INFO - PROCESS | 3053 | |3;mootools.html;1550.2636247782302;1578.479101896374;1790.979251580202;1872.728454374115;1892.3565987564234;7993.960030199841;8633.266172375348;8723.651053957834;9172.678956236534;9320.440773553591;8873.600687969041;9259.444433334005;9271.629134834615;9276.675316363928;9284.257259419248;2387.6776635154292;2411.577973854577;2430.368104292879;2434.7565243475688;2437.2079074300923;2355.5406695694346;2372.4424760181346;2417.0815090265764;2422.9757702422926;2426.9927979888325;2410.3612542676206;2427.599446091393;2430.2101816909485;2430.8176886733477;2445.6576079348906;2329.988350058256;2360.1267531013464;2367.147826782357;2373.08636175073;2393.1623931623967;2353.0470159585393;2355.340504658698;2355.787979081891;2356.634721618135;2364.113457453455;9190.21883139934;9326.347155699104;9346.439213647203;9365.391249568824;9377.202937750299;5357.4106848246665;5475.206095116186;5503.477169668875;5519.034169020405;5521.475459831349;3309.619393769723;3326.0354497195785;3398.451161628778;3417.3677869593957;3425.4519276915576;1074.425182527344;1076.1874784537702;1083.106437189322;1083.918706097038;1093.2238110941241;12707.174033687781;12712.300823454707;12726.936365318114;12766.234025958473;12786.424610892533;4683.227267500824;4701.858944231679;4835.8065677372515;4836.661433699677;4959.975200124049;10835.241533092765;10875.564977400974;10888.237823352447;10901.182411319183;10925.508352124174;5653.632513886584;5661.207430959669;5671.149327600893;5697.971510142423;5702.0591602385975;4467.419235499365;4991.5258050485145;5102.183650615883;5105.489451054865;5237.083510385667;4071.226466971266;4081.1225586499045;4083.5466286317373;4108.26051310761;4142.46148000758;1335.132164093347;1352.648311439033;1362.6184668292894;1366.152985149214;1367.2206842100106;1000.3297790480395;1012.2610494339174;1038.678009816944;1049.9842502362471;1063.7500187455942;5919.940800592025;6103.298120716086;6191.164192834;6206.162168107338;6284.654344011032;462.6784384852495;470.51066890433566;472.6903877959942;473.94312682478323;483.22683706070006;4186.058136919169;4205.91588168241;4227.196832601796;4227.936580951288;4252.468441444819;10978.12175026012;11150;11232.269902456314;11301.943490282496;11307.095432365391;11208.15938804593;11231.157663175294;11232.269902456477;11240.156988225915;11243.66269011931;8303.4602750821;8530.829383412422;8615.095414981462;8625.137486251324;8630.697925572575;5836.328822185334;6122.938770612237;6236.563440559117;6269.090981807703;6279.560430769802;10323.94838025835;10621.15030797519;10651.254412191072;10679.5194216262;10743.677689669323;10632.946835265775;10644.095251903365;10844.511996959998;10889.455527223448;10893.891061089606;7863.685452581833;8446.324294056338;8665.2634526066;8758.343124265579;8928.553572321229;9066.546672666209;9233.630654773733;9276.814463710552;9279.814403712024;9293.070692930924;7988;7990.400719945911;8014.83970320602;8148.5518296494265;8245.381596380415;7967.163447837894;8023.438359315025;8029.879551806845;8055.7583272501915;8144.185581441809;7031.7890463286185;7312.8537429250055;7349.8162545936775;7406.1482929461645;7408.259174082548;5171.974140129275;5213.504717051874;5213.713245771519;5232.26748255237;5254.106801843772;5209.0363282792805;5217.686938783685;5255.343082114736;5266.78932842682;5266.999270138662 06:53:45 INFO - PROCESS | 3053 | |4;prototype.html;332.1546663740779;341.5627996164909;341.63770740541344;357.13395017083565;358.41220398546386;5691.544676425887;5769.82690519284;5859.501942334901;5933.66492539179;5950.82147535574;5752.252207213067;5801.042827933396;5811.709414529268;5831.912521312183;5833.854153646161;4551.203539380604;4581.656375771814;4602.217623004098;4644.303354496818;4671.617475087695;4500.482444518873;4511.774411279423;4521.954780452186;4594.920193754482;4662.347271382009;4526.977365113186;4542.364069030338;4547.909041819178;4555.430571178603;4576.656750743691;4514.390557274792;4540.160070386973;4569.537747920666;4618.676692631517;4621.884452888671;3765.7928813915223;3955.367141257385;3992.92191108402;4111.794410279504;4131.772752498611;5599.832005039814;5663.451446848934;5671.63134396267;5675.2054712340305;5712.285964254468;5227.189785583203;5234.136367499358;5239.973800130975;5254.448282930313;5279.128943724281;5846.970765146147;6063.18147050147;6089.360617135226;6092.238470191226;6192.721327540272;4293;4317.84797098117;4342.261815491374;4344.695871289011;4357.150355680644;6180.505559555225;6369.853426383249;6442.549021568492;6450.580712253689;6489.772857949949;4442.378067070613;4469.9553004469535;4477.977610111994;4499.437570303712;4514.164879497303;4561.498235194126;4591.311303304531;4594.770261486912;4603.884902877455;4605.078984203173;5138.434772175057;5235.267062611238;5246.449122842123;5256;5256.947430525723;5890.970545147333;6107.572469927151;6154.969225153845;6170.969145154246;6192.411720886508;1550.5968448203548;1568.0434934689831;1573.590866374728;1580.8143892080939;1580.9170718058167;970.8204531494268;1001.1490233301781;1005.5676059294427;1023.155896385485;1024.9641262555774;5204.531592156648;5256.26412302278;5275.261463395128;5275.630705850554;5284.365876094893;5464.808731694372;5543.6396634218645;5546.25460397098;5557.305336832896;5559.471850174227;5008.6744361616375;5262.131943160123;5292.7032876945395;5304.257403963448;5328.333958255218;2965.31797686529;3001.5797788309656;3001.654809696869;3015.532592448174;3018.9886388060245;5525.484670326985;5713.685747283939;5723.713814309268;5768.596198266081;5803.040449370851;5572.888542229132;5678.488935995698;5691.402402747734;5703.437250199907;5751.252337196138;5694.5159661428415;5714;5726.484616384545;5730.484256416942;5738.225339579103;5260.736963151904;5443.747937974367;5469.288992430958;5492.80775172867;5533.889322213614;5391.541718953933;5400.244920400964;5420.7289635518855;5463.836084917459;5464.551893748239;5586.329640443173;5705.657660540215;5712.6001179917;5731.340895797037;5782.409837294777;3937.625925537069;3965.2466031453932;4023.631965131869;4057.4116753070048;4072;5478.178273259043;5494.835154945358;5515.552779512805;6018.909716354171;6151.6924153793025;6110.26676798787;6126.632402055891;6151.507879369729;6155;6184.350643182401;6004.159417681615;6117.204763380732;6165.938340616536;6174.25908890936;6175.3515880831865;6067.393260674074;6106.664133472702;6111.327753946974;6117.388261173847;6171.161265817774;6213.943629582891;6234.781782637768;6243.875122497434;6257.249130104235;6264.718087685974;5870.326956817457;5938.673372964528;6020.916235077728;6052.273727152769;6078.416672913905 06:53:45 INFO - PROCESS | 3053 | |5;yui.html;800.1998001997998;815.5442535074892;882.7616543533246;927.7680579855038;939.0234156477264;15320.463783767571;16576;16632.33470661172;16647.91676041621;16698.66602667946;14962.775558366606;16241.918790406062;16403.343866245337;16426.507204783844;16538.751918721227;877.4691311756392;894.4186278918722;895.852184389575;897.3987428422939;898.3801177187752;863.0549548244662;864.6498168241872;874.3355050161891;874.7375787263795;874.9912500875005;921.2261700171854;925.0887875442684;928.1368327455464;929.9209567186764;932.1424289653501;918.7611221082567;921.0329154387899;923.8706581078654;926.5922993882704;927.9304052196112;680.4420375292262;681.1791790891963;681.2914568848441;681.6012632609929;683.1904193530683;14573;14754.262286885612;14756.262186890612;14782.778258326134;14821.703565928728;14429.711405771826;14453.638659033502;14708.338124784303;14945.17801520916;15115.39538418462;14353.641158971004;14553.490627827976;14562.952831217226;14715;14807;4714.929276060861;4716.8349107781405;4723.622110231207;4730.408698912636;4766.666333356632;92881.53559232228;93078;93644;95906;96210.51894740551;12123.393830308449;12312.938435307946;12514.31171285588;12609.432575534123;12913.160644558073;20779.79220207809;20802;20823.895880520802;20914.686279705817;20924.476888077614;8986.236169925498;8997.595108220146;9057.36598438103;9152.606748760632;9171.678991235274;5140.691558506502;5151.479078626284;5179.715115668599;5272.340957380327;5326.174442961347;3827.2919509890758;3914.099757055836;3941.5270167580074;3941.9014524637114;3948.368261078214;666.4601672645173;671.3286713286714;676.4588329336511;679.4632240530025;687.6011913090396;526.6892533405232;562.6117978594757;566.4250785452768;626.4049153304379;632.2570979099539;9680.806383872425;11184.273022253528;11741.941290293495;11783.469743861548;12225.02199824012;669.3774789445862;731.9634018299171;758.0524344569288;823.4194892600702;826.6197549127469;4939.678920870132;5408.945910540844;5418.512333889968;5435.1303791393975;5451.509364157245;70770;71861.28138718651;110626;111515.88484115218;117294.89467868584;86536.567317163;87715;88669;98568;100530;88391;90621;92648.53675731712;93604.0639593609;95430.52284738532;10601.1519078472;10752.569897204337;10824.729381765204;10894.291871028357;11160.162987776112;55511;55520;55710.16434753401;56449.71775141098;57892.421075788705;72522.27477725156;73978.63010685127;80078.19921800708;80112.59943700244;81568;13606.727865442834;13751.312434378442;14241.50154744579;14498.927505362406;14764.852351476777;14899.255037248311;16329.856910016184;16747.1626418681;16951.576210594834;17033.14834258307;15320.779123858714;15357.33498037486;15591.532254032398;15954.760678590063;16316.755248671518;14663.900207484268;14980.625484362978;16043.919780401024;16068.839311606735;16254.945359655712;13336.266505342299;13366.198028118344;13786.65533361674;14163.929180354033;14321.928390357982;11471.139664525028;11650.359230242419;11977.161598688008;12226.144169908377;12302.753944920873;11978.46096925658;13171.407286672315;13205.933970330087;13269.270190139636;13407.195568265935 06:53:45 INFO - PROCESS | 3053 | __end_tp_report 06:53:45 INFO - PROCESS | 3053 | __start_cc_report 06:53:45 INFO - PROCESS | 3053 | _x_x_mozilla_cycle_collect,344 06:53:45 INFO - PROCESS | 3053 | __end_cc_report 06:53:45 INFO - PROCESS | 3053 | __startTimestamp1473342825729__endTimestamp 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | ------- Summary: start ------- 06:53:45 INFO - PROCESS | 3053 | Number of tests: 6 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | [#0] dojo.html Cycles:165 Average:5666.94 Median:5884.97 stddev:645.75 (11.0%) stddev-sans-first:618.30 06:53:45 INFO - PROCESS | 3053 | Values: 3210.1 3238.0 3243.8 3245.2 3264.5 5617.5 5690.1 5713.5 5733.6 5760.9 5562.1 5672.6 5681.0 5732.7 5745.7 5153.4 5169.3 5223.2 5263.3 5287.6 5105.0 5142.8 5144.9 5180.8 5196.2 5201.0 5209.2 5237.2 5239.8 5307.8 5279.1 5304.3 5316.5 5328.9 5331.8 4976.9 5059.3 5100.5 5193.1 5201.2 5638.4 5712.3 5727.9 5747.7 5771.7 6093.2 6103.5 6149.7 6155.5 6179.8 5886.0 5974.5 6031.6 6196.7 6228.6 5689.9 5694.1 5716.2 5719.6 5725.9 6255.8 6256.1 6257.8 6263.0 6286.8 5647.5 5873.2 5928.9 5936.8 5980.8 6093.6 6110.6 6112.1 6119.8 6125.2 5879.3 5921.1 5965.8 5968.5 5972.9 5838.2 5904.7 5966.2 5978.5 5994.0 4667.3 4676.6 4684.3 4698.1 4708.4 4179.4 4180.2 4185.7 4201.0 4215.4 5666.2 5783.0 5806.2 5870.0 5878.5 6164.8 6174.2 6183.9 6196.2 6198.8 5907.5 5936.5 5939.6 5946.0 5964.4 5080.6 5128.4 5172.0 5310.8 5318.9 6192.1 6276.7 6317.8 6321.1 6321.9 6035.4 6085.8 6102.5 6116.2 6131.0 6150.6 6205.1 6240.3 6299.4 6305.7 5978.9 6086.9 6089.1 6118.5 6119.9 6134.8 6186.3 6197.6 6222.9 6235.8 5755.3 5885.0 6039.0 6081.8 6095.7 5892.4 5955.7 6008.1 6038.3 6049.4 5942.8 5994.3 5995.9 5998.6 5998.9 5837.5 5841.1 6028.3 6047.3 6052.8 5717.8 5750.0 5824.0 5833.0 5842.6 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | [#1] ext.html Cycles:180 Average:67489.76 Median:45706.00 stddev:134121.40 (293.4%) stddev-sans-first:134403.56 06:53:45 INFO - PROCESS | 3053 | Values: 579.0 626.7 639.1 661.7 686.9 41679.6 45421.3 45623.0 45842.5 45916.8 47056.5 47491.3 47625.0 47695.3 47845.0 9059.7 9215.2 9254.5 9256.9 9290.7 9110.5 9184.3 9251.6 9259.6 9261.3 9354.6 9403.5 9415.1 9437.2 9452.7 9266.3 9319.6 9329.7 9355.4 9357.3 9151.6 9198.7 9200.6 9227.8 9238.9 44067.8 44299.1 44336.6 44433.8 44446.0 3449.2 3734.3 3862.4 4256.4 4284.7 34936.5 35178.6 35349.3 35860.8 35875.9 4273.1 4401.3 4408.5 4413.0 4483.3 380844.0 381824.0 383375.0 383399.0 383824.1 63678.4 64074.7 64224.4 64317.0 64358.0 38811.8 39220.2 39271.8 42110.4 67506.7 19344.5 19502.8 19526.0 19546.7 19592.5 14928.2 14998.4 15029.6 15050.6 15058.5 20745.7 20757.6 21042.7 21178.3 21235.2 7744.6 7822.3 7842.3 7845.1 7899.5 1045.6 1131.4 1213.1 1233.5 1271.8 33956.7 34080.7 34084.8 34325.8 34504.8 1141.7 1193.1 1203.8 1206.2 1238.7 17811.4 18203.4 18415.0 18456.1 18539.5 578768.0 582403.0 583704.0 586910.0 589491.0 65024.7 65381.3 65484.3 65787.7 65944.0 1450.4 1461.8 1467.8 1471.4 1476.7 32756.0 33958.5 33981.2 34168.7 34354.5 61123.0 62214.4 62686.0 68795.7 68971.0 523004.0 527625.0 528548.0 530564.7 532541.0 49102.3 49518.0 49534.5 50180.2 50377.7 53492.0 53572.0 54231.7 54464.7 54754.2 45427.0 46548.3 46805.0 47039.6 47326.3 44204.3 46307.3 46683.5 46751.0 47471.0 43214.6 44619.6 45789.0 45929.8 48318.3 38846.0 39998.8 40301.4 41163.4 41292.2 30013.0 30786.7 30826.0 31120.8 31247.8 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | [#2] jquery.html Cycles:180 Average:31768.42 Median:24716.82 stddev:90841.84 (367.5%) stddev-sans-first:91066.11 06:53:45 INFO - PROCESS | 3053 | Values: 386.0 390.1 407.3 412.6 431.3 19012.5 19323.4 21271.7 21277.8 21479.5 19961.4 20087.3 20146.9 20401.6 20476.3 5773.9 6022.7 6025.6 6031.4 6034.2 5767.7 5865.7 5904.0 5932.7 5987.7 5890.8 5891.7 5897.6 5903.3 5913.2 5719.6 5825.3 5828.9 5886.0 5894.6 5194.1 5226.6 5227.6 5234.9 5259.6 24675.0 24678.5 24755.1 25009.4 25647.4 2555.5 2560.9 2676.3 2891.2 3019.7 15445.8 15795.4 15808.0 15810.4 16258.4 2000.8 2054.3 2067.2 2115.5 2162.5 66015.0 84366.6 84953.6 85558.6 87816.6 9343.2 9417.5 9777.3 10807.2 11196.0 13692.6 14548.3 15051.7 15082.5 15103.9 8704.1 8837.2 8856.2 8945.2 9118.9 8668.5 8755.6 8855.2 8946.4 9141.0 6875.4 6935.1 7007.1 7014.0 7021.8 2014.1 2015.5 2023.9 2041.9 2101.6 1041.4 1063.4 1089.2 1111.8 1189.4 19332.2 20343.2 20846.2 20895.7 20939.8 1052.6 1083.0 1103.4 1111.2 1188.1 11550.2 11886.5 11982.5 12051.6 12061.3 537975.0 545938.0 553602.0 560134.0 562041.0 88484.6 93129.5 103369.2 104411.0 109028.0 1060.9 1086.5 1109.5 1120.7 1121.7 18976.9 19114.5 19212.2 19331.3 19347.6 40862.2 44845.3 45842.8 46071.8 47885.8 56377.4 60604.4 64234.7 64256.0 69264.3 8554.8 8678.3 8772.6 8961.5 9022.1 12247.7 13441.9 13599.7 13978.6 15090.8 11189.6 11584.9 12176.8 12345.6 12643.9 12023.6 12176.2 12647.9 12884.5 12946.4 9765.8 11684.2 12452.9 12865.1 12986.7 9245.1 9263.2 9400.2 9421.5 9464.8 11045.5 11559.2 12047.8 12566.1 12616.1 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | [#3] mootools.html Cycles:180 Average:6040.99 Median:2465.05 stddev:3476.07 (141.0%) stddev-sans-first:3469.44 06:53:45 INFO - PROCESS | 3053 | Values: 1550.3 1578.5 1791.0 1872.7 1892.4 7994.0 8633.3 8723.7 9172.7 9320.4 8873.6 9259.4 9271.6 9276.7 9284.3 2387.7 2411.6 2430.4 2434.8 2437.2 2355.5 2372.4 2417.1 2423.0 2427.0 2410.4 2427.6 2430.2 2430.8 2445.7 2330.0 2360.1 2367.1 2373.1 2393.2 2353.0 2355.3 2355.8 2356.6 2364.1 9190.2 9326.3 9346.4 9365.4 9377.2 5357.4 5475.2 5503.5 5519.0 5521.5 3309.6 3326.0 3398.5 3417.4 3425.5 1074.4 1076.2 1083.1 1083.9 1093.2 12707.2 12712.3 12726.9 12766.2 12786.4 4683.2 4701.9 4835.8 4836.7 4960.0 10835.2 10875.6 10888.2 10901.2 10925.5 5653.6 5661.2 5671.1 5698.0 5702.1 4467.4 4991.5 5102.2 5105.5 5237.1 4071.2 4081.1 4083.5 4108.3 4142.5 1335.1 1352.6 1362.6 1366.2 1367.2 1000.3 1012.3 1038.7 1050.0 1063.8 5919.9 6103.3 6191.2 6206.2 6284.7 462.7 470.5 472.7 473.9 483.2 4186.1 4205.9 4227.2 4227.9 4252.5 10978.1 11150.0 11232.3 11301.9 11307.1 11208.2 11231.2 11232.3 11240.2 11243.7 8303.5 8530.8 8615.1 8625.1 8630.7 5836.3 6122.9 6236.6 6269.1 6279.6 10323.9 10621.2 10651.3 10679.5 10743.7 10632.9 10644.1 10844.5 10889.5 10893.9 7863.7 8446.3 8665.3 8758.3 8928.6 9066.5 9233.6 9276.8 9279.8 9293.1 7988.0 7990.4 8014.8 8148.6 8245.4 7967.2 8023.4 8029.9 8055.8 8144.2 7031.8 7312.9 7349.8 7406.1 7408.3 5172.0 5213.5 5213.7 5232.3 5254.1 5209.0 5217.7 5255.3 5266.8 5267.0 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | [#4] prototype.html Cycles:180 Average:4944.96 Median:5464.68 stddev:1427.19 (26.1%) stddev-sans-first:1388.56 06:53:45 INFO - PROCESS | 3053 | Values: 332.2 341.6 341.6 357.1 358.4 5691.5 5769.8 5859.5 5933.7 5950.8 5752.3 5801.0 5811.7 5831.9 5833.9 4551.2 4581.7 4602.2 4644.3 4671.6 4500.5 4511.8 4522.0 4594.9 4662.3 4527.0 4542.4 4547.9 4555.4 4576.7 4514.4 4540.2 4569.5 4618.7 4621.9 3765.8 3955.4 3992.9 4111.8 4131.8 5599.8 5663.5 5671.6 5675.2 5712.3 5227.2 5234.1 5240.0 5254.4 5279.1 5847.0 6063.2 6089.4 6092.2 6192.7 4293.0 4317.8 4342.3 4344.7 4357.2 6180.5 6369.9 6442.5 6450.6 6489.8 4442.4 4470.0 4478.0 4499.4 4514.2 4561.5 4591.3 4594.8 4603.9 4605.1 5138.4 5235.3 5246.4 5256.0 5256.9 5891.0 6107.6 6155.0 6171.0 6192.4 1550.6 1568.0 1573.6 1580.8 1580.9 970.8 1001.1 1005.6 1023.2 1025.0 5204.5 5256.3 5275.3 5275.6 5284.4 5464.8 5543.6 5546.3 5557.3 5559.5 5008.7 5262.1 5292.7 5304.3 5328.3 2965.3 3001.6 3001.7 3015.5 3019.0 5525.5 5713.7 5723.7 5768.6 5803.0 5572.9 5678.5 5691.4 5703.4 5751.3 5694.5 5714.0 5726.5 5730.5 5738.2 5260.7 5443.7 5469.3 5492.8 5533.9 5391.5 5400.2 5420.7 5463.8 5464.6 5586.3 5705.7 5712.6 5731.3 5782.4 3937.6 3965.2 4023.6 4057.4 4072.0 5478.2 5494.8 5515.6 6018.9 6151.7 6110.3 6126.6 6151.5 6155.0 6184.4 6004.2 6117.2 6165.9 6174.3 6175.4 6067.4 6106.7 6111.3 6117.4 6171.2 6213.9 6234.8 6243.9 6257.2 6264.7 5870.3 5938.7 6020.9 6052.3 6078.4 06:53:45 INFO - PROCESS | 3053 | 06:53:45 INFO - PROCESS | 3053 | [#5] yui.html Cycles:180 Average:21591.49 Median:4727.02 stddev:29790.85 (630.2%) stddev-sans-first:29833.51 06:53:45 INFO - PROCESS | 3053 | Values: 800.2 815.5 882.8 927.8 939.0 15320.5 16576.0 16632.3 16647.9 16698.7 14962.8 16241.9 16403.3 16426.5 16538.8 877.5 894.4 895.9 897.4 898.4 863.1 864.6 874.3 874.7 875.0 921.2 925.1 928.1 929.9 932.1 918.8 921.0 923.9 926.6 927.9 680.4 681.2 681.3 681.6 683.2 14573.0 14754.3 14756.3 14782.8 14821.7 14429.7 14453.6 14708.3 14945.2 15115.4 14353.6 14553.5 14563.0 14715.0 14807.0 4714.9 4716.8 4723.6 4730.4 4766.7 92881.5 93078.0 93644.0 95906.0 96210.5 12123.4 12312.9 12514.3 12609.4 12913.2 20779.8 20802.0 20823.9 20914.7 20924.5 8986.2 8997.6 9057.4 9152.6 9171.7 5140.7 5151.5 5179.7 5272.3 5326.2 3827.3 3914.1 3941.5 3941.9 3948.4 666.5 671.3 676.5 679.5 687.6 526.7 562.6 566.4 626.4 632.3 9680.8 11184.3 11741.9 11783.5 12225.0 669.4 732.0 758.1 823.4 826.6 4939.7 5408.9 5418.5 5435.1 5451.5 70770.0 71861.3 110626.0 111515.9 117294.9 86536.6 87715.0 88669.0 98568.0 100530.0 88391.0 90621.0 92648.5 93604.1 95430.5 10601.2 10752.6 10824.7 10894.3 11160.2 55511.0 55520.0 55710.2 56449.7 57892.4 72522.3 73978.6 80078.2 80112.6 81568.0 13606.7 13751.3 14241.5 14498.9 14764.9 14899.3 16329.9 16747.2 16951.6 17033.1 15320.8 15357.3 15591.5 15954.8 16316.8 14663.9 14980.6 16043.9 16068.8 16254.9 13336.3 13366.2 13786.7 14163.9 14321.9 11471.1 11650.4 11977.2 12226.1 12302.8 11978.5 13171.4 13205.9 13269.3 13407.2 06:53:45 INFO - PROCESS | 3053 | -------- Summary: end -------- 06:53:45 INFO - PROCESS | 3053 | 06:53:46 INFO - TEST-INFO | 3053: exit 0 06:53:46 INFO - TEST-OK | dromaeo_css | took 1111278ms 06:53:46 INFO - TEST-START | kraken 06:53:46 INFO - operating with platform_type : linux_ 06:53:46 INFO - Initialising browser for kraken test... 06:53:46 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA8OGms/profile http://localhost:60910/getInfo.html) 06:53:51 INFO - PROCESS | 3315 | __metrics Screen width/height:1600/1200 06:53:51 INFO - PROCESS | 3315 | colorDepth:24 06:53:51 INFO - PROCESS | 3315 | Browser inner width/height: 1024/697 06:53:51 INFO - PROCESS | 3315 | __metrics 06:53:52 ERROR - PROCESS | 3315 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:53:52 INFO - TEST-INFO | 3315: exit 0 06:53:52 INFO - Browser initialized. 06:53:52 INFO - Running cycle 1/1 for kraken test... 06:53:52 INFO - TEST-INFO | started process 3441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA8OGms/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:04 INFO - PROCESS | 3441 | RSS: Main: 153583616 06:54:04 INFO - PROCESS | 3441 | 06:54:07 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60910/tests/kraken/driver.html?testName=audio-beat-detection) 06:54:08 INFO - PROCESS | 3441 | RSS: Main: 158957568 06:54:08 INFO - PROCESS | 3441 | 06:54:10 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60910/tests/kraken/driver.html?testName=audio-dft) 06:54:11 INFO - PROCESS | 3441 | RSS: Main: 157396992 06:54:11 INFO - PROCESS | 3441 | 06:54:14 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60910/tests/kraken/driver.html?testName=audio-fft) 06:54:14 INFO - PROCESS | 3441 | RSS: Main: 158535680 06:54:14 INFO - PROCESS | 3441 | 06:54:16 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60910/tests/kraken/driver.html?testName=audio-oscillator) 06:54:17 INFO - PROCESS | 3441 | RSS: Main: 157966336 06:54:17 INFO - PROCESS | 3441 | 06:54:19 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:54:20 INFO - PROCESS | 3441 | RSS: Main: 157687808 06:54:20 INFO - PROCESS | 3441 | 06:54:23 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60910/tests/kraken/driver.html?testName=imaging-darkroom) 06:54:23 INFO - PROCESS | 3441 | RSS: Main: 158208000 06:54:23 INFO - PROCESS | 3441 | 06:54:27 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60910/tests/kraken/driver.html?testName=imaging-desaturate) 06:54:27 INFO - PROCESS | 3441 | RSS: Main: 156172288 06:54:27 INFO - PROCESS | 3441 | 06:54:30 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60910/tests/kraken/driver.html?testName=json-parse-financial) 06:54:31 INFO - PROCESS | 3441 | RSS: Main: 157466624 06:54:31 INFO - PROCESS | 3441 | 06:54:33 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:54:33 INFO - PROCESS | 3441 | RSS: Main: 157974528 06:54:33 INFO - PROCESS | 3441 | 06:54:35 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:54:36 INFO - PROCESS | 3441 | RSS: Main: 157188096 06:54:36 INFO - PROCESS | 3441 | 06:54:38 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:54:38 INFO - PROCESS | 3441 | RSS: Main: 157577216 06:54:38 INFO - PROCESS | 3441 | 06:54:41 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:54:41 INFO - PROCESS | 3441 | RSS: Main: 158277632 06:54:41 INFO - PROCESS | 3441 | 06:54:44 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:54:45 INFO - PROCESS | 3441 | RSS: Main: 158638080 06:54:45 INFO - PROCESS | 3441 | 06:54:46 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:60910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60910/tests/kraken/driver.html?testName=ai-astar) 06:54:47 INFO - PROCESS | 3441 | RSS: Main: 160116736 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | __start_tp_report 06:54:47 INFO - PROCESS | 3441 | _x_x_mozilla_page_load 06:54:47 INFO - PROCESS | 3441 | _x_x_mozilla_page_load_details 06:54:47 INFO - PROCESS | 3441 | |i|pagename|runs| 06:54:47 INFO - PROCESS | 3441 | |0;ai-astar;107;111;103;109;110;111;97;111;110;111 06:54:47 INFO - PROCESS | 3441 | |1;audio-beat-detection;143;121;144;173;118;141;148;117;164;116 06:54:47 INFO - PROCESS | 3441 | |2;audio-dft;163;161;164;161;162;162;162;162;163;160 06:54:47 INFO - PROCESS | 3441 | |3;audio-fft;75;76;75;165;77;75;76;76;171;75 06:54:47 INFO - PROCESS | 3441 | |4;audio-oscillator;83;85;145;84;84;94;149;83;83;135 06:54:47 INFO - PROCESS | 3441 | |5;imaging-gaussian-blur;117;118;118;117;118;117;122;117;117;118 06:54:47 INFO - PROCESS | 3441 | |6;imaging-darkroom;148;147;147;148;146;146;147;147;147;147 06:54:47 INFO - PROCESS | 3441 | |7;imaging-desaturate;94;95;98;100;96;95;96;96;96;95 06:54:47 INFO - PROCESS | 3441 | |8;json-parse-financial;53;54;54;54;53;55;61;53;53;54 06:54:47 INFO - PROCESS | 3441 | |9;json-stringify-tinderbox;60;61;60;60;61;60;62;60;60;59 06:54:47 INFO - PROCESS | 3441 | |10;stanford-crypto-aes;73;74;82;78;73;75;72;72;74;73 06:54:47 INFO - PROCESS | 3441 | |11;stanford-crypto-ccm;133;122;123;117;120;119;119;135;154;125 06:54:47 INFO - PROCESS | 3441 | |12;stanford-crypto-pbkdf2;159;156;161;151;152;152;150;152;154;149 06:54:47 INFO - PROCESS | 3441 | |13;stanford-crypto-sha256-iterative;67;62;61;62;61;70;60;62;61;64 06:54:47 INFO - PROCESS | 3441 | __end_tp_report 06:54:47 INFO - PROCESS | 3441 | __start_cc_report 06:54:47 INFO - PROCESS | 3441 | _x_x_mozilla_cycle_collect,878 06:54:47 INFO - PROCESS | 3441 | __end_cc_report 06:54:47 INFO - PROCESS | 3441 | __startTimestamp1473342887130__endTimestamp 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | ------- Summary: start ------- 06:54:47 INFO - PROCESS | 3441 | Number of tests: 14 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#0] ai-astar Cycles:10 Average:108.00 Median:111.00 stddev:4.62 (4.2%) stddev-sans-first:4.88 06:54:47 INFO - PROCESS | 3441 | Values: 107.0 111.0 103.0 109.0 110.0 111.0 97.0 111.0 110.0 111.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:143.50 stddev:20.23 (14.1%) stddev-sans-first:21.39 06:54:47 INFO - PROCESS | 3441 | Values: 143.0 121.0 144.0 173.0 118.0 141.0 148.0 117.0 164.0 116.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 06:54:47 INFO - PROCESS | 3441 | Values: 163.0 161.0 164.0 161.0 162.0 162.0 162.0 162.0 163.0 160.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:38.98 (51.6%) stddev-sans-first:40.73 06:54:47 INFO - PROCESS | 3441 | Values: 75.0 76.0 75.0 165.0 77.0 75.0 76.0 76.0 171.0 75.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:83.50 stddev:28.34 (33.9%) stddev-sans-first:29.17 06:54:47 INFO - PROCESS | 3441 | Values: 83.0 85.0 145.0 84.0 84.0 94.0 149.0 83.0 83.0 135.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 06:54:47 INFO - PROCESS | 3441 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 122.0 117.0 117.0 118.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 06:54:47 INFO - PROCESS | 3441 | Values: 148.0 147.0 147.0 148.0 146.0 146.0 147.0 147.0 147.0 147.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.73 (1.8%) stddev-sans-first:1.66 06:54:47 INFO - PROCESS | 3441 | Values: 94.0 95.0 98.0 100.0 96.0 95.0 96.0 96.0 96.0 95.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.41 (4.5%) stddev-sans-first:2.51 06:54:47 INFO - PROCESS | 3441 | Values: 53.0 54.0 54.0 54.0 53.0 55.0 61.0 53.0 53.0 54.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 06:54:47 INFO - PROCESS | 3441 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 62.0 60.0 60.0 59.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:3.13 (4.2%) stddev-sans-first:3.27 06:54:47 INFO - PROCESS | 3441 | Values: 73.0 74.0 82.0 78.0 73.0 75.0 72.0 72.0 74.0 73.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:124.00 stddev:11.30 (9.1%) stddev-sans-first:11.76 06:54:47 INFO - PROCESS | 3441 | Values: 133.0 122.0 123.0 117.0 120.0 119.0 119.0 135.0 154.0 125.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.00 stddev:3.92 (2.6%) stddev-sans-first:3.64 06:54:47 INFO - PROCESS | 3441 | Values: 159.0 156.0 161.0 151.0 152.0 152.0 150.0 152.0 154.0 149.0 06:54:47 INFO - PROCESS | 3441 | 06:54:47 INFO - PROCESS | 3441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.00 stddev:3.16 (5.1%) stddev-sans-first:3.00 06:54:47 INFO - PROCESS | 3441 | Values: 67.0 62.0 61.0 62.0 61.0 70.0 60.0 62.0 61.0 64.0 06:54:47 INFO - PROCESS | 3441 | -------- Summary: end -------- 06:54:47 INFO - PROCESS | 3441 | 06:54:48 INFO - TEST-INFO | 3441: exit 0 06:54:48 INFO - TEST-OK | kraken | took 61648ms 06:54:48 INFO - SUITE-END | took 1172s 06:54:48 INFO - Completed test suite (00:19:33) 06:54:48 INFO - javascript benchmark 06:54:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7733.546482663388, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.1011716719318, 3237.9838100809493, 3243.7729358944866, 3245.188702824294, 3264.542963985041, 5617.494425501704, 5690.089585666295, 5713.542916566675, 5733.569982251327, 5760.913586296209, 5562.082256427695, 5672.602917795745, 5681.0, 5732.684702341369, 5745.741441635126, 5153.433122356538, 5169.302144210521, 5223.164293713006, 5263.31576895005, 5287.603429742765, 5104.974475127638, 5142.820001299955, 5144.948550514484, 5180.766865491043, 5196.168613021917, 5201.0, 5209.21861720743, 5237.2144178373355, 5239.842804715865, 5307.787688492455, 5279.128943724281, 5304.257403963448, 5316.494932981361, 5328.946710532884, 5331.786728530854, 4976.900461990776, 5059.266406371055, 5100.464451232641, 5193.065248255312, 5201.219817027476, 5638.379778224392, 5712.343080545749, 5727.9427205727825, 5747.712614369265, 5771.653700777967, 6093.177421048191, 6103.511719062509, 6149.723262453201, 6155.538334624921, 6179.845503862394, 5885.970570147165, 5974.4921681657115, 6031.638101713911, 6196.721147548371, 6228.626282423069, 5689.857753556194, 5694.1458781183155, 5716.228309178249, 5719.628224165457, 5725.856853578653, 6255.78104766331, 6256.124142620037, 6257.7809776658505, 6262.968685156545, 6286.811395658137, 5647.491725744702, 5873.207117039145, 5928.881422371528, 5936.762529498772, 5980.790672326448, 6093.634381937098, 6110.572259941761, 6112.144299798032, 6119.785807496716, 6125.1731016313115, 5879.294484661782, 5921.141434491975, 5965.821025369246, 5968.492678122321, 5972.910406343908, 5838.182654428383, 5904.704764761745, 5966.224390829165, 5978.521718262528, 5993.9700301498215, 4667.253239481666, 4676.602488788491, 4684.250519916797, 4698.060387922429, 4708.411448568929, 4179.393987871802, 4180.226658068267, 4185.665146788249, 4200.978995105066, 4215.388768628593, 5666.235058267163, 5783.0, 5806.187133801272, 5869.970650146807, 5878.500327472213, 6164.845878853064, 6174.228221472316, 6183.907241391383, 6196.194494715658, 6198.783042593487, 5907.527397808165, 5936.465718085393, 5939.584229104008, 5945.989181839098, 5964.373740757158, 5080.59355251579, 5128.384593848762, 5171.974140129275, 5310.7610157543, 5318.946810531923, 6192.0711893215475, 6276.6547839868335, 6317.842053948688, 6321.1150438938585, 6321.873562528724, 6035.366286540026, 6085.847853803691, 6102.4507794298725, 6116.174316467309, 6131.0, 6150.600210986271, 6205.069239613914, 6240.28236752761, 6299.433051025429, 6305.747770089145, 5978.9402105980125, 6086.878262434815, 6089.117078023751, 6118.5411094169, 6119.908201376894, 6134.798221018219, 6186.319504854552, 6197.597156184834, 6222.875542489215, 6235.844103897258, 5755.3381361144, 5884.9705751470965, 6039.0, 6081.801424799517, 6095.725692343944, 5892.440218179266, 5955.731992060281, 6008.098785182257, 6038.275406951194, 6049.3950604939155, 5942.821715348547, 5994.310654274815, 5995.850103747442, 5998.610090344114, 5998.940010599838, 5837.532997360286, 5841.1238314253205, 6028.2766068072115, 6047.274327080779, 6052.84867878289, 5717.799877004285, 5750.0, 5824.039033559416, 5833.0375488044, 5842.649441033552], "value": 5622.802137519272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9565782566306, 626.733638203763, 639.095679613347, 661.6757788683545, 686.9003994420806, 41679.583204167946, 45421.31868021974, 45623.0, 45842.54157458425, 45916.770416147956, 47056.52943470564, 47491.28763068548, 47625.04749905, 47695.28457073147, 47845.0, 9059.728208153749, 9215.216706579915, 9254.491002994833, 9256.907430925672, 9290.674826381079, 9110.544472776335, 9184.311176661744, 9251.6299348026, 9259.629614815432, 9261.259099272042, 9354.625814967427, 9403.482808445568, 9415.058494150599, 9437.245020398352, 9452.716418507456, 9266.305027122959, 9319.580618872167, 9329.72010839676, 9355.391899526508, 9357.251419886392, 9151.588178531982, 9198.67804626835, 9200.585973631203, 9227.76930576741, 9238.86141707875, 44067.77966110181, 44299.11401771979, 44336.55663443357, 44433.77783111064, 44446.0, 3449.2066824630474, 3734.290484807878, 3862.3627101528214, 4256.36154576816, 4284.700070995032, 34936.475952860725, 35178.64821351805, 35349.29301413983, 35860.82069589661, 35875.92372228811, 4273.1240095780295, 4401.317795741666, 4408.493023302329, 4412.977935110336, 4483.30508771141, 380844.0, 381824.0, 383375.0, 383399.0, 383824.0808795966, 63678.36321636817, 64074.679626601566, 64224.357756422774, 64317.0, 64358.0, 38811.805940970116, 39220.21559568793, 39271.84004879702, 42110.36834447486, 67506.66246668735, 19344.516387090152, 19502.804971950383, 19526.0, 19546.70679939802, 19592.510187245432, 14928.178950157846, 14998.400063997537, 15029.624259393384, 15050.623734406727, 15058.472953446577, 20745.688814667792, 20757.584848302948, 21042.684359734616, 21178.258760943292, 21235.15059397607, 7744.57404842739, 7822.256885595859, 7842.254985776342, 7845.137034926153, 7899.526028438312, 1045.6340280901775, 1131.422974283105, 1213.1265488848014, 1233.4511142541662, 1271.7965125579863, 33956.660433395846, 34080.659193408246, 34084.82957585196, 34325.828370857984, 34504.82747586246, 1141.6917432293235, 1193.1111322064944, 1203.7592481503734, 1206.1918514595243, 1238.7336722604684, 17811.376601818873, 18203.362882299058, 18415.0, 18456.07719614014, 18539.536511587317, 578768.0, 582403.0, 583704.0, 586910.0, 589491.0, 65024.674876625315, 65381.346186538474, 65484.34515654878, 65787.67106164535, 65944.0, 1450.4415799917108, 1461.817272840895, 1467.8385377608454, 1471.3599584180915, 1476.6677497562962, 32756.0, 33958.49062264019, 33981.15047123842, 34168.658313417545, 34354.48468272928, 61123.0, 62214.37785622267, 62686.0, 68795.65602171957, 68971.0, 523004.0, 527625.0, 528548.0, 530564.6943530515, 532541.0, 49102.26346604733, 49518.0, 49534.50465495299, 50180.247296289854, 50377.74811125921, 53492.0, 53572.0, 54231.72884135554, 54464.72767636136, 54754.17868732052, 45427.0, 46548.30177547407, 46805.0, 47039.6415951786, 47326.29010564776, 44204.33693494536, 46307.3053904185, 46683.53316466928, 46751.0, 47471.0, 43214.56785432105, 44619.55380446284, 45789.0, 45929.77035114803, 48318.27522587094, 38846.0, 39998.80000600095, 40301.39547906842, 41163.38254926239, 41292.1741565173, 30013.0, 30786.69213307838, 30826.0, 31120.844395777876, 31247.84376078196], "value": 22115.471698143374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.9845606175753, 390.05995550722747, 407.2953789943398, 412.5874125874125, 431.2862213037422, 19012.524686882836, 19323.420297391065, 21271.680924786142, 21277.787222127794, 21479.463013424673, 19961.401157965247, 20087.29694460694, 20146.89926550369, 20401.59196816063, 20476.28333008345, 5773.942260577403, 6022.728977196037, 6025.578209525335, 6031.396860313956, 6034.185384973016, 5767.653940763567, 5865.677387743673, 5904.0, 5932.7330270137945, 5987.700614969256, 5890.823275301726, 5891.734871930752, 5897.587168898179, 5903.26209223847, 5913.201717768089, 5719.59962802604, 5825.330087040003, 5828.854278643025, 5885.970570147122, 5894.616849904743, 5194.117000109953, 5226.55574276187, 5227.555657769094, 5234.8691282717855, 5259.579233661336, 24675.0, 24678.506429871482, 24755.13357032513, 25009.374765631004, 25647.358816029562, 2555.501677172952, 2560.8719564021912, 2676.330917270682, 2891.2482754483776, 3019.7282244597873, 15445.845541544553, 15795.36818527269, 15807.956131506078, 15810.446634367858, 16258.430954916521, 2000.8199262066485, 2054.30153747725, 2067.1937944201773, 2115.481706981784, 2162.48100455891, 66015.0, 84366.57816711, 84953.57523212406, 85558.57220713857, 87816.56091719565, 9343.205827504738, 9417.529123543796, 9777.315587908779, 10807.243492955575, 11196.0, 13692.589222323346, 14548.345324460424, 15051.698966020618, 15082.54752357431, 15103.924480377747, 8704.129587041372, 8837.204651581389, 8856.158664926821, 8945.19493245611, 9118.908810911938, 8668.479891206547, 8755.649774008969, 8855.247303979233, 8946.373753837299, 9141.0, 6875.3812156906115, 6935.133108361455, 7007.073054909941, 7013.964930175316, 7021.789346319619, 2014.143988804752, 2015.516276093727, 2023.919043238254, 2041.8979051047388, 2101.621708092558, 1041.4063983529468, 1063.4044934836515, 1089.199438412766, 1111.7998760223238, 1189.3993533265646, 19332.226710931685, 20343.18627254923, 20846.166153354, 20895.68656470154, 20939.790602093784, 1052.594751020847, 1083.041508265191, 1103.3710784852558, 1111.216592302425, 1188.085174415695, 11550.249233799776, 11886.524539018343, 11982.460789264504, 12051.638450846489, 12061.276323420623, 537975.0, 545938.0, 553602.0, 560134.0, 562041.0, 88484.557577213, 93129.5343523278, 103369.19705120512, 104411.0, 109028.0, 1060.9098226650667, 1086.4513420722485, 1109.5118148014847, 1120.6638008597552, 1121.657894342217, 18976.905115474336, 19114.52213694669, 19212.231510739974, 19331.323403680803, 19347.613047739247, 40862.182756345304, 44845.32732008957, 45842.770786145855, 46071.76964115292, 47885.76057119692, 56377.43622563722, 60604.393956059874, 64234.67882660557, 64256.0, 69264.30735692578, 8554.828903422022, 8678.349123815866, 8772.561371931506, 8961.507117108622, 9022.097790220925, 12247.652758196413, 13441.932790335986, 13599.660008499866, 13978.580642580739, 15090.849091509384, 11189.608363707232, 11584.884151158381, 12176.756464870476, 12345.629631111082, 12643.93678031604, 12023.579174728842, 12176.208546444454, 12647.873521265037, 12884.549040783528, 12946.352682365656, 9765.755856103655, 11684.240524365889, 12452.875471245172, 12865.099443038898, 12986.675333116747, 9245.121713437213, 9263.212626926786, 9400.247980161708, 9421.528923553931, 9464.810703786023, 11045.502952367324, 11559.19085664029, 12047.81928271059, 12566.120371574269, 12616.053795965523], "value": 9929.672541907088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.2636247782302, 1578.479101896374, 1790.979251580202, 1872.728454374115, 1892.3565987564234, 7993.960030199841, 8633.266172375348, 8723.651053957834, 9172.678956236534, 9320.440773553591, 8873.600687969041, 9259.444433334005, 9271.629134834615, 9276.675316363928, 9284.257259419248, 2387.6776635154292, 2411.577973854577, 2430.368104292879, 2434.7565243475688, 2437.2079074300923, 2355.5406695694346, 2372.4424760181346, 2417.0815090265764, 2422.9757702422926, 2426.9927979888325, 2410.3612542676206, 2427.599446091393, 2430.2101816909485, 2430.8176886733477, 2445.6576079348906, 2329.988350058256, 2360.1267531013464, 2367.147826782357, 2373.08636175073, 2393.1623931623967, 2353.0470159585393, 2355.340504658698, 2355.787979081891, 2356.634721618135, 2364.113457453455, 9190.21883139934, 9326.347155699104, 9346.439213647203, 9365.391249568824, 9377.202937750299, 5357.4106848246665, 5475.206095116186, 5503.477169668875, 5519.034169020405, 5521.475459831349, 3309.619393769723, 3326.0354497195785, 3398.451161628778, 3417.3677869593957, 3425.4519276915576, 1074.425182527344, 1076.1874784537702, 1083.106437189322, 1083.918706097038, 1093.2238110941241, 12707.174033687781, 12712.300823454707, 12726.936365318114, 12766.234025958473, 12786.424610892533, 4683.227267500824, 4701.858944231679, 4835.8065677372515, 4836.661433699677, 4959.975200124049, 10835.241533092765, 10875.564977400974, 10888.237823352447, 10901.182411319183, 10925.508352124174, 5653.632513886584, 5661.207430959669, 5671.149327600893, 5697.971510142423, 5702.0591602385975, 4467.419235499365, 4991.5258050485145, 5102.183650615883, 5105.489451054865, 5237.083510385667, 4071.226466971266, 4081.1225586499045, 4083.5466286317373, 4108.26051310761, 4142.46148000758, 1335.132164093347, 1352.648311439033, 1362.6184668292894, 1366.152985149214, 1367.2206842100106, 1000.3297790480395, 1012.2610494339174, 1038.678009816944, 1049.9842502362471, 1063.7500187455942, 5919.940800592025, 6103.298120716086, 6191.164192834, 6206.162168107338, 6284.654344011032, 462.6784384852495, 470.51066890433566, 472.6903877959942, 473.94312682478323, 483.22683706070006, 4186.058136919169, 4205.91588168241, 4227.196832601796, 4227.936580951288, 4252.468441444819, 10978.12175026012, 11150.0, 11232.269902456314, 11301.943490282496, 11307.095432365391, 11208.15938804593, 11231.157663175294, 11232.269902456477, 11240.156988225915, 11243.66269011931, 8303.4602750821, 8530.829383412422, 8615.095414981462, 8625.137486251324, 8630.697925572575, 5836.328822185334, 6122.938770612237, 6236.563440559117, 6269.090981807703, 6279.560430769802, 10323.94838025835, 10621.15030797519, 10651.254412191072, 10679.5194216262, 10743.677689669323, 10632.946835265775, 10644.095251903365, 10844.511996959998, 10889.455527223448, 10893.891061089606, 7863.685452581833, 8446.324294056338, 8665.2634526066, 8758.343124265579, 8928.553572321229, 9066.546672666209, 9233.630654773733, 9276.814463710552, 9279.814403712024, 9293.070692930924, 7988.0, 7990.400719945911, 8014.83970320602, 8148.5518296494265, 8245.381596380415, 7967.163447837894, 8023.438359315025, 8029.879551806845, 8055.7583272501915, 8144.185581441809, 7031.7890463286185, 7312.8537429250055, 7349.8162545936775, 7406.1482929461645, 7408.259174082548, 5171.974140129275, 5213.504717051874, 5213.713245771519, 5232.26748255237, 5254.106801843772, 5209.0363282792805, 5217.686938783685, 5255.343082114736, 5266.78932842682, 5266.999270138662], "value": 4738.531626034695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1546663740779, 341.5627996164909, 341.63770740541344, 357.13395017083565, 358.41220398546386, 5691.544676425887, 5769.82690519284, 5859.501942334901, 5933.66492539179, 5950.82147535574, 5752.252207213067, 5801.042827933396, 5811.709414529268, 5831.912521312183, 5833.854153646161, 4551.203539380604, 4581.656375771814, 4602.217623004098, 4644.303354496818, 4671.617475087695, 4500.482444518873, 4511.774411279423, 4521.954780452186, 4594.920193754482, 4662.347271382009, 4526.977365113186, 4542.364069030338, 4547.909041819178, 4555.430571178603, 4576.656750743691, 4514.390557274792, 4540.160070386973, 4569.537747920666, 4618.676692631517, 4621.884452888671, 3765.7928813915223, 3955.367141257385, 3992.92191108402, 4111.794410279504, 4131.772752498611, 5599.832005039814, 5663.451446848934, 5671.63134396267, 5675.2054712340305, 5712.285964254468, 5227.189785583203, 5234.136367499358, 5239.973800130975, 5254.448282930313, 5279.128943724281, 5846.970765146147, 6063.18147050147, 6089.360617135226, 6092.238470191226, 6192.721327540272, 4293.0, 4317.84797098117, 4342.261815491374, 4344.695871289011, 4357.150355680644, 6180.505559555225, 6369.853426383249, 6442.549021568492, 6450.580712253689, 6489.772857949949, 4442.378067070613, 4469.9553004469535, 4477.977610111994, 4499.437570303712, 4514.164879497303, 4561.498235194126, 4591.311303304531, 4594.770261486912, 4603.884902877455, 4605.078984203173, 5138.434772175057, 5235.267062611238, 5246.449122842123, 5256.0, 5256.947430525723, 5890.970545147333, 6107.572469927151, 6154.969225153845, 6170.969145154246, 6192.411720886508, 1550.5968448203548, 1568.0434934689831, 1573.590866374728, 1580.8143892080939, 1580.9170718058167, 970.8204531494268, 1001.1490233301781, 1005.5676059294427, 1023.155896385485, 1024.9641262555774, 5204.531592156648, 5256.26412302278, 5275.261463395128, 5275.630705850554, 5284.365876094893, 5464.808731694372, 5543.6396634218645, 5546.25460397098, 5557.305336832896, 5559.471850174227, 5008.6744361616375, 5262.131943160123, 5292.7032876945395, 5304.257403963448, 5328.333958255218, 2965.31797686529, 3001.5797788309656, 3001.654809696869, 3015.532592448174, 3018.9886388060245, 5525.484670326985, 5713.685747283939, 5723.713814309268, 5768.596198266081, 5803.040449370851, 5572.888542229132, 5678.488935995698, 5691.402402747734, 5703.437250199907, 5751.252337196138, 5694.5159661428415, 5714.0, 5726.484616384545, 5730.484256416942, 5738.225339579103, 5260.736963151904, 5443.747937974367, 5469.288992430958, 5492.80775172867, 5533.889322213614, 5391.541718953933, 5400.244920400964, 5420.7289635518855, 5463.836084917459, 5464.551893748239, 5586.329640443173, 5705.657660540215, 5712.6001179917, 5731.340895797037, 5782.409837294777, 3937.625925537069, 3965.2466031453932, 4023.631965131869, 4057.4116753070048, 4072.0, 5478.178273259043, 5494.835154945358, 5515.552779512805, 6018.909716354171, 6151.6924153793025, 6110.26676798787, 6126.632402055891, 6151.507879369729, 6155.0, 6184.350643182401, 6004.159417681615, 6117.204763380732, 6165.938340616536, 6174.25908890936, 6175.3515880831865, 6067.393260674074, 6106.664133472702, 6111.327753946974, 6117.388261173847, 6171.161265817774, 6213.943629582891, 6234.781782637768, 6243.875122497434, 6257.249130104235, 6264.718087685974, 5870.326956817457, 5938.673372964528, 6020.916235077728, 6052.273727152769, 6078.416672913905], "value": 4488.94176181057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.1998001997998, 815.5442535074892, 882.7616543533246, 927.7680579855038, 939.0234156477264, 15320.463783767571, 16576.0, 16632.33470661172, 16647.91676041621, 16698.66602667946, 14962.775558366606, 16241.918790406062, 16403.343866245337, 16426.507204783844, 16538.751918721227, 877.4691311756392, 894.4186278918722, 895.852184389575, 897.3987428422939, 898.3801177187752, 863.0549548244662, 864.6498168241872, 874.3355050161891, 874.7375787263795, 874.9912500875005, 921.2261700171854, 925.0887875442684, 928.1368327455464, 929.9209567186764, 932.1424289653501, 918.7611221082567, 921.0329154387899, 923.8706581078654, 926.5922993882704, 927.9304052196112, 680.4420375292262, 681.1791790891963, 681.2914568848441, 681.6012632609929, 683.1904193530683, 14573.0, 14754.262286885612, 14756.262186890612, 14782.778258326134, 14821.703565928728, 14429.711405771826, 14453.638659033502, 14708.338124784303, 14945.17801520916, 15115.39538418462, 14353.641158971004, 14553.490627827976, 14562.952831217226, 14715.0, 14807.0, 4714.929276060861, 4716.8349107781405, 4723.622110231207, 4730.408698912636, 4766.666333356632, 92881.53559232228, 93078.0, 93644.0, 95906.0, 96210.51894740551, 12123.393830308449, 12312.938435307946, 12514.31171285588, 12609.432575534123, 12913.160644558073, 20779.79220207809, 20802.0, 20823.895880520802, 20914.686279705817, 20924.476888077614, 8986.236169925498, 8997.595108220146, 9057.36598438103, 9152.606748760632, 9171.678991235274, 5140.691558506502, 5151.479078626284, 5179.715115668599, 5272.340957380327, 5326.174442961347, 3827.2919509890758, 3914.099757055836, 3941.5270167580074, 3941.9014524637114, 3948.368261078214, 666.4601672645173, 671.3286713286714, 676.4588329336511, 679.4632240530025, 687.6011913090396, 526.6892533405232, 562.6117978594757, 566.4250785452768, 626.4049153304379, 632.2570979099539, 9680.806383872425, 11184.273022253528, 11741.941290293495, 11783.469743861548, 12225.02199824012, 669.3774789445862, 731.9634018299171, 758.0524344569288, 823.4194892600702, 826.6197549127469, 4939.678920870132, 5408.945910540844, 5418.512333889968, 5435.1303791393975, 5451.509364157245, 70770.0, 71861.28138718651, 110626.0, 111515.88484115218, 117294.89467868584, 86536.567317163, 87715.0, 88669.0, 98568.0, 100530.0, 88391.0, 90621.0, 92648.53675731712, 93604.0639593609, 95430.52284738532, 10601.1519078472, 10752.569897204337, 10824.729381765204, 10894.291871028357, 11160.162987776112, 55511.0, 55520.0, 55710.16434753401, 56449.71775141098, 57892.421075788705, 72522.27477725156, 73978.63010685127, 80078.19921800708, 80112.59943700244, 81568.0, 13606.727865442834, 13751.312434378442, 14241.50154744579, 14498.927505362406, 14764.852351476777, 14899.255037248311, 16329.856910016184, 16747.1626418681, 16951.576210594834, 17033.14834258307, 15320.779123858714, 15357.33498037486, 15591.532254032398, 15954.760678590063, 16316.755248671518, 14663.900207484268, 14980.625484362978, 16043.919780401024, 16068.839311606735, 16254.945359655712, 13336.266505342299, 13366.198028118344, 13786.65533361674, 14163.929180354033, 14321.928390357982, 11471.139664525028, 11650.359230242419, 11977.161598688008, 12226.144169908377, 12302.753944920873, 11978.46096925658, 13171.407286672315, 13205.933970330087, 13269.270190139636, 13407.195568265935], "value": 8144.3256368724105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 103.0, 109.0, 110.0, 111.0, 97.0, 111.0, 110.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 144.0, 173.0, 118.0, 141.0, 148.0, 117.0, 164.0, 116.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 161.0, 162.0, 162.0, 162.0, 162.0, 163.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 165.0, 77.0, 75.0, 76.0, 76.0, 171.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 145.0, 84.0, 84.0, 94.0, 149.0, 83.0, 83.0, 135.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 122.0, 117.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 98.0, 100.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 53.0, 55.0, 61.0, 53.0, 53.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 62.0, 60.0, 60.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 82.0, 78.0, 73.0, 75.0, 72.0, 72.0, 74.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 123.0, 117.0, 120.0, 119.0, 119.0, 135.0, 154.0, 125.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 161.0, 151.0, 152.0, 152.0, 150.0, 152.0, 154.0, 149.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 61.0, 62.0, 61.0, 70.0, 60.0, 62.0, 61.0, 64.0], "value": 63.0, "unit": "score"}]}]} 06:54:48 INFO - Return code: 0 06:54:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:54:48 ERROR - # TBPL SUCCESS # 06:54:48 INFO - Running post-action listener: _resource_record_post_action 06:54:48 INFO - [mozharness: 2016-09-08 13:54:48.466014Z] Finished run-tests step (success) 06:54:48 INFO - Running post-run listener: _resource_record_post_run 06:54:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 325750784; Read time: 52; Write time: 303164 06:54:48 INFO - TinderboxPrint: CPU usage
13.3% 06:54:48 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 52 06:54:48 INFO - TinderboxPrint: I/O write bytes / time
325,750,784 / 303,164 06:54:48 INFO - TinderboxPrint: CPU idle
8,227.7 (86.7%) 06:54:48 INFO - TinderboxPrint: CPU user
1,206.1 (12.7%) 06:54:48 INFO - TinderboxPrint: Swap in / out
0 / 0 06:54:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79646720; Read time: 0; Write time: 135308 06:54:48 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246104064; Read time: 44; Write time: 167856 06:54:49 INFO - Running post-run listener: _upload_blobber_files 06:54:49 INFO - Blob upload gear active. 06:54:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:54:49 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 06:54:49 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'] 06:54:49 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 06:54:49 INFO - (blobuploader) - INFO - Open directory for files ... 06:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:50 INFO - (blobuploader) - INFO - Done attempting. 06:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:53 INFO - (blobuploader) - INFO - Done attempting. 06:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:54 INFO - (blobuploader) - INFO - Done attempting. 06:54:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:54:54 INFO - Return code: 0 06:54:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:54:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:54:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08699cba73d236e7023fcd0a54a88d27b3555e9244d46850f7a431627f6e6dd5dcc9ce65ac9bdbcba1dd84337a84cbbe811aba391a5302accb53e3a001918bde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86c07ddd728a5f579dc29095a355ea9623fdbca3c4f4fef26754463bccfdc4511e0ad20dce6cd6a22930ab9a65c3addc703ca5eea40b45c214c3351a7eb93a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c0b248897356820d161bf10e4424786091e93c3d8a4b838db47d1ee3c411e9bef2fe5ad1832587afc2eb96d5eb995921831b00576d884c84ac550f5c872a8b6"} 06:54:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:54:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:54:54 INFO - Contents: 06:54:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08699cba73d236e7023fcd0a54a88d27b3555e9244d46850f7a431627f6e6dd5dcc9ce65ac9bdbcba1dd84337a84cbbe811aba391a5302accb53e3a001918bde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86c07ddd728a5f579dc29095a355ea9623fdbca3c4f4fef26754463bccfdc4511e0ad20dce6cd6a22930ab9a65c3addc703ca5eea40b45c214c3351a7eb93a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c0b248897356820d161bf10e4424786091e93c3d8a4b838db47d1ee3c411e9bef2fe5ad1832587afc2eb96d5eb995921831b00576d884c84ac550f5c872a8b6"} 06:54:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:54:54 INFO - Copying logs to upload dir... 06:54:54 INFO - mkdir: /builds/slave/test/build/upload/logs 06:54:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.098965 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-08 06:54:53.936500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 06:54:53.940193) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254 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/08699cba73d236e7023fcd0a54a88d27b3555e9244d46850f7a431627f6e6dd5dcc9ce65ac9bdbcba1dd84337a84cbbe811aba391a5302accb53e3a001918bde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86c07ddd728a5f579dc29095a355ea9623fdbca3c4f4fef26754463bccfdc4511e0ad20dce6cd6a22930ab9a65c3addc703ca5eea40b45c214c3351a7eb93a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c0b248897356820d161bf10e4424786091e93c3d8a4b838db47d1ee3c411e9bef2fe5ad1832587afc2eb96d5eb995921831b00576d884c84ac550f5c872a8b6"} build_url:https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/L3U85OqYTHeBRwlZVnmmsw/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/08699cba73d236e7023fcd0a54a88d27b3555e9244d46850f7a431627f6e6dd5dcc9ce65ac9bdbcba1dd84337a84cbbe811aba391a5302accb53e3a001918bde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86c07ddd728a5f579dc29095a355ea9623fdbca3c4f4fef26754463bccfdc4511e0ad20dce6cd6a22930ab9a65c3addc703ca5eea40b45c214c3351a7eb93a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c0b248897356820d161bf10e4424786091e93c3d8a4b838db47d1ee3c411e9bef2fe5ad1832587afc2eb96d5eb995921831b00576d884c84ac550f5c872a8b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 06:54:53.967360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:54:53.969150) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473341215.399650-1320444254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 06:54:54.054980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 06:54:54.055788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 06:54:54.056518) ========= ========= Total master_lag: 0.15 =========