builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1462230430.12 results: success (0) buildid: 20160502133436 builduid: 809d0caa233347d7abb79d039e676759 revision: cb7afc6a6450dd75d89b10825f719178eb15437b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.121371) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.121882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.122174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.138846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.139134) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-02 16:07:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-05-02 16:07:11 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.317893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.318218) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.367826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.368185) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cb7afc6a6450dd75d89b10825f719178eb15437b --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 cb7afc6a6450dd75d89b10825f719178eb15437b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-02 16:07:11,139 truncating revision to first 12 chars 2016-05-02 16:07:11,139 Setting DEBUG logging. 2016-05-02 16:07:11,139 attempt 1/10 2016-05-02 16:07:11,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cb7afc6a6450?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-02 16:07:11,419 unpacking tar archive at: mozilla-aurora-cb7afc6a6450/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.994358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.994701) ========= script_repo_revision: cb7afc6a6450dd75d89b10825f719178eb15437b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.995097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:10.995371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-02 16:07:11.004505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 27 secs) (at 2016-05-02 16:07:11.004970) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:07:11 INFO - MultiFileLogger online at 20160502 16:07:11 in /builds/slave/test 16:07:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:07:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:07:11 INFO - {'append_to_log': False, 16:07:11 INFO - 'base_work_dir': '/builds/slave/test', 16:07:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:07:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:07:11 INFO - 'branch': 'Mozilla-Aurora', 16:07:11 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:11 INFO - 'config_files': ('talos/linux_config.py',), 16:07:11 INFO - 'default_actions': ('clobber', 16:07:11 INFO - 'read-buildbot-config', 16:07:11 INFO - 'download-and-extract', 16:07:11 INFO - 'populate-webroot', 16:07:11 INFO - 'create-virtualenv', 16:07:11 INFO - 'install', 16:07:11 INFO - 'run-tests'), 16:07:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:11 INFO - 'download_minidump_stackwalk': True, 16:07:11 INFO - 'download_symbols': 'ondemand', 16:07:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:11 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:11 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:11 INFO - 'installer_path': 'installer.exe', 16:07:11 INFO - 'log_level': 'info', 16:07:11 INFO - 'log_name': 'talos', 16:07:11 INFO - 'log_to_console': True, 16:07:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:07:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:07:11 INFO - 'opt_config_files': (), 16:07:11 INFO - 'pip_index': False, 16:07:11 INFO - 'sps_profile': False, 16:07:11 INFO - 'sps_profile_interval': 0, 16:07:11 INFO - 'suite': 'dromaeojs', 16:07:11 INFO - 'system_bits': '32', 16:07:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:11 INFO - 'title': 'talos-linux64-ix-034', 16:07:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:11 INFO - 'use_talos_json': True, 16:07:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:07:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:11 INFO - 'work_dir': 'build'} 16:07:11 INFO - ##### 16:07:11 INFO - ##### Running clobber step. 16:07:11 INFO - ##### 16:07:11 INFO - Running pre-action listener: _resource_record_pre_action 16:07:11 INFO - Running main action method: clobber 16:07:11 INFO - rmtree: /builds/slave/test/build 16:07:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:12 INFO - Running post-action listener: _resource_record_post_action 16:07:12 INFO - ##### 16:07:12 INFO - ##### Running read-buildbot-config step. 16:07:12 INFO - ##### 16:07:12 INFO - Running pre-action listener: _resource_record_pre_action 16:07:12 INFO - Running main action method: read_buildbot_config 16:07:12 INFO - Using buildbot properties: 16:07:12 INFO - { 16:07:12 INFO - "project": "", 16:07:12 INFO - "product": "firefox", 16:07:12 INFO - "script_repo_revision": "production", 16:07:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:07:12 INFO - "repository": "", 16:07:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:07:12 INFO - "buildid": "20160502133436", 16:07:12 INFO - "pgo_build": "True", 16:07:12 INFO - "basedir": "/builds/slave/test", 16:07:12 INFO - "buildnumber": 301, 16:07:12 INFO - "slavename": "talos-linux64-ix-034", 16:07:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:07:12 INFO - "platform": "ubuntu64_hw", 16:07:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:07:12 INFO - "branch": "mozilla-aurora", 16:07:12 INFO - "repo_path": "releases/mozilla-aurora", 16:07:12 INFO - "revision": "cb7afc6a6450dd75d89b10825f719178eb15437b", 16:07:12 INFO - "stage_platform": "linux64-pgo", 16:07:12 INFO - "builduid": "809d0caa233347d7abb79d039e676759", 16:07:12 INFO - "slavebuilddir": "test" 16:07:12 INFO - } 16:07:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 16:07:12 INFO - Running post-action listener: _resource_record_post_action 16:07:12 INFO - ##### 16:07:12 INFO - ##### Running download-and-extract step. 16:07:12 INFO - ##### 16:07:12 INFO - Running pre-action listener: _resource_record_pre_action 16:07:12 INFO - Running main action method: download_and_extract 16:07:12 INFO - mkdir: /builds/slave/test/build/tests 16:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:12 INFO - https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:07:42 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 16:07:42 INFO - retry: attempt #1 caught exception: timed out 16:07:42 INFO - retry: Failed, sleeping 30 seconds before retrying 16:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 16:08:42 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 16:08:42 INFO - retry: attempt #2 caught exception: timed out 16:08:42 INFO - retry: Failed, sleeping 60 seconds before retrying 16:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 16:10:13 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 16:10:13 INFO - retry: attempt #3 caught exception: timed out 16:10:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json! 16:10:13 INFO - Caught exception: timed out 16:10:13 INFO - Caught exception: timed out 16:10:13 INFO - Caught exception: timed out 16:10:13 INFO - trying https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:10:13 INFO - Downloading https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:10:13 INFO - Downloaded 1361 bytes. 16:10:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:10:13 INFO - Using the following test package requirements: 16:10:13 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:10:13 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:10:13 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:10:13 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'jsshell-linux-x86_64.zip'], 16:10:13 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:10:13 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:10:13 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:10:13 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:10:13 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:10:13 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:10:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:10:13 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:13 INFO - https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:43 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 16:10:43 INFO - retry: attempt #1 caught exception: timed out 16:10:43 INFO - retry: Failed, sleeping 30 seconds before retrying 16:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 16:11:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 16:11:44 INFO - retry: attempt #2 caught exception: timed out 16:11:44 INFO - retry: Failed, sleeping 60 seconds before retrying 16:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 16:13:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 16:13:14 INFO - retry: attempt #3 caught exception: timed out 16:13:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip! 16:13:14 INFO - Caught exception: timed out 16:13:14 INFO - Caught exception: timed out 16:13:14 INFO - Caught exception: timed out 16:13:14 INFO - trying https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:13:14 INFO - Downloading https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:13:15 INFO - Downloaded 23821233 bytes. 16:13:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:13:16 INFO - Return code: 0 16:13:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:13:16 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')]} 16:13:16 INFO - https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:13:46 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 16:13:46 INFO - retry: attempt #1 caught exception: timed out 16:13:46 INFO - retry: Failed, sleeping 30 seconds before retrying 16:14:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 16:14:46 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 16:14:46 INFO - retry: attempt #2 caught exception: timed out 16:14:46 INFO - retry: Failed, sleeping 60 seconds before retrying 16:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 16:16:16 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 16:16:16 INFO - retry: attempt #3 caught exception: timed out 16:16:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip! 16:16:16 INFO - Caught exception: timed out 16:16:16 INFO - Caught exception: timed out 16:16:16 INFO - Caught exception: timed out 16:16:16 INFO - trying https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:16:16 INFO - Downloading https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:16:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:16:17 INFO - Downloaded 23821233 bytes. 16:16:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:16:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:16:19 INFO - Return code: 0 16:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:19 INFO - https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:16:49 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 16:16:49 INFO - retry: attempt #1 caught exception: timed out 16:16:49 INFO - retry: Failed, sleeping 30 seconds before retrying 16:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 16:17:49 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 16:17:49 INFO - retry: attempt #2 caught exception: timed out 16:17:49 INFO - retry: Failed, sleeping 60 seconds before retrying 16:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 16:19:19 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 16:19:19 INFO - retry: attempt #3 caught exception: timed out 16:19:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip! 16:19:19 INFO - Caught exception: timed out 16:19:19 INFO - Caught exception: timed out 16:19:19 INFO - Caught exception: timed out 16:19:19 INFO - trying https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:19:19 INFO - Downloading https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:19:20 INFO - Downloaded 10840145 bytes. 16:19:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:19:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:19:20 INFO - Return code: 0 16:19:20 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')]} 16:19:20 INFO - https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:19:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:19:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:19:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:19:50 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 16:19:50 INFO - retry: attempt #1 caught exception: timed out 16:19:50 INFO - retry: Failed, sleeping 30 seconds before retrying 16:20:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 16:20:50 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 16:20:50 INFO - retry: attempt #2 caught exception: timed out 16:20:50 INFO - retry: Failed, sleeping 60 seconds before retrying 16:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 16:22:20 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 16:22:20 INFO - retry: attempt #3 caught exception: timed out 16:22:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2! 16:22:20 INFO - Caught exception: timed out 16:22:20 INFO - Caught exception: timed out 16:22:20 INFO - Caught exception: timed out 16:22:20 INFO - trying https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:22:20 INFO - Downloading https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:22:22 INFO - Downloaded 62719520 bytes. 16:22:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:22:22 INFO - mkdir: /builds/slave/test/properties 16:22:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:22 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:22 INFO - Contents: 16:22:22 INFO - build_url:https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:22:22 INFO - Running post-action listener: _resource_record_post_action 16:22:22 INFO - Running post-action listener: set_extra_try_arguments 16:22:22 INFO - ##### 16:22:22 INFO - ##### Running populate-webroot step. 16:22:22 INFO - ##### 16:22:22 INFO - Running pre-action listener: _resource_record_pre_action 16:22:22 INFO - Running main action method: populate_webroot 16:22:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:22:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:22:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:22:22 INFO - '--tppagecycles', 16:22:22 INFO - '7'], 16:22:22 INFO - 'tests': ['tsvgm']}}, 16:22:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:22:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:22:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['damp', 'tps']}, 16:22:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'tests': ['damp', 'tps']}, 16:22:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['dromaeo_dom']}, 16:22:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['a11yr', 16:22:22 INFO - 'ts_paint', 16:22:22 INFO - 'tpaint', 16:22:22 INFO - 'sessionrestore', 16:22:22 INFO - 'sessionrestore_no_auto_restore', 16:22:22 INFO - 'tabpaint']}, 16:22:22 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:22 INFO - 'ts_paint', 16:22:22 INFO - 'tpaint', 16:22:22 INFO - 'sessionrestore', 16:22:22 INFO - 'sessionrestore_no_auto_restore', 16:22:22 INFO - 'tabpaint']}, 16:22:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:22:22 INFO - 'ts_paint', 16:22:22 INFO - 'tpaint', 16:22:22 INFO - 'sessionrestore', 16:22:22 INFO - 'sessionrestore_no_auto_restore', 16:22:22 INFO - 'tabpaint']}, 16:22:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:22:22 INFO - 'ts_paint', 16:22:22 INFO - 'tpaint', 16:22:22 INFO - 'sessionrestore', 16:22:22 INFO - 'sessionrestore_no_auto_restore', 16:22:22 INFO - 'tabpaint']}, 16:22:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['a11yr', 16:22:22 INFO - 'ts_paint', 16:22:22 INFO - 'tpaint', 16:22:22 INFO - 'sessionrestore', 16:22:22 INFO - 'sessionrestore_no_auto_restore', 16:22:22 INFO - 'tabpaint']}, 16:22:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['a11yr', 16:22:22 INFO - 'ts_paint', 16:22:22 INFO - 'tpaint', 16:22:22 INFO - 'sessionrestore', 16:22:22 INFO - 'sessionrestore_no_auto_restore', 16:22:22 INFO - 'tabpaint']}, 16:22:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['tsvgx', 16:22:22 INFO - 'tsvgr_opacity', 16:22:22 INFO - 'tart', 16:22:22 INFO - 'tscrollx', 16:22:22 INFO - 'cart']}, 16:22:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:22 INFO - 'tsvgr_opacity', 16:22:22 INFO - 'tart', 16:22:22 INFO - 'tscrollx', 16:22:22 INFO - 'cart']}, 16:22:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'talos_options': ['--disable-e10s'], 16:22:22 INFO - 'tests': ['tp5o']}, 16:22:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'tests': ['tp5o']}, 16:22:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'talos_options': ['--disable-e10s', 16:22:22 INFO - '--xperf_path', 16:22:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:22 INFO - 'tests': ['tp5n']}, 16:22:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:22 INFO - 'talos_options': ['--xperf_path', 16:22:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:22 INFO - 'tests': ['tp5n']}}, 16:22:22 INFO - 'talos.zip': {'path': '', 16:22:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:22:22 INFO - Running post-action listener: _resource_record_post_action 16:22:22 INFO - ##### 16:22:22 INFO - ##### Running create-virtualenv step. 16:22:22 INFO - ##### 16:22:22 INFO - Running pre-action listener: _resource_record_pre_action 16:22:22 INFO - Running main action method: create_virtualenv 16:22:22 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:22 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 16:22:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:22:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:23 INFO - Using real prefix '/usr' 16:22:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:23 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:25 INFO - Installing pip.................done. 16:22:25 INFO - Return code: 0 16:22:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:22:25 INFO - Using env: {'DISPLAY': ':0', 16:22:25 INFO - 'HOME': '/home/cltbld', 16:22:25 INFO - 'LANG': 'en_US.UTF-8', 16:22:25 INFO - 'LANGUAGE': 'en_US:en', 16:22:25 INFO - 'LOGNAME': 'cltbld', 16:22:25 INFO - 'MAIL': '/var/mail/cltbld', 16:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:25 INFO - 'MOZ_NO_REMOTE': '1', 16:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:25 INFO - 'NO_EM_RESTART': '1', 16:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:25 INFO - 'PWD': '/builds/slave/test', 16:22:25 INFO - 'SHELL': '/bin/bash', 16:22:25 INFO - 'SHLVL': '1', 16:22:25 INFO - 'TERM': 'linux', 16:22:25 INFO - 'TMOUT': '86400', 16:22:25 INFO - 'USER': 'cltbld', 16:22:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:25 INFO - '_': '/tools/buildbot/bin/python'} 16:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:25 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 16:22:25 INFO - Cleaning up... 16:22:25 INFO - Return code: 0 16:22:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:22:25 INFO - Using env: {'DISPLAY': ':0', 16:22:25 INFO - 'HOME': '/home/cltbld', 16:22:25 INFO - 'LANG': 'en_US.UTF-8', 16:22:25 INFO - 'LANGUAGE': 'en_US:en', 16:22:25 INFO - 'LOGNAME': 'cltbld', 16:22:25 INFO - 'MAIL': '/var/mail/cltbld', 16:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:25 INFO - 'MOZ_NO_REMOTE': '1', 16:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:25 INFO - 'NO_EM_RESTART': '1', 16:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:25 INFO - 'PWD': '/builds/slave/test', 16:22:25 INFO - 'SHELL': '/bin/bash', 16:22:25 INFO - 'SHLVL': '1', 16:22:25 INFO - 'TERM': 'linux', 16:22:25 INFO - 'TMOUT': '86400', 16:22:25 INFO - 'USER': 'cltbld', 16:22:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:25 INFO - '_': '/tools/buildbot/bin/python'} 16:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:25 INFO - Downloading/unpacking psutil>=0.7.1 16:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:27 INFO - Installing collected packages: psutil 16:22:27 INFO - Running setup.py install for psutil 16:22:27 INFO - building 'psutil._psutil_linux' extension 16:22:27 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 16:22:28 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 16:22:28 INFO - building 'psutil._psutil_posix' extension 16:22:28 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 16:22:28 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 16:22:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:28 INFO - Successfully installed psutil 16:22:28 INFO - Cleaning up... 16:22:28 INFO - Return code: 0 16:22:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:22:28 INFO - Using env: {'DISPLAY': ':0', 16:22:28 INFO - 'HOME': '/home/cltbld', 16:22:28 INFO - 'LANG': 'en_US.UTF-8', 16:22:28 INFO - 'LANGUAGE': 'en_US:en', 16:22:28 INFO - 'LOGNAME': 'cltbld', 16:22:28 INFO - 'MAIL': '/var/mail/cltbld', 16:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:28 INFO - 'MOZ_NO_REMOTE': '1', 16:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:28 INFO - 'NO_EM_RESTART': '1', 16:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:28 INFO - 'PWD': '/builds/slave/test', 16:22:28 INFO - 'SHELL': '/bin/bash', 16:22:28 INFO - 'SHLVL': '1', 16:22:28 INFO - 'TERM': 'linux', 16:22:28 INFO - 'TMOUT': '86400', 16:22:28 INFO - 'USER': 'cltbld', 16:22:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:28 INFO - '_': '/tools/buildbot/bin/python'} 16:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:22:30 INFO - Installing collected packages: mozsystemmonitor 16:22:30 INFO - Running setup.py install for mozsystemmonitor 16:22:30 INFO - Successfully installed mozsystemmonitor 16:22:30 INFO - Cleaning up... 16:22:30 INFO - Return code: 0 16:22:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:30 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 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:30 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 16:22:30 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 16:22:30 INFO - Using env: {'DISPLAY': ':0', 16:22:30 INFO - 'HOME': '/home/cltbld', 16:22:30 INFO - 'LANG': 'en_US.UTF-8', 16:22:30 INFO - 'LANGUAGE': 'en_US:en', 16:22:30 INFO - 'LOGNAME': 'cltbld', 16:22:30 INFO - 'MAIL': '/var/mail/cltbld', 16:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:30 INFO - 'MOZ_NO_REMOTE': '1', 16:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:30 INFO - 'NO_EM_RESTART': '1', 16:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:30 INFO - 'PWD': '/builds/slave/test', 16:22:30 INFO - 'SHELL': '/bin/bash', 16:22:30 INFO - 'SHLVL': '1', 16:22:30 INFO - 'TERM': 'linux', 16:22:30 INFO - 'TMOUT': '86400', 16:22:30 INFO - 'USER': 'cltbld', 16:22:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:30 INFO - '_': '/tools/buildbot/bin/python'} 16:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22:32 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 16:22:32 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 16:22:32 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 16:22:32 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 16:22:32 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 16:22:32 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 16:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:33 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 16:22:33 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 16:22:33 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 16:22:33 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 16:22:33 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 16:22:33 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 16:22:33 INFO - Downloading docopt-0.6.1.tar.gz 16:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:33 INFO - Running setup.py install for blobuploader 16:22:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:33 INFO - Running setup.py install for requests 16:22:33 INFO - Running setup.py install for docopt 16:22:34 INFO - Successfully installed blobuploader requests docopt 16:22:34 INFO - Cleaning up... 16:22:34 INFO - Return code: 0 16:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:34 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 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:34 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 16:22:34 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 16:22:34 INFO - Using env: {'DISPLAY': ':0', 16:22:34 INFO - 'HOME': '/home/cltbld', 16:22:34 INFO - 'LANG': 'en_US.UTF-8', 16:22:34 INFO - 'LANGUAGE': 'en_US:en', 16:22:34 INFO - 'LOGNAME': 'cltbld', 16:22:34 INFO - 'MAIL': '/var/mail/cltbld', 16:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:34 INFO - 'MOZ_NO_REMOTE': '1', 16:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:34 INFO - 'NO_EM_RESTART': '1', 16:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:34 INFO - 'PWD': '/builds/slave/test', 16:22:34 INFO - 'SHELL': '/bin/bash', 16:22:34 INFO - 'SHLVL': '1', 16:22:34 INFO - 'TERM': 'linux', 16:22:34 INFO - 'TMOUT': '86400', 16:22:34 INFO - 'USER': 'cltbld', 16:22:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:34 INFO - '_': '/tools/buildbot/bin/python'} 16:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:34 INFO - Running setup.py (path:/tmp/pip-GcPbx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:34 INFO - Running setup.py (path:/tmp/pip-_vYinO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:34 INFO - Running setup.py (path:/tmp/pip-D7eQJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:34 INFO - Running setup.py (path:/tmp/pip-ZH1d1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:34 INFO - Running setup.py (path:/tmp/pip-BYlecM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:34 INFO - Running setup.py (path:/tmp/pip-nEqyjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:34 INFO - Running setup.py (path:/tmp/pip-OrGBWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:34 INFO - Running setup.py (path:/tmp/pip-IiWwGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:34 INFO - Running setup.py (path:/tmp/pip-_jBaRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:35 INFO - Running setup.py (path:/tmp/pip-CnS2R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:35 INFO - Running setup.py (path:/tmp/pip-UZKzq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:35 INFO - Running setup.py (path:/tmp/pip-ewRlGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:35 INFO - Running setup.py (path:/tmp/pip-69x4a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:35 INFO - Running setup.py (path:/tmp/pip-fnko6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:35 INFO - Running setup.py (path:/tmp/pip-ZmEGKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:35 INFO - Running setup.py (path:/tmp/pip-dmSy83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:35 INFO - Running setup.py (path:/tmp/pip-CbzuvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:35 INFO - Running setup.py install for manifestparser 16:22:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:35 INFO - Running setup.py install for mozcrash 16:22:35 INFO - Running setup.py install for mozdebug 16:22:35 INFO - Running setup.py install for mozdevice 16:22:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for mozfile 16:22:36 INFO - Running setup.py install for mozhttpd 16:22:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for mozinfo 16:22:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for mozInstall 16:22:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for mozleak 16:22:36 INFO - Running setup.py install for mozlog 16:22:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for moznetwork 16:22:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for mozprocess 16:22:36 INFO - Running setup.py install for mozprofile 16:22:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:36 INFO - Running setup.py install for mozrunner 16:22:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:37 INFO - Running setup.py install for mozscreenshot 16:22:37 INFO - Running setup.py install for moztest 16:22:37 INFO - Running setup.py install for mozversion 16:22:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:37 INFO - Cleaning up... 16:22:37 INFO - Return code: 0 16:22:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:37 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 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:37 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 16:22:37 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 16:22:37 INFO - Using env: {'DISPLAY': ':0', 16:22:37 INFO - 'HOME': '/home/cltbld', 16:22:37 INFO - 'LANG': 'en_US.UTF-8', 16:22:37 INFO - 'LANGUAGE': 'en_US:en', 16:22:37 INFO - 'LOGNAME': 'cltbld', 16:22:37 INFO - 'MAIL': '/var/mail/cltbld', 16:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:37 INFO - 'MOZ_NO_REMOTE': '1', 16:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:37 INFO - 'NO_EM_RESTART': '1', 16:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:37 INFO - 'PWD': '/builds/slave/test', 16:22:37 INFO - 'SHELL': '/bin/bash', 16:22:37 INFO - 'SHLVL': '1', 16:22:37 INFO - 'TERM': 'linux', 16:22:37 INFO - 'TMOUT': '86400', 16:22:37 INFO - 'USER': 'cltbld', 16:22:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:37 INFO - '_': '/tools/buildbot/bin/python'} 16:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:37 INFO - Running setup.py (path:/tmp/pip-Rxwtj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:37 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)) 16:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:37 INFO - Running setup.py (path:/tmp/pip-U1eBiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:37 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)) 16:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:37 INFO - Running setup.py (path:/tmp/pip-dYUzSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:37 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)) 16:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:37 INFO - Running setup.py (path:/tmp/pip-elAEpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:37 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)) 16:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:37 INFO - Running setup.py (path:/tmp/pip-7zaNzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:37 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)) 16:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:37 INFO - Running setup.py (path:/tmp/pip-ZYHNca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:38 INFO - Running setup.py (path:/tmp/pip-yu3kiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:38 INFO - Running setup.py (path:/tmp/pip-f0gMZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:38 INFO - Running setup.py (path:/tmp/pip-Yr4txI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:38 INFO - Running setup.py (path:/tmp/pip-6ix8Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:38 INFO - Running setup.py (path:/tmp/pip-KknAIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:38 INFO - Running setup.py (path:/tmp/pip-64uBln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:38 INFO - Running setup.py (path:/tmp/pip-fb9h5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:38 INFO - Running setup.py (path:/tmp/pip-vQHPAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:38 INFO - Running setup.py (path:/tmp/pip-Lw44OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:38 INFO - Running setup.py (path:/tmp/pip-nP3ncg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:38 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)) 16:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:38 INFO - Running setup.py (path:/tmp/pip-JDYLvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:38 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)) 16:22:38 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)) 16:22:38 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)) 16:22:38 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)) 16:22:38 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)) 16:22:38 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)) 16:22:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:40 INFO - Downloading blessings-1.6.tar.gz 16:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:40 INFO - Installing collected packages: blessings 16:22:40 INFO - Running setup.py install for blessings 16:22:40 INFO - Successfully installed blessings 16:22:40 INFO - Cleaning up... 16:22:40 INFO - Return code: 0 16:22:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:41 INFO - Reading from file tmpfile_stdout 16:22:41 INFO - Current package versions: 16:22:41 INFO - argparse == 1.2.1 16:22:41 INFO - blessings == 1.6 16:22:41 INFO - blobuploader == 1.2.4 16:22:41 INFO - docopt == 0.6.1 16:22:41 INFO - manifestparser == 1.1 16:22:41 INFO - mozInstall == 1.12 16:22:41 INFO - mozcrash == 0.17 16:22:41 INFO - mozdebug == 0.1 16:22:41 INFO - mozdevice == 0.48 16:22:41 INFO - mozfile == 1.2 16:22:41 INFO - mozhttpd == 0.7 16:22:41 INFO - mozinfo == 0.9 16:22:41 INFO - mozleak == 0.1 16:22:41 INFO - mozlog == 3.1 16:22:41 INFO - moznetwork == 0.27 16:22:41 INFO - mozprocess == 0.22 16:22:41 INFO - mozprofile == 0.28 16:22:41 INFO - mozrunner == 6.11 16:22:41 INFO - mozscreenshot == 0.1 16:22:41 INFO - mozsystemmonitor == 0.0 16:22:41 INFO - moztest == 0.7 16:22:41 INFO - mozversion == 1.4 16:22:41 INFO - psutil == 3.1.1 16:22:41 INFO - requests == 1.2.3 16:22:41 INFO - wsgiref == 0.1.2 16:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:41 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 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22:41 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 16:22:41 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 16:22:41 INFO - Using env: {'DISPLAY': ':0', 16:22:41 INFO - 'HOME': '/home/cltbld', 16:22:41 INFO - 'LANG': 'en_US.UTF-8', 16:22:41 INFO - 'LANGUAGE': 'en_US:en', 16:22:41 INFO - 'LOGNAME': 'cltbld', 16:22:41 INFO - 'MAIL': '/var/mail/cltbld', 16:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:41 INFO - 'MOZ_NO_REMOTE': '1', 16:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:41 INFO - 'NO_EM_RESTART': '1', 16:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:41 INFO - 'PWD': '/builds/slave/test', 16:22:41 INFO - 'SHELL': '/bin/bash', 16:22:41 INFO - 'SHLVL': '1', 16:22:41 INFO - 'TERM': 'linux', 16:22:41 INFO - 'TMOUT': '86400', 16:22:41 INFO - 'USER': 'cltbld', 16:22:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:41 INFO - '_': '/tools/buildbot/bin/python'} 16:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 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)) 16:22:41 INFO - Cleaning up... 16:22:41 INFO - Return code: 0 16:22:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22: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', 'jsonschema'] in /builds/slave/test/build 16:22: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 jsonschema 16:22:41 INFO - Using env: {'DISPLAY': ':0', 16:22:41 INFO - 'HOME': '/home/cltbld', 16:22:41 INFO - 'LANG': 'en_US.UTF-8', 16:22:41 INFO - 'LANGUAGE': 'en_US:en', 16:22:41 INFO - 'LOGNAME': 'cltbld', 16:22:41 INFO - 'MAIL': '/var/mail/cltbld', 16:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:41 INFO - 'MOZ_NO_REMOTE': '1', 16:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:41 INFO - 'NO_EM_RESTART': '1', 16:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:41 INFO - 'PWD': '/builds/slave/test', 16:22:41 INFO - 'SHELL': '/bin/bash', 16:22:41 INFO - 'SHLVL': '1', 16:22:41 INFO - 'TERM': 'linux', 16:22:41 INFO - 'TMOUT': '86400', 16:22:41 INFO - 'USER': 'cltbld', 16:22:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:41 INFO - '_': '/tools/buildbot/bin/python'} 16:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:41 INFO - Downloading/unpacking jsonschema 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:43 INFO - Downloading/unpacking functools32 (from jsonschema) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:43 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:43 INFO - warning: no files found matching '*.txt' 16:22:43 INFO - no previously-included directories found matching 'build' 16:22:43 INFO - no previously-included directories found matching 'dist' 16:22:43 INFO - no previously-included directories found matching '.git*' 16:22:43 INFO - Installing collected packages: jsonschema, functools32 16:22:43 INFO - Running setup.py install for functools32 16:22:43 INFO - warning: no files found matching '*.txt' 16:22:43 INFO - no previously-included directories found matching 'build' 16:22:43 INFO - no previously-included directories found matching 'dist' 16:22:43 INFO - no previously-included directories found matching '.git*' 16:22:43 INFO - Successfully installed jsonschema functools32 16:22:43 INFO - Cleaning up... 16:22:43 INFO - Return code: 0 16:22:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e71caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', '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 16:22: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', 'flake8'] in /builds/slave/test/build 16:22: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 flake8 16:22:43 INFO - Using env: {'DISPLAY': ':0', 16:22:43 INFO - 'HOME': '/home/cltbld', 16:22:43 INFO - 'LANG': 'en_US.UTF-8', 16:22:43 INFO - 'LANGUAGE': 'en_US:en', 16:22:43 INFO - 'LOGNAME': 'cltbld', 16:22:43 INFO - 'MAIL': '/var/mail/cltbld', 16:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:43 INFO - 'MOZ_NO_REMOTE': '1', 16:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:43 INFO - 'NO_EM_RESTART': '1', 16:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:43 INFO - 'PWD': '/builds/slave/test', 16:22:43 INFO - 'SHELL': '/bin/bash', 16:22:43 INFO - 'SHLVL': '1', 16:22:43 INFO - 'TERM': 'linux', 16:22:43 INFO - 'TMOUT': '86400', 16:22:43 INFO - 'USER': 'cltbld', 16:22:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:43 INFO - '_': '/tools/buildbot/bin/python'} 16:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:44 INFO - Downloading/unpacking flake8 16:22:44 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 16:22:44 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 16:22:44 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 16:22:44 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 16:22:44 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 16:22:44 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 16:22:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:22:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:22:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:22:46 INFO - no previously-included directories found matching 'docs/_build' 16:22:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:22:46 INFO - Running setup.py install for pep8 16:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:22:46 INFO - no previously-included directories found matching 'docs/_build' 16:22:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:22:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:22:46 INFO - Cleaning up... 16:22:46 INFO - Return code: 0 16:22:46 INFO - Running post-action listener: _resource_record_post_action 16:22:46 INFO - Running post-action listener: _start_resource_monitoring 16:22:47 INFO - Starting resource monitoring. 16:22:47 INFO - ##### 16:22:47 INFO - ##### Running install step. 16:22:47 INFO - ##### 16:22:47 INFO - Running pre-action listener: _resource_record_pre_action 16:22:47 INFO - Running main action method: install 16:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:47 INFO - Reading from file tmpfile_stdout 16:22:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:47 INFO - Reading from file tmpfile_stdout 16:22:47 INFO - Output received: 16:22:47 INFO - Usage: mozinstall [options] installer 16:22:47 INFO - Options: 16:22:47 INFO - -h, --help show this help message and exit 16:22:47 INFO - -d DEST, --destination=DEST 16:22:47 INFO - Directory to install application into. [default: 16:22:47 INFO - "/builds/slave/test"] 16:22:47 INFO - --app=APP Application being installed. [default: firefox] 16:22:47 INFO - mkdir: /builds/slave/test/build/application 16:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:23:02 INFO - Reading from file tmpfile_stdout 16:23:02 INFO - Output received: 16:23:02 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:02 INFO - Running post-action listener: _resource_record_post_action 16:23:02 INFO - ##### 16:23:02 INFO - ##### Running run-tests step. 16:23:02 INFO - ##### 16:23:02 INFO - Running pre-action listener: _resource_record_pre_action 16:23:02 INFO - Running main action method: run_tests 16:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:02 INFO - Python 2.7.3 16:23:02 INFO - Return code: 0 16:23:02 INFO - grabbing minidump binary from tooltool 16:23:02 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')]} 16:23:02 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9410>, '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 0x10da310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:02 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 16:23:02 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 16:23:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:02 INFO - Return code: 0 16:23:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:23:03 INFO - Return code: 0 16:23:03 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:23:03 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:23:03 INFO - Using env: {'DISPLAY': ':0', 16:23:03 INFO - 'HOME': '/home/cltbld', 16:23:03 INFO - 'LANG': 'en_US.UTF-8', 16:23:03 INFO - 'LANGUAGE': 'en_US:en', 16:23:03 INFO - 'LOGNAME': 'cltbld', 16:23:03 INFO - 'MAIL': '/var/mail/cltbld', 16:23:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:03 INFO - 'MOZ_NO_REMOTE': '1', 16:23:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:03 INFO - 'NO_EM_RESTART': '1', 16:23:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:03 INFO - 'PWD': '/builds/slave/test', 16:23:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:03 INFO - 'SHELL': '/bin/bash', 16:23:03 INFO - 'SHLVL': '1', 16:23:03 INFO - 'TERM': 'linux', 16:23:03 INFO - 'TMOUT': '86400', 16:23:03 INFO - 'USER': 'cltbld', 16:23:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903', 16:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:03 INFO - '_': '/tools/buildbot/bin/python'} 16:23:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:23:04 INFO - mozversion application_buildid: 20160502133436 16:23:04 INFO - mozversion application_changeset: cb7afc6a6450dd75d89b10825f719178eb15437b 16:23:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:23:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:04 INFO - mozversion application_name: Firefox 16:23:04 INFO - mozversion application_remotingname: firefox-dev 16:23:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:23:04 INFO - mozversion application_vendor: Mozilla 16:23:04 INFO - mozversion application_version: 48.0a2 16:23:04 INFO - mozversion platform_buildid: 20160502133436 16:23:04 INFO - mozversion platform_changeset: cb7afc6a6450dd75d89b10825f719178eb15437b 16:23:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:23:04 INFO - mozversion platform_version: 48.0a2 16:23:04 INFO - using testdate: 1462231384 16:23:04 INFO - actual date: 1462231384 16:23:04 INFO - starting webserver on 'localhost:44929' 16:23:04 INFO - SUITE-START | Running 2 tests 16:23:04 INFO - TEST-START | dromaeo_css 16:23:04 INFO - operating with platform_type : linux_ 16:23:04 INFO - Initialising browser for dromaeo_css test... 16:23:04 INFO - TEST-INFO | started process 14487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqs7mg5/profile http://localhost:44929/getInfo.html) 16:23:08 INFO - PROCESS | 14487 | __metrics Screen width/height:1600/1200 16:23:08 INFO - PROCESS | 14487 | colorDepth:24 16:23:08 INFO - PROCESS | 14487 | Browser inner width/height: 1024/697 16:23:08 INFO - PROCESS | 14487 | __metrics 16:23:08 ERROR - PROCESS | 14487 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:23:09 INFO - TEST-INFO | 14487: exit 0 16:23:09 INFO - Browser initialized. 16:23:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:09 INFO - TEST-INFO | started process 14576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqs7mg5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:21 INFO - PROCESS | 14576 | RSS: Main: 142176256 16:23:21 INFO - PROCESS | 14576 | 16:24:12 INFO - PROCESS | 14576 | 1462231452663 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] 16:26:20 INFO - PROCESS | 14576 | Cycle 1(1): loaded http://localhost:44929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44929/tests/dromaeo/cssquery-ext.html) 16:26:21 INFO - PROCESS | 14576 | RSS: Main: 250683392 16:26:21 INFO - PROCESS | 14576 | 16:29:23 INFO - PROCESS | 14576 | Cycle 1(1): loaded http://localhost:44929/tests/dromaeo/cssquery-ext.html (next: http://localhost:44929/tests/dromaeo/cssquery-jquery.html) 16:29:24 INFO - PROCESS | 14576 | RSS: Main: 223760384 16:29:24 INFO - PROCESS | 14576 | 16:32:26 INFO - PROCESS | 14576 | Cycle 1(1): loaded http://localhost:44929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44929/tests/dromaeo/cssquery-mootools.html) 16:32:26 INFO - PROCESS | 14576 | RSS: Main: 226320384 16:32:26 INFO - PROCESS | 14576 | 16:35:28 INFO - PROCESS | 14576 | Cycle 1(1): loaded http://localhost:44929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44929/tests/dromaeo/cssquery-prototype.html) 16:35:29 INFO - PROCESS | 14576 | RSS: Main: 216350720 16:35:29 INFO - PROCESS | 14576 | 16:38:31 INFO - PROCESS | 14576 | Cycle 1(1): loaded http://localhost:44929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44929/tests/dromaeo/cssquery-yui.html) 16:38:32 INFO - PROCESS | 14576 | RSS: Main: 214786048 16:38:32 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | Cycle 1(1): loaded http://localhost:44929/tests/dromaeo/cssquery-yui.html (next: http://localhost:44929/tests/dromaeo/cssquery-dojo.html) 16:41:34 INFO - PROCESS | 14576 | RSS: Main: 235503616 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | __start_tp_report 16:41:34 INFO - PROCESS | 14576 | _x_x_mozilla_page_load 16:41:34 INFO - PROCESS | 14576 | _x_x_mozilla_page_load_details 16:41:34 INFO - PROCESS | 14576 | |i|pagename|runs| 16:41:34 INFO - PROCESS | 14576 | |0;dojo.html;3310.2386451116245;3340.5156252343427;3353.3125709229594;3358.9664103358973;3401.2517246205844;5429.049916264653;5441.374241962176;5465.207544905991;5474.042042642542;5493.423190564993;5457.181422786584;5512.669239845602;5513.862153446166;5518.724063796804;5522.420145884685;4853.466118726938;4928.26076088586;4978.6514943953935;5005.874853128665;5079.79680812767;4946.629002824785;5037.11850426174;5046.54581087702;5046.84859454217;5046.924296135561;4931.334269873575;4981.775820088104;4987.426445958725;5024.82413115541;5030.84907452777;5031.547160755531;5052.317937078484;5076.771545280471;5077.086124497589;5105.030044291572;4858.975705121487;4896.290037944514;4921.704697718148;4983.401991760976;5018;5254.290670759437;5267.47325267474;5327.7336133193185;5335.359756829166;5338.359396872362;5807.622504537191;5870.618409803392;5880;5882.323532793741;5889.381614930457;5846.941530584725;5885.911711324334;5925.170476133301;5928.081147422114;5954.761809527614;5423.945760542383;5469.343678758495;5471.863203419906;5477.808276710336;5482.533984611313;5796.246487956623;5946.940530594638;5953;5966.612170208922;5968.403159684084;5720.08478643415;5751.367349591542;5776.768929242783;5793.275840519935;5805.593608447368;5841.88316233673;5854.414558544111;5861.912071318934;5864.648121112747;5871.6770577618645;5678.659280443187;5800.9129863052085;5818.8254352369495;5823.980803359395;5829.504492118217;5816.651000939957;5825.592208545361;5826.592138550345;5833.358330583633;5861.267341582302;4439.334099885043;4441.71128876622;4443.777811109431;4467.955320446819;4497.820087196541;3912.295786758411;3976.980115099406;3985.003749062734;4035.53591337;4054.493188351456;5568.025595520849;5594.13290939905;5594.188842617879;5594.440555944454;5602.215689803431;5886.352501224862;5901.232839730894;5904.911426328608;5906.704664766745;5911.349751527328;5384.246205531229;5538.9169162462595;5572.414896435897;5588.1059030555725;5604.8318550443555;4889.682170658896;4905.7301848397965;4907.9263811042865;4912.852614421573;4951.183054795991;6054.061620448838;6102.206713127265;6118.082287656887;6118.082287656887;6122;5673.574481913955;5814.73833677494;5890.175375447355;5895.587308888336;5897.203877476486;6026.548008899263;6035.36628653985;6036.879262414815;6037.909431358621;6038.4867286279405;5598.468145526169;5678.346990096192;5688.14677798317;5689.34572524165;5703.971480142573;5776.971115144397;5815.331236907809;5816.738246778989;5828.970855145867;5869.8239052828485;5685.175649530877;5692.743826527899;5697.088465845445;5706.457886500776;5712.885742285214;5525.834224973257;5678.74445649955;5687.744051517609;5688.3742788294085;5695.572832037531;5608.915866262091;5624.29696287964;5632.127020311858;5635.774569017193;5662.122371032497;5669.262995810518;5738.741756621045;5742.483176514133;5747.19539264495;5749.166370876116;5531.529819965348;5619.325680918316;5644.153376993484;5648.943510564842;5743.712814359349 16:41:34 INFO - PROCESS | 14576 | |1;ext.html;595.4224402329738;653.2291895563234;657.2310396835702;664.3522565498637;678.4436761855279;30864.228394290152;39895.40156897645;40556.797216013954;40777.38833917493;40783.18433631326;43894;44760.55239447604;44791.77604111975;44819.77590112045;44847.327290090594;8085.110637829834;8676.47941123533;8997.550122493882;10160.441175735332;10401.167906567494;10417.479126043705;10600.78798424031;10605.73485662857;10614.946925265363;10624.30941988772;10470.738231544196;10617.150627949784;10619.840702389432;10632.30889992148;10634.627788027421;8024.358051355906;10340.948295258513;10527.105196058345;10537.420441875694;10541.104006159485;10550;10653.094486968617;10655.041046305869;10667;10671.626493072783;39959;41063.58936410627;41087;41110;41114.58885411167;3681.7606855554573;3713.925721485582;3770.7171962102952;3800.7339486235974;3806.7715937043868;34826.30347393038;35508.64491355105;35610.10974725627;35626.821865890764;35803.64196358029;4068.552459229512;4166.6250037496775;4199.4330765346895;4203.201391735561;4223.598758117974;245877;248321;249348;249836;250450;31086.53370199449;31434.68565314363;70412.2958770416;71113.64443177752;71241.93137102948;33119.172020699676;33156.83421582876;33224.501632475534;33341;33442;15370.769438458432;17330.74003889943;17607.207675654627;17613.207405666777;17628.823711762976;13576.864231357758;13929.094608850392;13944;13956.930215348859;13964.301784910916;9559.283053770994;9573.473458959685;9609.069233883592;9635.277354198462;9684.08001239881;2982.56752770847;3031.514158390143;3053.2061663967083;3078.1073488688476;3134.7335476484755;1091.3124731419314;1127.9492422840992;1190.8392367030513;1206.6500714792612;1208.583038851595;31237.219069522987;31648.525272120936;31849.8407507961;32437.35125297528;33252.50121248183;1243.5274595653593;1275.3941877608063;1307.7972914198315;1340.1423089222906;1343.986560134386;17533.29866805339;17803.879374757093;17868.195931183127;17870.5532361692;17872.28510859577;532571;539210;539634;539710;540453;65761.34238657648;66914.66542667255;66934;66994.66502667553;67144.6642766783;1358.2936872826272;1490.470882836599;1505.284989629939;1588.4202266172763;1625.1955282135182;31249.84375078201;31899;34261;34562.654373455945;34671.65328346684;55280;56466.71766641141;56549;56601;56642;269838;422760;424358;425012;425464;43085.35371969486;43260.35109473424;43546.34680479859;43551.12897742091;43915.34126988162;49413.75293123511;49737.75131124321;50291;51379.74310128426;51414;40656.59343406646;41221.1755764889;41508;42676.573234267256;42781.57218427776;43854;43976.34035489406;45120.32319515144;45899.77050114728;46372.30441543447;46481;46495;47215;47487;47545;40082.799586001885;41005;41077.38383924303;41290;41307.38038929358;30880.691193087783;31034.20945738445;31067.223319417197;31126.22184445407;31386.21534461657 16:41:34 INFO - PROCESS | 14576 | |2;jquery.html;396.84721382267827;400.96591789697885;405.2320851985486;419.2579134931172;422.6090865948996;12970.80543791844;18026.18882150303;18934.431967040975;18943.336983205572;20171.798282017175;15054.397824087051;17167.57081072974;17812.821871781278;17845.196966136522;18322.541936451595;5548.306461692288;5783.016887129198;5794.623349482291;5795;5795.507381872546;5458.781648734066;5650.378458369576;5736.996025695507;5751.4536119068625;5754.1944127822135;5680.289963754531;5730.885382292352;5738.139279108146;5751.913721294184;5755.0504166812425;5418.133098704188;5613.831585052455;5614.101743721006;5628.155776633497;5714.542836573064;5033.521815427529;5087.898242035176;5098.260752190949;5120.103981803207;5122.026814905156;21847.781522184734;22242.443938901495;22491.775082249296;22836;22910.198143065078;2589.741025897395;2594.9870250648814;2595.948081038369;2622;2681.705012448629;14418.639534011734;14433.783493247609;14492;14772.70454590913;15113.773293400607;2036.1549956767924;2068.379486154163;2090.4146838884985;2107.7576078750835;2151.580441813847;78712;81008.18991810066;81258.59370703109;81715.18284817194;82279.70881164746;10184.949075254577;10542.47287635615;10591.311564748421;10594.099501542456;10624.150067994542;14633.560993170222;14694.485693000694;14777.113373197642;14816.296125945439;14832.777508337384;8427.452215605967;8470.195331443503;8474.703385381483;8542.530160841214;8608.69869554575;8456.746297611082;8524.8721269181;8615.224629783224;8617.913820861837;8656.31201915633;4004;5821.301443826683;6190.721417536221;6242.906356404657;6613.636250006296;1882.5670095877751;1952.8242458178547;1993.641144593987;2010.2461576908659;2095.476130967258;986.9013098690074;994.9154321882721;1076.472528461064;1112.2936935046305;1189.898858597029;17477.213525391133;17505.64988700219;17619.911900440417;17678;18048.548786280186;1078.5200585739428;1093.278436232099;1094.8412480190327;1101.983470247947;1120.4285814234636;10138.341007834468;10593.629222977159;10617.469126543641;10722.303050301705;10748;517313;517957;523628;532629;536691;98509;99471.50264248632;99590;99609.50195248978;100197;1035.30634474902;1036.5542816588788;1064.9467526623637;1068.8289873620183;1072.6460268111505;16267.234570122871;16540.338386464406;16780.412685555948;16823.495295141165;17167.399141030004;40639.1872162561;41158.1768364637;41295.58704412918;42631.36052959146;43097.35353969756;57491;58796;59196.70401647964;59887.40112598818;59928.700356499685;6563;7383.889241661272;8171.918280817115;8284.212999765012;8609.139086091342;7636.311942705419;12758.170718903242;13133.934330328288;13330.466781328638;13622.727545449234;10839.729006774578;11009.944950275198;11058.944705276423;11255.66233013011;11342.60300889465;10949.945250273699;11083.224174307721;11517.42412879336;11623.244489108181;11699.766004679688;11390.658280251606;11468.369239691898;11617.767644647229;11624;11646.24299420535;8264.297534709376;8421.178486738752;8422.284105851071;8464.026636936831;8505.064442911398;10750.623728169476;11314.886851131383;11495.885041149482;11541.711457213636;11586.942065289619 16:41:34 INFO - PROCESS | 14576 | |3;mootools.html;1416.150309814111;1541.2447900528741;1579.2735341742798;1724.30165782858;1857.8699491035634;7622.885656715147;8214.30178434833;8406.7057652982;8432.578371081438;8480.830383392344;8190.91809081909;8315.168483151681;8328.875066874001;8345.833083338344;8347.666093356258;2073.419442556087;2166.295953815016;2235.407616981501;2313.2135074074854;2360.3037104054347;2364.361622361961;2376.489054853206;2387.0929046962215;2389.247387073075;2392.150786470795;2298.5517824024323;2342.543204075206;2346.8239882008834;2346.8709220992837;2349.1073392110975;2030.6344857925567;2174.3694328644674;2231.2190733243397;2236.0161528927383;2236.2061468178886;2272.488690044743;2275.5562665280277;2291.9197828076103;2292.094622624071;2313.34069790109;8551.572421378905;8570.871436928452;8583.699570515002;8586.613602387908;8592.226699597066;5060.696358218519;5231.398389185254;5238.240455133984;5254.133068043769;5280.947190528084;3275.5905511811025;3327.05179023977;3374.038399056282;3441.328940856509;3464.0300715799617;1065.6430095917876;1092.2299778656109;1116.391566596207;1126.808442564766;1160.7214268575565;11888.583899563473;11934;11943.94028029863;11944.343061131722;11953.043756499459;4435.534268901783;4459.910801784011;4521.59305662492;4539.568740969603;4554.521775213555;10156.593736250616;10181.745456363502;10188.796224075626;10191.337563058378;10193.133583645325;4813.807447702123;5315.229291752674;5366.409694933554;5367.087595108841;5384.811531596375;4663.766811659403;4819.59033482151;4836.685615434985;4845.103655823684;4862.78117484714;3886.9028274292805;3953.743006704555;4017.979910100431;4044.8786536403954;4095.9590404096175;1250.9061820363509;1298.3054066074794;1303.648015035954;1317.0648839323997;1321.14125818217;1075.9139268858473;1105.2760441910561;1105.745678493951;1111.2332490581473;1117.6870476266658;5817.301923769175;5976.7908123215475;6001.159837622737;6006.849828754316;6079;432.4961419945791;435.4970009638872;436.0646413443147;1068.1454836131063;1133.6032388664066;4270.957290427118;4272.124214536013;4274;4277.7647229402055;4299.290617048215;10059.295849290625;10402.11582015522;10430.582776689;10445.529951152217;10495.737606559896;10392.37645741258;10465.738356540995;10576.841347379795;10604.628837990633;10606.310589811792;7356;7513.39892808574;7606.733764318333;7621.352185064221;8055.677772889136;6117.418845209698;6123.693815309306;6201.844953876189;6287.717052732546;6347.619142851444;9200;9382.95308523453;9583.808323833624;9602.183814375578;9670.274729395464;9677.951610241904;9695.70912872615;9993.550290236812;10010.099091081838;10021;6824.317568243335;6993.510454268356;7118.786436406916;7651.923480765344;7779.7666070017995;7902.525848448881;7923.088844782924;7962.08436029864;7986.161453047579;8030;7019.473539484661;7040.471964602573;7070.328318809705;7210;7402.33378995893;7134.32223938725;7149.106361704787;7152.785416437515;7225.927740722525;7261.564306141649;6574.342565743387;6706.061151438705;6768.2216545097945;6777.254502004874;6778.4577233822165;5253.605979551626;5361.51746342831;5396.298481197419;5461.481159289861;5527.44725527444;5492.642978206404;5496.120620700669;5501.559875210054;5506.614536982373;5570.972145139248 16:41:34 INFO - PROCESS | 14576 | |4;prototype.html;326.46296841695414;326.882322363949;332.2938755145315;334.4431521516675;336.3659501839033;5285.418603953567;5402.864928376793;5402.9729851350785;5417.891642167155;5424.538914192293;5309.522143007129;5319.893602127955;5345.278387417698;5359.651622644526;5362.43694412087;3935.940960885589;4021.2761702893467;4139.958600414003;4166.958330416703;4190.120074784284;4154.397612346208;4156.8129434175535;4161.791910404483;4170.311898536738;4179.9791001045105;3939.4484772131923;4121.9381709274385;4138.379243113542;4143.917121657565;4156.646685031761;3895.902602434919;4023.577524359944;4080.10237747695;4107.54816970133;4147.81334839933;3653.1049892776173;3669.743117981742;3669.87155449558;3673.522442082512;3678.2091850252054;5117.872053198663;5190.468811700557;5195.844124676228;5214.400343960455;5242.895142097175;4572.154151481953;4749.905001899942;4750.627054791103;4754.857354279377;4777.402824646884;5556.888862222733;5579.553635709174;5601.187827764992;5607.635503692247;5641.94069164756;4053.310937140693;4054.594540545922;4060.2894493463823;4076.9388459173138;4081.08175660477;5691.743871525791;5806.564507661942;5806.7386967586135;5808.183031229893;5834.124881267844;4045.7167998239843;4082.4692789937117;4089.386592011222;4094.1197642507004;4100.91798164035;4141.364161156386;4142.71001029931;4147.988225710528;4161.958380416218;4164;4587.587117159472;4738.123447162286;4743.810247590127;4752.809887604457;4763.237881938873;5594.328680558359;5616.045272303718;5616.466435688685;5616.634918730269;5633.126865335879;1505.5633866178905;1519.8480151984713;1520.1715065289443;1522.444307827657;1531.2802982598162;940.5250348573926;978.2223132609593;992.6376872441507;994.8209322321907;1038.678009816959;5711.571632127607;5739.512141467939;5741.8277451675685;5747.051736463437;5761.695321871285;6144.846378840565;6153.507719382439;6163.1679723237685;6182.567220294626;6186.319504854462;5564.554835613222;5707.543396528268;5717.399673034354;5717.914231286534;5810.593258471867;3215.1962009497624;3275.132089996153;3283.1627934876456;3290.177455636091;3291.9136684894406;5856.502197313191;6122;6137.232845894263;6447.743289848516;6476.190476190476;5896.204012458264;5927.8221653350465;5930.644161350333;5952.523798096142;5952.642841429528;5875.6474611523445;6045.153678484928;6104.145419641254;6106.084087386927;6117.745862098348;5807.809399073095;5818.2436283282905;5845.918505076575;5885.264341957255;5888;5819.301683797971;5821.446962538552;5836.941630583639;5837.503812176013;5860.648361098348;5917.5857689961285;6080.270367555921;6129.478994285358;6150.446459818459;6151.72317245716;3942.7042971777805;3957.485526881487;3972.1261322509004;3978.343573310487;3991.600839915985;5638.887222255614;5747.224124743107;5883.470487656132;5890;5907.527397808251;5736.942630573641;5756.683382414008;5766.336871259691;5781.508571771446;5793.217915581343;5606.383297837153;5714.828555143353;5725.427457254241;5767.509761670305;5787.450192231731;5605.243292155506;5655.321361436654;5667.688277144796;5669.943300567106;5673.212937924541;5690.3456102548735;5751.769929202952;5776.393478684678;5780.942190578208;5792.768289268382;5364.034473794754;5618.550515958796;5628.268325117709;5641.802536911188;5644.238027866186 16:41:34 INFO - PROCESS | 14576 | |5;yui.html;798.9960050199749;808.3694718119865;826.5908375354198;841.9873701894472;917.0462718772477;15120.92439537802;16196.919015404936;16227.350905963747;16234.675306493878;16240;14788.704225915475;15051.548453546411;15070.547883563484;15090.924545377286;15101.924490377532;893.2585953658448;897.3001059173838;901.8016036471965;902.2285945516587;902.6840605787987;876.8202518483696;882.5498995512271;882.6601758323028;883.0110276490308;883.0639522106587;934.5560858592148;939.7979434421597;939.8402271613842;939.9859002114973;940.1162906867556;925.8935222449437;929.7582628516567;930.0420566816157;930.1814403325099;930.6184464369644;678.3250665587723;680.482833046883;680.5746408494691;680.7243066558052;681.0533358631507;13455.730885382238;13485.05604607678;13505.324733763273;13507.25710085945;13525.18848869071;13161.341932903413;13322.333883305795;13362.532311369152;13511.797323040162;13555;10866.402347870864;10960.581935503138;11031.062359699436;11284.32294062359;11418.029467495273;3963.742356746802;4024.1549274652357;4030.435738996543;4088.4480595119576;4185.455890734215;48951.755241223924;50567;55835.72082139604;58121.70939145277;58395.12407313851;11927.534713386982;12030.556333240067;12140.514379424902;12283.201591896499;12341.444634991447;21246.362609121443;21429.57140857174;21442.249521266993;21444;21825.12699492034;8341.541215233221;8525.275351595184;8602.397832151815;8682.565871706389;9324.25405967521;5004.574611158092;5154.716490593053;5160.40655324635;5198.2202669599865;5229.084910140787;3394.9490757638655;3493.039414161075;3499.6675315844955;3501.28223714138;3505.4741788731385;597.2862429396915;606.5814587934311;611.2054329371888;611.996940015306;614.2751553167216;685.4721864164665;689.9379055884895;700.2962023166685;715.3883429667663;716.3839098375392;9272.33193339884;9537.809243815085;9792;10025.949870250748;10042.447665378475;651.4104735214638;740.2782287269869;748.8839229919371;755.6712829919003;761.2007392238128;4578.702384345007;4661.254199328091;4692.052947201979;4708.905821883612;4766;64396;67400;69675;69740;69760;44253.55746442559;60606.39393606008;61480.385196147465;64117.679411603574;64195;47650.285245721345;49900.25149622759;49918.25122623164;51026.23460648093;51135.23297150546;10277;10278.229132815219;10290.742731431774;10319.400492923609;10418.843717344094;36486.27027459383;36712.63287367092;37511.81244093762;37548.6245137556;37552.2489550202;46489.535104649876;49022;49330.75334623304;49929;50099;12924.806127907901;12951;12974.28641424693;13025.544105956245;13204.66988325261;13138;13575.932120339336;13581.796273055714;13747.656308592364;14786.482473113389;13267.66830829237;13782.586522404345;14257.643558910695;14404.20776857241;14645.633859153606;13422.664433389244;13536.932315338361;13709.314534273446;13998.300084995913;14060.578182654537;12874.806877897026;12945.935270323587;13009.869901300866;13176.077674563072;13302.40139193758;11241.943790280997;11533.88466115328;11559.711007224887;11642.185047046964;11782.764344713229;11252.774944500901;11270.887291126985;11482.343095400627;11563.942180289381;11584.536618535501 16:41:34 INFO - PROCESS | 14576 | __end_tp_report 16:41:34 INFO - PROCESS | 14576 | __start_cc_report 16:41:34 INFO - PROCESS | 14576 | _x_x_mozilla_cycle_collect,882 16:41:34 INFO - PROCESS | 14576 | __end_cc_report 16:41:34 INFO - PROCESS | 14576 | __startTimestamp1462232494927__endTimestamp 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | ------- Summary: start ------- 16:41:34 INFO - PROCESS | 14576 | Number of tests: 6 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | [#0] dojo.html Cycles:165 Average:5431.62 Median:5635.77 stddev:595.30 (10.6%) stddev-sans-first:573.39 16:41:34 INFO - PROCESS | 14576 | Values: 3310.2 3340.5 3353.3 3359.0 3401.3 5429.0 5441.4 5465.2 5474.0 5493.4 5457.2 5512.7 5513.9 5518.7 5522.4 4853.5 4928.3 4978.7 5005.9 5079.8 4946.6 5037.1 5046.5 5046.8 5046.9 4931.3 4981.8 4987.4 5024.8 5030.8 5031.5 5052.3 5076.8 5077.1 5105.0 4859.0 4896.3 4921.7 4983.4 5018.0 5254.3 5267.5 5327.7 5335.4 5338.4 5807.6 5870.6 5880.0 5882.3 5889.4 5846.9 5885.9 5925.2 5928.1 5954.8 5423.9 5469.3 5471.9 5477.8 5482.5 5796.2 5946.9 5953.0 5966.6 5968.4 5720.1 5751.4 5776.8 5793.3 5805.6 5841.9 5854.4 5861.9 5864.6 5871.7 5678.7 5800.9 5818.8 5824.0 5829.5 5816.7 5825.6 5826.6 5833.4 5861.3 4439.3 4441.7 4443.8 4468.0 4497.8 3912.3 3977.0 3985.0 4035.5 4054.5 5568.0 5594.1 5594.2 5594.4 5602.2 5886.4 5901.2 5904.9 5906.7 5911.3 5384.2 5538.9 5572.4 5588.1 5604.8 4889.7 4905.7 4907.9 4912.9 4951.2 6054.1 6102.2 6118.1 6118.1 6122.0 5673.6 5814.7 5890.2 5895.6 5897.2 6026.5 6035.4 6036.9 6037.9 6038.5 5598.5 5678.3 5688.1 5689.3 5704.0 5777.0 5815.3 5816.7 5829.0 5869.8 5685.2 5692.7 5697.1 5706.5 5712.9 5525.8 5678.7 5687.7 5688.4 5695.6 5608.9 5624.3 5632.1 5635.8 5662.1 5669.3 5738.7 5742.5 5747.2 5749.2 5531.5 5619.3 5644.2 5648.9 5743.7 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | [#1] ext.html Cycles:180 Average:56716.33 Median:3697.84 stddev:109566.70 (2963.0%) stddev-sans-first:109793.04 16:41:34 INFO - PROCESS | 14576 | Values: 595.4 653.2 657.2 664.4 678.4 30864.2 39895.4 40556.8 40777.4 40783.2 43894.0 44760.6 44791.8 44819.8 44847.3 8085.1 8676.5 8997.6 10160.4 10401.2 10417.5 10600.8 10605.7 10614.9 10624.3 10470.7 10617.2 10619.8 10632.3 10634.6 8024.4 10340.9 10527.1 10537.4 10541.1 10550.0 10653.1 10655.0 10667.0 10671.6 39959.0 41063.6 41087.0 41110.0 41114.6 3681.8 3713.9 3770.7 3800.7 3806.8 34826.3 35508.6 35610.1 35626.8 35803.6 4068.6 4166.6 4199.4 4203.2 4223.6 245877.0 248321.0 249348.0 249836.0 250450.0 31086.5 31434.7 70412.3 71113.6 71241.9 33119.2 33156.8 33224.5 33341.0 33442.0 15370.8 17330.7 17607.2 17613.2 17628.8 13576.9 13929.1 13944.0 13956.9 13964.3 9559.3 9573.5 9609.1 9635.3 9684.1 2982.6 3031.5 3053.2 3078.1 3134.7 1091.3 1127.9 1190.8 1206.7 1208.6 31237.2 31648.5 31849.8 32437.4 33252.5 1243.5 1275.4 1307.8 1340.1 1344.0 17533.3 17803.9 17868.2 17870.6 17872.3 532571.0 539210.0 539634.0 539710.0 540453.0 65761.3 66914.7 66934.0 66994.7 67144.7 1358.3 1490.5 1505.3 1588.4 1625.2 31249.8 31899.0 34261.0 34562.7 34671.7 55280.0 56466.7 56549.0 56601.0 56642.0 269838.0 422760.0 424358.0 425012.0 425464.0 43085.4 43260.4 43546.3 43551.1 43915.3 49413.8 49737.8 50291.0 51379.7 51414.0 40656.6 41221.2 41508.0 42676.6 42781.6 43854.0 43976.3 45120.3 45899.8 46372.3 46481.0 46495.0 47215.0 47487.0 47545.0 40082.8 41005.0 41077.4 41290.0 41307.4 30880.7 31034.2 31067.2 31126.2 31386.2 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | [#2] jquery.html Cycles:180 Average:30111.08 Median:22663.89 stddev:86673.17 (382.4%) stddev-sans-first:86887.60 16:41:34 INFO - PROCESS | 14576 | Values: 396.8 401.0 405.2 419.3 422.6 12970.8 18026.2 18934.4 18943.3 20171.8 15054.4 17167.6 17812.8 17845.2 18322.5 5548.3 5783.0 5794.6 5795.0 5795.5 5458.8 5650.4 5737.0 5751.5 5754.2 5680.3 5730.9 5738.1 5751.9 5755.1 5418.1 5613.8 5614.1 5628.2 5714.5 5033.5 5087.9 5098.3 5120.1 5122.0 21847.8 22242.4 22491.8 22836.0 22910.2 2589.7 2595.0 2595.9 2622.0 2681.7 14418.6 14433.8 14492.0 14772.7 15113.8 2036.2 2068.4 2090.4 2107.8 2151.6 78712.0 81008.2 81258.6 81715.2 82279.7 10184.9 10542.5 10591.3 10594.1 10624.2 14633.6 14694.5 14777.1 14816.3 14832.8 8427.5 8470.2 8474.7 8542.5 8608.7 8456.7 8524.9 8615.2 8617.9 8656.3 4004.0 5821.3 6190.7 6242.9 6613.6 1882.6 1952.8 1993.6 2010.2 2095.5 986.9 994.9 1076.5 1112.3 1189.9 17477.2 17505.6 17619.9 17678.0 18048.5 1078.5 1093.3 1094.8 1102.0 1120.4 10138.3 10593.6 10617.5 10722.3 10748.0 517313.0 517957.0 523628.0 532629.0 536691.0 98509.0 99471.5 99590.0 99609.5 100197.0 1035.3 1036.6 1064.9 1068.8 1072.6 16267.2 16540.3 16780.4 16823.5 17167.4 40639.2 41158.2 41295.6 42631.4 43097.4 57491.0 58796.0 59196.7 59887.4 59928.7 6563.0 7383.9 8171.9 8284.2 8609.1 7636.3 12758.2 13133.9 13330.5 13622.7 10839.7 11009.9 11058.9 11255.7 11342.6 10949.9 11083.2 11517.4 11623.2 11699.8 11390.7 11468.4 11617.8 11624.0 11646.2 8264.3 8421.2 8422.3 8464.0 8505.1 10750.6 11314.9 11495.9 11541.7 11586.9 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | [#3] mootools.html Cycles:180 Average:5644.46 Median:4547.05 stddev:3124.63 (68.7%) stddev-sans-first:3117.24 16:41:34 INFO - PROCESS | 14576 | Values: 1416.2 1541.2 1579.3 1724.3 1857.9 7622.9 8214.3 8406.7 8432.6 8480.8 8190.9 8315.2 8328.9 8345.8 8347.7 2073.4 2166.3 2235.4 2313.2 2360.3 2364.4 2376.5 2387.1 2389.2 2392.2 2298.6 2342.5 2346.8 2346.9 2349.1 2030.6 2174.4 2231.2 2236.0 2236.2 2272.5 2275.6 2291.9 2292.1 2313.3 8551.6 8570.9 8583.7 8586.6 8592.2 5060.7 5231.4 5238.2 5254.1 5280.9 3275.6 3327.1 3374.0 3441.3 3464.0 1065.6 1092.2 1116.4 1126.8 1160.7 11888.6 11934.0 11943.9 11944.3 11953.0 4435.5 4459.9 4521.6 4539.6 4554.5 10156.6 10181.7 10188.8 10191.3 10193.1 4813.8 5315.2 5366.4 5367.1 5384.8 4663.8 4819.6 4836.7 4845.1 4862.8 3886.9 3953.7 4018.0 4044.9 4096.0 1250.9 1298.3 1303.6 1317.1 1321.1 1075.9 1105.3 1105.7 1111.2 1117.7 5817.3 5976.8 6001.2 6006.8 6079.0 432.5 435.5 436.1 1068.1 1133.6 4271.0 4272.1 4274.0 4277.8 4299.3 10059.3 10402.1 10430.6 10445.5 10495.7 10392.4 10465.7 10576.8 10604.6 10606.3 7356.0 7513.4 7606.7 7621.4 8055.7 6117.4 6123.7 6201.8 6287.7 6347.6 9200.0 9383.0 9583.8 9602.2 9670.3 9678.0 9695.7 9993.6 10010.1 10021.0 6824.3 6993.5 7118.8 7651.9 7779.8 7902.5 7923.1 7962.1 7986.2 8030.0 7019.5 7040.5 7070.3 7210.0 7402.3 7134.3 7149.1 7152.8 7225.9 7261.6 6574.3 6706.1 6768.2 6777.3 6778.5 5253.6 5361.5 5396.3 5461.5 5527.4 5492.6 5496.1 5501.6 5506.6 5571.0 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | [#4] prototype.html Cycles:180 Average:4796.55 Median:5597.76 stddev:1432.94 (25.6%) stddev-sans-first:1397.13 16:41:34 INFO - PROCESS | 14576 | Values: 326.5 326.9 332.3 334.4 336.4 5285.4 5402.9 5403.0 5417.9 5424.5 5309.5 5319.9 5345.3 5359.7 5362.4 3935.9 4021.3 4140.0 4167.0 4190.1 4154.4 4156.8 4161.8 4170.3 4180.0 3939.4 4121.9 4138.4 4143.9 4156.6 3895.9 4023.6 4080.1 4107.5 4147.8 3653.1 3669.7 3669.9 3673.5 3678.2 5117.9 5190.5 5195.8 5214.4 5242.9 4572.2 4749.9 4750.6 4754.9 4777.4 5556.9 5579.6 5601.2 5607.6 5641.9 4053.3 4054.6 4060.3 4076.9 4081.1 5691.7 5806.6 5806.7 5808.2 5834.1 4045.7 4082.5 4089.4 4094.1 4100.9 4141.4 4142.7 4148.0 4162.0 4164.0 4587.6 4738.1 4743.8 4752.8 4763.2 5594.3 5616.0 5616.5 5616.6 5633.1 1505.6 1519.8 1520.2 1522.4 1531.3 940.5 978.2 992.6 994.8 1038.7 5711.6 5739.5 5741.8 5747.1 5761.7 6144.8 6153.5 6163.2 6182.6 6186.3 5564.6 5707.5 5717.4 5717.9 5810.6 3215.2 3275.1 3283.2 3290.2 3291.9 5856.5 6122.0 6137.2 6447.7 6476.2 5896.2 5927.8 5930.6 5952.5 5952.6 5875.6 6045.2 6104.1 6106.1 6117.7 5807.8 5818.2 5845.9 5885.3 5888.0 5819.3 5821.4 5836.9 5837.5 5860.6 5917.6 6080.3 6129.5 6150.4 6151.7 3942.7 3957.5 3972.1 3978.3 3991.6 5638.9 5747.2 5883.5 5890.0 5907.5 5736.9 5756.7 5766.3 5781.5 5793.2 5606.4 5714.8 5725.4 5767.5 5787.5 5605.2 5655.3 5667.7 5669.9 5673.2 5690.3 5751.8 5776.4 5780.9 5792.8 5364.0 5618.6 5628.3 5641.8 5644.2 16:41:34 INFO - PROCESS | 14576 | 16:41:34 INFO - PROCESS | 14576 | [#5] yui.html Cycles:180 Average:15671.28 Median:4136.95 stddev:18083.07 (437.1%) stddev-sans-first:18099.31 16:41:34 INFO - PROCESS | 14576 | Values: 799.0 808.4 826.6 842.0 917.0 15120.9 16196.9 16227.4 16234.7 16240.0 14788.7 15051.5 15070.5 15090.9 15101.9 893.3 897.3 901.8 902.2 902.7 876.8 882.5 882.7 883.0 883.1 934.6 939.8 939.8 940.0 940.1 925.9 929.8 930.0 930.2 930.6 678.3 680.5 680.6 680.7 681.1 13455.7 13485.1 13505.3 13507.3 13525.2 13161.3 13322.3 13362.5 13511.8 13555.0 10866.4 10960.6 11031.1 11284.3 11418.0 3963.7 4024.2 4030.4 4088.4 4185.5 48951.8 50567.0 55835.7 58121.7 58395.1 11927.5 12030.6 12140.5 12283.2 12341.4 21246.4 21429.6 21442.2 21444.0 21825.1 8341.5 8525.3 8602.4 8682.6 9324.3 5004.6 5154.7 5160.4 5198.2 5229.1 3394.9 3493.0 3499.7 3501.3 3505.5 597.3 606.6 611.2 612.0 614.3 685.5 689.9 700.3 715.4 716.4 9272.3 9537.8 9792.0 10025.9 10042.4 651.4 740.3 748.9 755.7 761.2 4578.7 4661.3 4692.1 4708.9 4766.0 64396.0 67400.0 69675.0 69740.0 69760.0 44253.6 60606.4 61480.4 64117.7 64195.0 47650.3 49900.3 49918.3 51026.2 51135.2 10277.0 10278.2 10290.7 10319.4 10418.8 36486.3 36712.6 37511.8 37548.6 37552.2 46489.5 49022.0 49330.8 49929.0 50099.0 12924.8 12951.0 12974.3 13025.5 13204.7 13138.0 13575.9 13581.8 13747.7 14786.5 13267.7 13782.6 14257.6 14404.2 14645.6 13422.7 13536.9 13709.3 13998.3 14060.6 12874.8 12945.9 13009.9 13176.1 13302.4 11241.9 11533.9 11559.7 11642.2 11782.8 11252.8 11270.9 11482.3 11563.9 11584.5 16:41:34 INFO - PROCESS | 14576 | -------- Summary: end -------- 16:41:34 INFO - PROCESS | 14576 | 16:41:35 INFO - TEST-INFO | 14576: exit 0 16:41:35 INFO - TEST-OK | dromaeo_css | took 1111540ms 16:41:35 INFO - TEST-START | kraken 16:41:35 INFO - operating with platform_type : linux_ 16:41:35 INFO - Initialising browser for kraken test... 16:41:35 INFO - TEST-INFO | started process 14772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTCppZ/profile http://localhost:44929/getInfo.html) 16:41:39 INFO - PROCESS | 14772 | __metrics Screen width/height:1600/1200 16:41:39 INFO - PROCESS | 14772 | colorDepth:24 16:41:39 INFO - PROCESS | 14772 | Browser inner width/height: 1024/697 16:41:39 INFO - PROCESS | 14772 | __metrics 16:41:40 ERROR - PROCESS | 14772 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:41:41 INFO - TEST-INFO | 14772: exit 0 16:41:41 INFO - Browser initialized. 16:41:41 INFO - Running cycle 1/1 for kraken test... 16:41:41 INFO - TEST-INFO | started process 14861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTCppZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:52 INFO - PROCESS | 14861 | RSS: Main: 142475264 16:41:52 INFO - PROCESS | 14861 | 16:41:55 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44929/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:56 INFO - PROCESS | 14861 | RSS: Main: 191094784 16:41:56 INFO - PROCESS | 14861 | 16:41:58 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44929/tests/kraken/driver.html?testName=audio-dft) 16:41:59 INFO - PROCESS | 14861 | RSS: Main: 184856576 16:41:59 INFO - PROCESS | 14861 | 16:42:02 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44929/tests/kraken/driver.html?testName=audio-fft) 16:42:02 INFO - PROCESS | 14861 | RSS: Main: 273948672 16:42:02 INFO - PROCESS | 14861 | 16:42:04 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44929/tests/kraken/driver.html?testName=audio-oscillator) 16:42:05 INFO - PROCESS | 14861 | RSS: Main: 183083008 16:42:05 INFO - PROCESS | 14861 | 16:42:07 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:08 INFO - PROCESS | 14861 | RSS: Main: 181567488 16:42:08 INFO - PROCESS | 14861 | 16:42:11 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44929/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:11 INFO - PROCESS | 14861 | RSS: Main: 215773184 16:42:11 INFO - PROCESS | 14861 | 16:42:15 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44929/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:15 INFO - PROCESS | 14861 | RSS: Main: 215887872 16:42:15 INFO - PROCESS | 14861 | 16:42:18 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44929/tests/kraken/driver.html?testName=json-parse-financial) 16:42:19 INFO - PROCESS | 14861 | RSS: Main: 215654400 16:42:19 INFO - PROCESS | 14861 | 16:42:20 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:21 INFO - PROCESS | 14861 | RSS: Main: 194129920 16:42:21 INFO - PROCESS | 14861 | 16:42:23 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:23 INFO - PROCESS | 14861 | RSS: Main: 195264512 16:42:23 INFO - PROCESS | 14861 | 16:42:25 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:26 INFO - PROCESS | 14861 | RSS: Main: 208367616 16:42:26 INFO - PROCESS | 14861 | 16:42:28 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:29 INFO - PROCESS | 14861 | RSS: Main: 214970368 16:42:29 INFO - PROCESS | 14861 | 16:42:32 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:32 INFO - PROCESS | 14861 | RSS: Main: 211017728 16:42:32 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | Cycle 1(1): loaded http://localhost:44929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44929/tests/kraken/driver.html?testName=ai-astar) 16:42:34 INFO - PROCESS | 14861 | RSS: Main: 275202048 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | __start_tp_report 16:42:34 INFO - PROCESS | 14861 | _x_x_mozilla_page_load 16:42:34 INFO - PROCESS | 14861 | _x_x_mozilla_page_load_details 16:42:34 INFO - PROCESS | 14861 | |i|pagename|runs| 16:42:34 INFO - PROCESS | 14861 | |0;ai-astar;110;109;105;109;109;109;99;110;109;111 16:42:34 INFO - PROCESS | 14861 | |1;audio-beat-detection;161;132;156;169;127;150;160;129;195;127 16:42:34 INFO - PROCESS | 14861 | |2;audio-dft;162;162;161;160;160;162;158;164;161;161 16:42:34 INFO - PROCESS | 14861 | |3;audio-fft;76;73;77;170;76;76;76;76;159;77 16:42:34 INFO - PROCESS | 14861 | |4;audio-oscillator;93;92;147;91;93;92;151;92;93;144 16:42:34 INFO - PROCESS | 14861 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 16:42:34 INFO - PROCESS | 14861 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;145;145 16:42:34 INFO - PROCESS | 14861 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:42:34 INFO - PROCESS | 14861 | |8;json-parse-financial;53;57;59;55;56;55;57;75;54;54 16:42:34 INFO - PROCESS | 14861 | |9;json-stringify-tinderbox;61;60;59;59;60;60;60;60;60;59 16:42:34 INFO - PROCESS | 14861 | |10;stanford-crypto-aes;72;72;80;72;74;82;73;82;74;75 16:42:34 INFO - PROCESS | 14861 | |11;stanford-crypto-ccm;122;118;119;118;130;119;129;116;154;125 16:42:34 INFO - PROCESS | 14861 | |12;stanford-crypto-pbkdf2;160;160;160;165;162;160;159;160;159;165 16:42:34 INFO - PROCESS | 14861 | |13;stanford-crypto-sha256-iterative;65;65;66;66;65;66;65;67;66;65 16:42:34 INFO - PROCESS | 14861 | __end_tp_report 16:42:34 INFO - PROCESS | 14861 | __start_cc_report 16:42:34 INFO - PROCESS | 14861 | _x_x_mozilla_cycle_collect,1611 16:42:34 INFO - PROCESS | 14861 | __end_cc_report 16:42:34 INFO - PROCESS | 14861 | __startTimestamp1462232554615__endTimestamp 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | ------- Summary: start ------- 16:42:34 INFO - PROCESS | 14861 | Number of tests: 14 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.50 stddev:3.53 (3.2%) stddev-sans-first:3.67 16:42:34 INFO - PROCESS | 14861 | Values: 110.0 109.0 105.0 109.0 109.0 109.0 99.0 110.0 109.0 111.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:158.00 stddev:22.27 (14.1%) stddev-sans-first:23.30 16:42:34 INFO - PROCESS | 14861 | Values: 161.0 132.0 156.0 169.0 127.0 150.0 160.0 129.0 195.0 127.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.60 (1.0%) stddev-sans-first:1.66 16:42:34 INFO - PROCESS | 14861 | Values: 162.0 162.0 161.0 160.0 160.0 162.0 158.0 164.0 161.0 161.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.47 (49.3%) stddev-sans-first:39.20 16:42:34 INFO - PROCESS | 14861 | Values: 76.0 73.0 77.0 170.0 76.0 76.0 76.0 76.0 159.0 77.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:26.65 (29.0%) stddev-sans-first:27.65 16:42:34 INFO - PROCESS | 14861 | Values: 93.0 92.0 147.0 91.0 93.0 92.0 151.0 92.0 93.0 144.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:42:34 INFO - PROCESS | 14861 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:42:34 INFO - PROCESS | 14861 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:42:34 INFO - PROCESS | 14861 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.50 stddev:6.40 (11.3%) stddev-sans-first:6.58 16:42:34 INFO - PROCESS | 14861 | Values: 53.0 57.0 59.0 55.0 56.0 55.0 57.0 75.0 54.0 54.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 16:42:34 INFO - PROCESS | 14861 | Values: 61.0 60.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 59.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.50 stddev:4.12 (5.5%) stddev-sans-first:4.15 16:42:34 INFO - PROCESS | 14861 | Values: 72.0 72.0 80.0 72.0 74.0 82.0 73.0 82.0 74.0 75.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:123.50 stddev:11.26 (9.1%) stddev-sans-first:11.90 16:42:34 INFO - PROCESS | 14861 | Values: 122.0 118.0 119.0 118.0 130.0 119.0 129.0 116.0 154.0 125.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:160.00 stddev:2.26 (1.4%) stddev-sans-first:2.37 16:42:34 INFO - PROCESS | 14861 | Values: 160.0 160.0 160.0 165.0 162.0 160.0 159.0 160.0 159.0 165.0 16:42:34 INFO - PROCESS | 14861 | 16:42:34 INFO - PROCESS | 14861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 16:42:34 INFO - PROCESS | 14861 | Values: 65.0 65.0 66.0 66.0 65.0 66.0 65.0 67.0 66.0 65.0 16:42:34 INFO - PROCESS | 14861 | -------- Summary: end -------- 16:42:34 INFO - PROCESS | 14861 | 16:42:35 INFO - TEST-INFO | 14861: exit 0 16:42:35 INFO - TEST-OK | kraken | took 59939ms 16:42:35 INFO - SUITE-END | took 1171s 16:42:35 INFO - Completed test suite (00:19:31) 16:42:35 INFO - javascript benchmark 16:42:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.2386451116245, 3340.5156252343427, 3353.3125709229594, 3358.9664103358973, 3401.2517246205844, 5429.049916264653, 5441.374241962176, 5465.207544905991, 5474.042042642542, 5493.423190564993, 5457.181422786584, 5512.669239845602, 5513.862153446166, 5518.724063796804, 5522.420145884685, 4853.466118726938, 4928.26076088586, 4978.6514943953935, 5005.874853128665, 5079.79680812767, 4946.629002824785, 5037.11850426174, 5046.54581087702, 5046.84859454217, 5046.924296135561, 4931.334269873575, 4981.775820088104, 4987.426445958725, 5024.82413115541, 5030.84907452777, 5031.547160755531, 5052.317937078484, 5076.771545280471, 5077.086124497589, 5105.030044291572, 4858.975705121487, 4896.290037944514, 4921.704697718148, 4983.401991760976, 5018.0, 5254.290670759437, 5267.47325267474, 5327.7336133193185, 5335.359756829166, 5338.359396872362, 5807.622504537191, 5870.618409803392, 5880.0, 5882.323532793741, 5889.381614930457, 5846.941530584725, 5885.911711324334, 5925.170476133301, 5928.081147422114, 5954.761809527614, 5423.945760542383, 5469.343678758495, 5471.863203419906, 5477.808276710336, 5482.533984611313, 5796.246487956623, 5946.940530594638, 5953.0, 5966.612170208922, 5968.403159684084, 5720.08478643415, 5751.367349591542, 5776.768929242783, 5793.275840519935, 5805.593608447368, 5841.88316233673, 5854.414558544111, 5861.912071318934, 5864.648121112747, 5871.6770577618645, 5678.659280443187, 5800.9129863052085, 5818.8254352369495, 5823.980803359395, 5829.504492118217, 5816.651000939957, 5825.592208545361, 5826.592138550345, 5833.358330583633, 5861.267341582302, 4439.334099885043, 4441.71128876622, 4443.777811109431, 4467.955320446819, 4497.820087196541, 3912.295786758411, 3976.980115099406, 3985.003749062734, 4035.53591337, 4054.493188351456, 5568.025595520849, 5594.13290939905, 5594.188842617879, 5594.440555944454, 5602.215689803431, 5886.352501224862, 5901.232839730894, 5904.911426328608, 5906.704664766745, 5911.349751527328, 5384.246205531229, 5538.9169162462595, 5572.414896435897, 5588.1059030555725, 5604.8318550443555, 4889.682170658896, 4905.7301848397965, 4907.9263811042865, 4912.852614421573, 4951.183054795991, 6054.061620448838, 6102.206713127265, 6118.082287656887, 6118.082287656887, 6122.0, 5673.574481913955, 5814.73833677494, 5890.175375447355, 5895.587308888336, 5897.203877476486, 6026.548008899263, 6035.36628653985, 6036.879262414815, 6037.909431358621, 6038.4867286279405, 5598.468145526169, 5678.346990096192, 5688.14677798317, 5689.34572524165, 5703.971480142573, 5776.971115144397, 5815.331236907809, 5816.738246778989, 5828.970855145867, 5869.8239052828485, 5685.175649530877, 5692.743826527899, 5697.088465845445, 5706.457886500776, 5712.885742285214, 5525.834224973257, 5678.74445649955, 5687.744051517609, 5688.3742788294085, 5695.572832037531, 5608.915866262091, 5624.29696287964, 5632.127020311858, 5635.774569017193, 5662.122371032497, 5669.262995810518, 5738.741756621045, 5742.483176514133, 5747.19539264495, 5749.166370876116, 5531.529819965348, 5619.325680918316, 5644.153376993484, 5648.943510564842, 5743.712814359349], "value": 5393.733562166765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.4224402329738, 653.2291895563234, 657.2310396835702, 664.3522565498637, 678.4436761855279, 30864.228394290152, 39895.40156897645, 40556.797216013954, 40777.38833917493, 40783.18433631326, 43894.0, 44760.55239447604, 44791.77604111975, 44819.77590112045, 44847.327290090594, 8085.110637829834, 8676.47941123533, 8997.550122493882, 10160.441175735332, 10401.167906567494, 10417.479126043705, 10600.78798424031, 10605.73485662857, 10614.946925265363, 10624.30941988772, 10470.738231544196, 10617.150627949784, 10619.840702389432, 10632.30889992148, 10634.627788027421, 8024.358051355906, 10340.948295258513, 10527.105196058345, 10537.420441875694, 10541.104006159485, 10550.0, 10653.094486968617, 10655.041046305869, 10667.0, 10671.626493072783, 39959.0, 41063.58936410627, 41087.0, 41110.0, 41114.58885411167, 3681.7606855554573, 3713.925721485582, 3770.7171962102952, 3800.7339486235974, 3806.7715937043868, 34826.30347393038, 35508.64491355105, 35610.10974725627, 35626.821865890764, 35803.64196358029, 4068.552459229512, 4166.6250037496775, 4199.4330765346895, 4203.201391735561, 4223.598758117974, 245877.0, 248321.0, 249348.0, 249836.0, 250450.0, 31086.53370199449, 31434.68565314363, 70412.2958770416, 71113.64443177752, 71241.93137102948, 33119.172020699676, 33156.83421582876, 33224.501632475534, 33341.0, 33442.0, 15370.769438458432, 17330.74003889943, 17607.207675654627, 17613.207405666777, 17628.823711762976, 13576.864231357758, 13929.094608850392, 13944.0, 13956.930215348859, 13964.301784910916, 9559.283053770994, 9573.473458959685, 9609.069233883592, 9635.277354198462, 9684.08001239881, 2982.56752770847, 3031.514158390143, 3053.2061663967083, 3078.1073488688476, 3134.7335476484755, 1091.3124731419314, 1127.9492422840992, 1190.8392367030513, 1206.6500714792612, 1208.583038851595, 31237.219069522987, 31648.525272120936, 31849.8407507961, 32437.35125297528, 33252.50121248183, 1243.5274595653593, 1275.3941877608063, 1307.7972914198315, 1340.1423089222906, 1343.986560134386, 17533.29866805339, 17803.879374757093, 17868.195931183127, 17870.5532361692, 17872.28510859577, 532571.0, 539210.0, 539634.0, 539710.0, 540453.0, 65761.34238657648, 66914.66542667255, 66934.0, 66994.66502667553, 67144.6642766783, 1358.2936872826272, 1490.470882836599, 1505.284989629939, 1588.4202266172763, 1625.1955282135182, 31249.84375078201, 31899.0, 34261.0, 34562.654373455945, 34671.65328346684, 55280.0, 56466.71766641141, 56549.0, 56601.0, 56642.0, 269838.0, 422760.0, 424358.0, 425012.0, 425464.0, 43085.35371969486, 43260.35109473424, 43546.34680479859, 43551.12897742091, 43915.34126988162, 49413.75293123511, 49737.75131124321, 50291.0, 51379.74310128426, 51414.0, 40656.59343406646, 41221.1755764889, 41508.0, 42676.573234267256, 42781.57218427776, 43854.0, 43976.34035489406, 45120.32319515144, 45899.77050114728, 46372.30441543447, 46481.0, 46495.0, 47215.0, 47487.0, 47545.0, 40082.799586001885, 41005.0, 41077.38383924303, 41290.0, 41307.38038929358, 30880.691193087783, 31034.20945738445, 31067.223319417197, 31126.22184445407, 31386.21534461657], "value": 20062.247317988706, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.84721382267827, 400.96591789697885, 405.2320851985486, 419.2579134931172, 422.6090865948996, 12970.80543791844, 18026.18882150303, 18934.431967040975, 18943.336983205572, 20171.798282017175, 15054.397824087051, 17167.57081072974, 17812.821871781278, 17845.196966136522, 18322.541936451595, 5548.306461692288, 5783.016887129198, 5794.623349482291, 5795.0, 5795.507381872546, 5458.781648734066, 5650.378458369576, 5736.996025695507, 5751.4536119068625, 5754.1944127822135, 5680.289963754531, 5730.885382292352, 5738.139279108146, 5751.913721294184, 5755.0504166812425, 5418.133098704188, 5613.831585052455, 5614.101743721006, 5628.155776633497, 5714.542836573064, 5033.521815427529, 5087.898242035176, 5098.260752190949, 5120.103981803207, 5122.026814905156, 21847.781522184734, 22242.443938901495, 22491.775082249296, 22836.0, 22910.198143065078, 2589.741025897395, 2594.9870250648814, 2595.948081038369, 2622.0, 2681.705012448629, 14418.639534011734, 14433.783493247609, 14492.0, 14772.70454590913, 15113.773293400607, 2036.1549956767924, 2068.379486154163, 2090.4146838884985, 2107.7576078750835, 2151.580441813847, 78712.0, 81008.18991810066, 81258.59370703109, 81715.18284817194, 82279.70881164746, 10184.949075254577, 10542.47287635615, 10591.311564748421, 10594.099501542456, 10624.150067994542, 14633.560993170222, 14694.485693000694, 14777.113373197642, 14816.296125945439, 14832.777508337384, 8427.452215605967, 8470.195331443503, 8474.703385381483, 8542.530160841214, 8608.69869554575, 8456.746297611082, 8524.8721269181, 8615.224629783224, 8617.913820861837, 8656.31201915633, 4004.0, 5821.301443826683, 6190.721417536221, 6242.906356404657, 6613.636250006296, 1882.5670095877751, 1952.8242458178547, 1993.641144593987, 2010.2461576908659, 2095.476130967258, 986.9013098690074, 994.9154321882721, 1076.472528461064, 1112.2936935046305, 1189.898858597029, 17477.213525391133, 17505.64988700219, 17619.911900440417, 17678.0, 18048.548786280186, 1078.5200585739428, 1093.278436232099, 1094.8412480190327, 1101.983470247947, 1120.4285814234636, 10138.341007834468, 10593.629222977159, 10617.469126543641, 10722.303050301705, 10748.0, 517313.0, 517957.0, 523628.0, 532629.0, 536691.0, 98509.0, 99471.50264248632, 99590.0, 99609.50195248978, 100197.0, 1035.30634474902, 1036.5542816588788, 1064.9467526623637, 1068.8289873620183, 1072.6460268111505, 16267.234570122871, 16540.338386464406, 16780.412685555948, 16823.495295141165, 17167.399141030004, 40639.1872162561, 41158.1768364637, 41295.58704412918, 42631.36052959146, 43097.35353969756, 57491.0, 58796.0, 59196.70401647964, 59887.40112598818, 59928.700356499685, 6563.0, 7383.889241661272, 8171.918280817115, 8284.212999765012, 8609.139086091342, 7636.311942705419, 12758.170718903242, 13133.934330328288, 13330.466781328638, 13622.727545449234, 10839.729006774578, 11009.944950275198, 11058.944705276423, 11255.66233013011, 11342.60300889465, 10949.945250273699, 11083.224174307721, 11517.42412879336, 11623.244489108181, 11699.766004679688, 11390.658280251606, 11468.369239691898, 11617.767644647229, 11624.0, 11646.24299420535, 8264.297534709376, 8421.178486738752, 8422.284105851071, 8464.026636936831, 8505.064442911398, 10750.623728169476, 11314.886851131383, 11495.885041149482, 11541.711457213636, 11586.942065289619], "value": 9333.213328615104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.150309814111, 1541.2447900528741, 1579.2735341742798, 1724.30165782858, 1857.8699491035634, 7622.885656715147, 8214.30178434833, 8406.7057652982, 8432.578371081438, 8480.830383392344, 8190.91809081909, 8315.168483151681, 8328.875066874001, 8345.833083338344, 8347.666093356258, 2073.419442556087, 2166.295953815016, 2235.407616981501, 2313.2135074074854, 2360.3037104054347, 2364.361622361961, 2376.489054853206, 2387.0929046962215, 2389.247387073075, 2392.150786470795, 2298.5517824024323, 2342.543204075206, 2346.8239882008834, 2346.8709220992837, 2349.1073392110975, 2030.6344857925567, 2174.3694328644674, 2231.2190733243397, 2236.0161528927383, 2236.2061468178886, 2272.488690044743, 2275.5562665280277, 2291.9197828076103, 2292.094622624071, 2313.34069790109, 8551.572421378905, 8570.871436928452, 8583.699570515002, 8586.613602387908, 8592.226699597066, 5060.696358218519, 5231.398389185254, 5238.240455133984, 5254.133068043769, 5280.947190528084, 3275.5905511811025, 3327.05179023977, 3374.038399056282, 3441.328940856509, 3464.0300715799617, 1065.6430095917876, 1092.2299778656109, 1116.391566596207, 1126.808442564766, 1160.7214268575565, 11888.583899563473, 11934.0, 11943.94028029863, 11944.343061131722, 11953.043756499459, 4435.534268901783, 4459.910801784011, 4521.59305662492, 4539.568740969603, 4554.521775213555, 10156.593736250616, 10181.745456363502, 10188.796224075626, 10191.337563058378, 10193.133583645325, 4813.807447702123, 5315.229291752674, 5366.409694933554, 5367.087595108841, 5384.811531596375, 4663.766811659403, 4819.59033482151, 4836.685615434985, 4845.103655823684, 4862.78117484714, 3886.9028274292805, 3953.743006704555, 4017.979910100431, 4044.8786536403954, 4095.9590404096175, 1250.9061820363509, 1298.3054066074794, 1303.648015035954, 1317.0648839323997, 1321.14125818217, 1075.9139268858473, 1105.2760441910561, 1105.745678493951, 1111.2332490581473, 1117.6870476266658, 5817.301923769175, 5976.7908123215475, 6001.159837622737, 6006.849828754316, 6079.0, 432.4961419945791, 435.4970009638872, 436.0646413443147, 1068.1454836131063, 1133.6032388664066, 4270.957290427118, 4272.124214536013, 4274.0, 4277.7647229402055, 4299.290617048215, 10059.295849290625, 10402.11582015522, 10430.582776689, 10445.529951152217, 10495.737606559896, 10392.37645741258, 10465.738356540995, 10576.841347379795, 10604.628837990633, 10606.310589811792, 7356.0, 7513.39892808574, 7606.733764318333, 7621.352185064221, 8055.677772889136, 6117.418845209698, 6123.693815309306, 6201.844953876189, 6287.717052732546, 6347.619142851444, 9200.0, 9382.95308523453, 9583.808323833624, 9602.183814375578, 9670.274729395464, 9677.951610241904, 9695.70912872615, 9993.550290236812, 10010.099091081838, 10021.0, 6824.317568243335, 6993.510454268356, 7118.786436406916, 7651.923480765344, 7779.7666070017995, 7902.525848448881, 7923.088844782924, 7962.08436029864, 7986.161453047579, 8030.0, 7019.473539484661, 7040.471964602573, 7070.328318809705, 7210.0, 7402.33378995893, 7134.32223938725, 7149.106361704787, 7152.785416437515, 7225.927740722525, 7261.564306141649, 6574.342565743387, 6706.061151438705, 6768.2216545097945, 6777.254502004874, 6778.4577233822165, 5253.605979551626, 5361.51746342831, 5396.298481197419, 5461.481159289861, 5527.44725527444, 5492.642978206404, 5496.120620700669, 5501.559875210054, 5506.614536982373, 5570.972145139248], "value": 4546.416390128364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.46296841695414, 326.882322363949, 332.2938755145315, 334.4431521516675, 336.3659501839033, 5285.418603953567, 5402.864928376793, 5402.9729851350785, 5417.891642167155, 5424.538914192293, 5309.522143007129, 5319.893602127955, 5345.278387417698, 5359.651622644526, 5362.43694412087, 3935.940960885589, 4021.2761702893467, 4139.958600414003, 4166.958330416703, 4190.120074784284, 4154.397612346208, 4156.8129434175535, 4161.791910404483, 4170.311898536738, 4179.9791001045105, 3939.4484772131923, 4121.9381709274385, 4138.379243113542, 4143.917121657565, 4156.646685031761, 3895.902602434919, 4023.577524359944, 4080.10237747695, 4107.54816970133, 4147.81334839933, 3653.1049892776173, 3669.743117981742, 3669.87155449558, 3673.522442082512, 3678.2091850252054, 5117.872053198663, 5190.468811700557, 5195.844124676228, 5214.400343960455, 5242.895142097175, 4572.154151481953, 4749.905001899942, 4750.627054791103, 4754.857354279377, 4777.402824646884, 5556.888862222733, 5579.553635709174, 5601.187827764992, 5607.635503692247, 5641.94069164756, 4053.310937140693, 4054.594540545922, 4060.2894493463823, 4076.9388459173138, 4081.08175660477, 5691.743871525791, 5806.564507661942, 5806.7386967586135, 5808.183031229893, 5834.124881267844, 4045.7167998239843, 4082.4692789937117, 4089.386592011222, 4094.1197642507004, 4100.91798164035, 4141.364161156386, 4142.71001029931, 4147.988225710528, 4161.958380416218, 4164.0, 4587.587117159472, 4738.123447162286, 4743.810247590127, 4752.809887604457, 4763.237881938873, 5594.328680558359, 5616.045272303718, 5616.466435688685, 5616.634918730269, 5633.126865335879, 1505.5633866178905, 1519.8480151984713, 1520.1715065289443, 1522.444307827657, 1531.2802982598162, 940.5250348573926, 978.2223132609593, 992.6376872441507, 994.8209322321907, 1038.678009816959, 5711.571632127607, 5739.512141467939, 5741.8277451675685, 5747.051736463437, 5761.695321871285, 6144.846378840565, 6153.507719382439, 6163.1679723237685, 6182.567220294626, 6186.319504854462, 5564.554835613222, 5707.543396528268, 5717.399673034354, 5717.914231286534, 5810.593258471867, 3215.1962009497624, 3275.132089996153, 3283.1627934876456, 3290.177455636091, 3291.9136684894406, 5856.502197313191, 6122.0, 6137.232845894263, 6447.743289848516, 6476.190476190476, 5896.204012458264, 5927.8221653350465, 5930.644161350333, 5952.523798096142, 5952.642841429528, 5875.6474611523445, 6045.153678484928, 6104.145419641254, 6106.084087386927, 6117.745862098348, 5807.809399073095, 5818.2436283282905, 5845.918505076575, 5885.264341957255, 5888.0, 5819.301683797971, 5821.446962538552, 5836.941630583639, 5837.503812176013, 5860.648361098348, 5917.5857689961285, 6080.270367555921, 6129.478994285358, 6150.446459818459, 6151.72317245716, 3942.7042971777805, 3957.485526881487, 3972.1261322509004, 3978.343573310487, 3991.600839915985, 5638.887222255614, 5747.224124743107, 5883.470487656132, 5890.0, 5907.527397808251, 5736.942630573641, 5756.683382414008, 5766.336871259691, 5781.508571771446, 5793.217915581343, 5606.383297837153, 5714.828555143353, 5725.427457254241, 5767.509761670305, 5787.450192231731, 5605.243292155506, 5655.321361436654, 5667.688277144796, 5669.943300567106, 5673.212937924541, 5690.3456102548735, 5751.769929202952, 5776.393478684678, 5780.942190578208, 5792.768289268382, 5364.034473794754, 5618.550515958796, 5628.268325117709, 5641.802536911188, 5644.238027866186], "value": 4343.082035071925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.9960050199749, 808.3694718119865, 826.5908375354198, 841.9873701894472, 917.0462718772477, 15120.92439537802, 16196.919015404936, 16227.350905963747, 16234.675306493878, 16240.0, 14788.704225915475, 15051.548453546411, 15070.547883563484, 15090.924545377286, 15101.924490377532, 893.2585953658448, 897.3001059173838, 901.8016036471965, 902.2285945516587, 902.6840605787987, 876.8202518483696, 882.5498995512271, 882.6601758323028, 883.0110276490308, 883.0639522106587, 934.5560858592148, 939.7979434421597, 939.8402271613842, 939.9859002114973, 940.1162906867556, 925.8935222449437, 929.7582628516567, 930.0420566816157, 930.1814403325099, 930.6184464369644, 678.3250665587723, 680.482833046883, 680.5746408494691, 680.7243066558052, 681.0533358631507, 13455.730885382238, 13485.05604607678, 13505.324733763273, 13507.25710085945, 13525.18848869071, 13161.341932903413, 13322.333883305795, 13362.532311369152, 13511.797323040162, 13555.0, 10866.402347870864, 10960.581935503138, 11031.062359699436, 11284.32294062359, 11418.029467495273, 3963.742356746802, 4024.1549274652357, 4030.435738996543, 4088.4480595119576, 4185.455890734215, 48951.755241223924, 50567.0, 55835.72082139604, 58121.70939145277, 58395.12407313851, 11927.534713386982, 12030.556333240067, 12140.514379424902, 12283.201591896499, 12341.444634991447, 21246.362609121443, 21429.57140857174, 21442.249521266993, 21444.0, 21825.12699492034, 8341.541215233221, 8525.275351595184, 8602.397832151815, 8682.565871706389, 9324.25405967521, 5004.574611158092, 5154.716490593053, 5160.40655324635, 5198.2202669599865, 5229.084910140787, 3394.9490757638655, 3493.039414161075, 3499.6675315844955, 3501.28223714138, 3505.4741788731385, 597.2862429396915, 606.5814587934311, 611.2054329371888, 611.996940015306, 614.2751553167216, 685.4721864164665, 689.9379055884895, 700.2962023166685, 715.3883429667663, 716.3839098375392, 9272.33193339884, 9537.809243815085, 9792.0, 10025.949870250748, 10042.447665378475, 651.4104735214638, 740.2782287269869, 748.8839229919371, 755.6712829919003, 761.2007392238128, 4578.702384345007, 4661.254199328091, 4692.052947201979, 4708.905821883612, 4766.0, 64396.0, 67400.0, 69675.0, 69740.0, 69760.0, 44253.55746442559, 60606.39393606008, 61480.385196147465, 64117.679411603574, 64195.0, 47650.285245721345, 49900.25149622759, 49918.25122623164, 51026.23460648093, 51135.23297150546, 10277.0, 10278.229132815219, 10290.742731431774, 10319.400492923609, 10418.843717344094, 36486.27027459383, 36712.63287367092, 37511.81244093762, 37548.6245137556, 37552.2489550202, 46489.535104649876, 49022.0, 49330.75334623304, 49929.0, 50099.0, 12924.806127907901, 12951.0, 12974.28641424693, 13025.544105956245, 13204.66988325261, 13138.0, 13575.932120339336, 13581.796273055714, 13747.656308592364, 14786.482473113389, 13267.66830829237, 13782.586522404345, 14257.643558910695, 14404.20776857241, 14645.633859153606, 13422.664433389244, 13536.932315338361, 13709.314534273446, 13998.300084995913, 14060.578182654537, 12874.806877897026, 12945.935270323587, 13009.869901300866, 13176.077674563072, 13302.40139193758, 11241.943790280997, 11533.88466115328, 11559.711007224887, 11642.185047046964, 11782.764344713229, 11252.774944500901, 11270.887291126985, 11482.343095400627, 11563.942180289381, 11584.536618535501], "value": 7143.9063516103215, "unit": "score"}], "name": "dromaeo_css", "value": 7226.998245934125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 105.0, 109.0, 109.0, 109.0, 99.0, 110.0, 109.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 156.0, 169.0, 127.0, 150.0, 160.0, 129.0, 195.0, 127.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 160.0, 162.0, 158.0, 164.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 77.0, 170.0, 76.0, 76.0, 76.0, 76.0, 159.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 147.0, 91.0, 93.0, 92.0, 151.0, 92.0, 93.0, 144.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 59.0, 55.0, 56.0, 55.0, 57.0, 75.0, 54.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 80.0, 72.0, 74.0, 82.0, 73.0, 82.0, 74.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 119.0, 118.0, 130.0, 119.0, 129.0, 116.0, 154.0, 125.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 165.0, 162.0, 160.0, 159.0, 160.0, 159.0, 165.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1523.8999999999999, "alertThreshold": 2.0}]} 16:42:35 INFO - Return code: 0 16:42:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:42:35 ERROR - # TBPL SUCCESS # 16:42:35 INFO - Running post-action listener: _resource_record_post_action 16:42:35 INFO - Running post-run listener: _resource_record_post_run 16:42:37 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323805184; Read time: 16; Write time: 216436 16:42:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78041088; Read time: 0; Write time: 80512 16:42:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245764096; Read time: 16; Write time: 135924 16:42:37 INFO - Running post-run listener: _upload_blobber_files 16:42:37 INFO - Blob upload gear active. 16:42:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:37 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 16:42:37 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'] 16:42:37 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 16:42:37 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:42:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:42:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:38 INFO - (blobuploader) - INFO - Done attempting. 16:42:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:42:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:39 INFO - (blobuploader) - INFO - Done attempting. 16:42:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:39 INFO - Return code: 0 16:42:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bad9d1276726f2a98bc845b0424921fd18368c7ae86d7dc05f05a243a85be67e40b1d0fb58f5b103162a8c35e41ffcdb0866ee638fe1356142993931773194d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93af9f21ff16227de077cec33f05360077b18ce0781bec1360ac55953bb84b66c4b062bf82d9a4dacf4a531df745701c448b623ba7d6766812579cab8646602d"} 16:42:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:39 INFO - Contents: 16:42:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bad9d1276726f2a98bc845b0424921fd18368c7ae86d7dc05f05a243a85be67e40b1d0fb58f5b103162a8c35e41ffcdb0866ee638fe1356142993931773194d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93af9f21ff16227de077cec33f05360077b18ce0781bec1360ac55953bb84b66c4b062bf82d9a4dacf4a531df745701c448b623ba7d6766812579cab8646602d"} 16:42:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:39 INFO - Copying logs to upload dir... 16:42:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2127.334125 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 27 secs) (at 2016-05-02 16:42:38.335938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:38.339429) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bad9d1276726f2a98bc845b0424921fd18368c7ae86d7dc05f05a243a85be67e40b1d0fb58f5b103162a8c35e41ffcdb0866ee638fe1356142993931773194d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93af9f21ff16227de077cec33f05360077b18ce0781bec1360ac55953bb84b66c4b062bf82d9a4dacf4a531df745701c448b623ba7d6766812579cab8646602d"} build_url:https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bad9d1276726f2a98bc845b0424921fd18368c7ae86d7dc05f05a243a85be67e40b1d0fb58f5b103162a8c35e41ffcdb0866ee638fe1356142993931773194d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93af9f21ff16227de077cec33f05360077b18ce0781bec1360ac55953bb84b66c4b062bf82d9a4dacf4a531df745701c448b623ba7d6766812579cab8646602d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:38.364050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:38.364381) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1462230430.198489-226567903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:38.447994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-02 16:42:38.448318) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-02 16:42:38.448657) ========= ========= Total master_lag: 0.15 =========