builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1462230413.32 results: success (0) buildid: 20160502133436 builduid: 809d0caa233347d7abb79d039e676759 revision: cb7afc6a6450dd75d89b10825f719178eb15437b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.319886) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.320301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.320591) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.337169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.337436) ========= 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=523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-02 16:06:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-02 16:06:55 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.457874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.458153) ========= 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=523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016241 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:53.507201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-02 16:06:53.507523) ========= 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=523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-02 16:06:56,046 truncating revision to first 12 chars 2016-05-02 16:06:56,046 Setting DEBUG logging. 2016-05-02 16:06:56,046 attempt 1/10 2016-05-02 16:06:56,046 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:06:56,291 unpacking tar archive at: mozilla-aurora-cb7afc6a6450/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-02 16:06:54.563335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:54.563714) ========= script_repo_revision: cb7afc6a6450dd75d89b10825f719178eb15437b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:54.564137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:54.564402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-02 16:06:54.573887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 26 secs) (at 2016-05-02 16:06:54.574192) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:57 INFO - MultiFileLogger online at 20160502 16:06:57 in /builds/slave/test 16:06:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:06:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:57 INFO - {'append_to_log': False, 16:06:57 INFO - 'base_work_dir': '/builds/slave/test', 16:06:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:06:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:57 INFO - 'branch': 'Mozilla-Aurora', 16:06:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:57 INFO - 'config_files': ('talos/linux_config.py',), 16:06:57 INFO - 'default_actions': ('clobber', 16:06:57 INFO - 'read-buildbot-config', 16:06:57 INFO - 'download-and-extract', 16:06:57 INFO - 'populate-webroot', 16:06:57 INFO - 'create-virtualenv', 16:06:57 INFO - 'install', 16:06:57 INFO - 'run-tests'), 16:06:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:57 INFO - 'download_minidump_stackwalk': True, 16:06:57 INFO - 'download_symbols': 'ondemand', 16:06:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:57 INFO - 'installer_path': 'installer.exe', 16:06:57 INFO - 'log_level': 'info', 16:06:57 INFO - 'log_name': 'talos', 16:06:57 INFO - 'log_to_console': True, 16:06:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:57 INFO - 'opt_config_files': (), 16:06:57 INFO - 'pip_index': False, 16:06:57 INFO - 'sps_profile': False, 16:06:57 INFO - 'sps_profile_interval': 0, 16:06:57 INFO - 'suite': 'dromaeojs-e10s', 16:06:57 INFO - 'system_bits': '32', 16:06:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:57 INFO - 'title': 'talos-linux64-ix-065', 16:06:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:57 INFO - 'use_talos_json': True, 16:06:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:57 INFO - 'work_dir': 'build'} 16:06:57 INFO - ##### 16:06:57 INFO - ##### Running clobber step. 16:06:57 INFO - ##### 16:06:57 INFO - Running pre-action listener: _resource_record_pre_action 16:06:57 INFO - Running main action method: clobber 16:06:57 INFO - rmtree: /builds/slave/test/build 16:06:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:06:58 INFO - Running post-action listener: _resource_record_post_action 16:06:58 INFO - ##### 16:06:58 INFO - ##### Running read-buildbot-config step. 16:06:58 INFO - ##### 16:06:58 INFO - Running pre-action listener: _resource_record_pre_action 16:06:58 INFO - Running main action method: read_buildbot_config 16:06:58 INFO - Using buildbot properties: 16:06:58 INFO - { 16:06:58 INFO - "project": "", 16:06:58 INFO - "product": "firefox", 16:06:58 INFO - "script_repo_revision": "production", 16:06:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:06:58 INFO - "repository": "", 16:06:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:06:58 INFO - "buildid": "20160502133436", 16:06:58 INFO - "pgo_build": "True", 16:06:58 INFO - "basedir": "/builds/slave/test", 16:06:58 INFO - "buildnumber": 337, 16:06:58 INFO - "slavename": "talos-linux64-ix-065", 16:06:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:06:58 INFO - "platform": "ubuntu64_hw", 16:06:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:06:58 INFO - "branch": "mozilla-aurora", 16:06:58 INFO - "repo_path": "releases/mozilla-aurora", 16:06:58 INFO - "revision": "cb7afc6a6450dd75d89b10825f719178eb15437b", 16:06:58 INFO - "stage_platform": "linux64-pgo", 16:06:58 INFO - "builduid": "809d0caa233347d7abb79d039e676759", 16:06:58 INFO - "slavebuilddir": "test" 16:06:58 INFO - } 16:06:58 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:06:58 INFO - Running post-action listener: _resource_record_post_action 16:06:58 INFO - ##### 16:06:58 INFO - ##### Running download-and-extract step. 16:06:58 INFO - ##### 16:06:58 INFO - Running pre-action listener: _resource_record_pre_action 16:06:58 INFO - Running main action method: download_and_extract 16:06:58 INFO - mkdir: /builds/slave/test/build/tests 16:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:28 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:28 INFO - retry: attempt #1 caught exception: timed out 16:07:28 INFO - retry: Failed, sleeping 30 seconds before retrying 16:07:58 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:28 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:28 INFO - retry: attempt #2 caught exception: timed out 16:08:28 INFO - retry: Failed, sleeping 60 seconds before retrying 16:09:28 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:09:58 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:09:58 INFO - retry: attempt #3 caught exception: timed out 16:09:58 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:09:58 INFO - Caught exception: timed out 16:09:58 INFO - Caught exception: timed out 16:09:58 INFO - Caught exception: timed out 16:09:58 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:09:58 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:09:58 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:09:59 INFO - Downloaded 1361 bytes. 16:09:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:09:59 INFO - Using the following test package requirements: 16:09:59 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:09:59 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:09:59 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:09:59 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'jsshell-linux-x86_64.zip'], 16:09:59 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:09:59 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:09:59 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:09:59 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:09:59 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:09:59 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:09:59 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:09:59 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:09:59 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:09:59 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:09:59 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:09:59 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:09:59 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:29 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:29 INFO - retry: attempt #1 caught exception: timed out 16:10:29 INFO - retry: Failed, sleeping 30 seconds before retrying 16:10:59 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:29 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:29 INFO - retry: attempt #2 caught exception: timed out 16:11:29 INFO - retry: Failed, sleeping 60 seconds before retrying 16:12:29 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:12:59 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:12:59 INFO - retry: attempt #3 caught exception: timed out 16:12:59 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:12:59 INFO - Caught exception: timed out 16:12:59 INFO - Caught exception: timed out 16:12:59 INFO - Caught exception: timed out 16:12:59 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:12:59 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:12:59 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:00 INFO - Downloaded 23821233 bytes. 16:13:00 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:00 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:01 INFO - Return code: 0 16:13:01 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:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:01 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:01 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:01 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:01 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:01 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:31 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:31 INFO - retry: attempt #1 caught exception: timed out 16:13:31 INFO - retry: Failed, sleeping 30 seconds before retrying 16:14:01 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:31 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:31 INFO - retry: attempt #2 caught exception: timed out 16:14:31 INFO - retry: Failed, sleeping 60 seconds before retrying 16:15:31 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:02 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:02 INFO - retry: attempt #3 caught exception: timed out 16:16:02 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:02 INFO - Caught exception: timed out 16:16:02 INFO - Caught exception: timed out 16:16:02 INFO - Caught exception: timed out 16:16:02 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:02 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:02 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:03 INFO - Downloaded 23821233 bytes. 16:16:03 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:03 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:04 INFO - Return code: 0 16:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:04 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:04 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:04 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:04 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:04 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:34 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:34 INFO - retry: attempt #1 caught exception: timed out 16:16:34 INFO - retry: Failed, sleeping 30 seconds before retrying 16:17:04 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:34 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:34 INFO - retry: attempt #2 caught exception: timed out 16:17:34 INFO - retry: Failed, sleeping 60 seconds before retrying 16:18:34 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:04 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:04 INFO - retry: attempt #3 caught exception: timed out 16:19:04 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:04 INFO - Caught exception: timed out 16:19:04 INFO - Caught exception: timed out 16:19:04 INFO - Caught exception: timed out 16:19:04 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:04 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:04 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:05 INFO - Downloaded 10840145 bytes. 16:19:05 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:05 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:05 INFO - Return code: 0 16:19:05 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:05 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:05 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:05 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:05 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:05 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:36 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:36 INFO - retry: attempt #1 caught exception: timed out 16:19:36 INFO - retry: Failed, sleeping 30 seconds before retrying 16:20:06 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:36 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:36 INFO - retry: attempt #2 caught exception: timed out 16:20:36 INFO - retry: Failed, sleeping 60 seconds before retrying 16:21:36 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:06 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:06 INFO - retry: attempt #3 caught exception: timed out 16:22:06 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:06 INFO - Caught exception: timed out 16:22:06 INFO - Caught exception: timed out 16:22:06 INFO - Caught exception: timed out 16:22:06 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:06 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:06 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:07 INFO - Downloaded 62719520 bytes. 16:22:07 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:07 INFO - mkdir: /builds/slave/test/properties 16:22:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:07 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:07 INFO - Contents: 16:22:07 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:08 INFO - Running post-action listener: _resource_record_post_action 16:22:08 INFO - Running post-action listener: set_extra_try_arguments 16:22:08 INFO - ##### 16:22:08 INFO - ##### Running populate-webroot step. 16:22:08 INFO - ##### 16:22:08 INFO - Running pre-action listener: _resource_record_pre_action 16:22:08 INFO - Running main action method: populate_webroot 16:22:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:22:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:22:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:22:08 INFO - '--tppagecycles', 16:22:08 INFO - '7'], 16:22:08 INFO - 'tests': ['tsvgm']}}, 16:22:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:22:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:22:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['damp', 'tps']}, 16:22:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'tests': ['damp', 'tps']}, 16:22:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['dromaeo_dom']}, 16:22:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['a11yr', 16:22:08 INFO - 'ts_paint', 16:22:08 INFO - 'tpaint', 16:22:08 INFO - 'sessionrestore', 16:22:08 INFO - 'sessionrestore_no_auto_restore', 16:22:08 INFO - 'tabpaint']}, 16:22:08 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:08 INFO - 'ts_paint', 16:22:08 INFO - 'tpaint', 16:22:08 INFO - 'sessionrestore', 16:22:08 INFO - 'sessionrestore_no_auto_restore', 16:22:08 INFO - 'tabpaint']}, 16:22:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:22:08 INFO - 'ts_paint', 16:22:08 INFO - 'tpaint', 16:22:08 INFO - 'sessionrestore', 16:22:08 INFO - 'sessionrestore_no_auto_restore', 16:22:08 INFO - 'tabpaint']}, 16:22:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:22:08 INFO - 'ts_paint', 16:22:08 INFO - 'tpaint', 16:22:08 INFO - 'sessionrestore', 16:22:08 INFO - 'sessionrestore_no_auto_restore', 16:22:08 INFO - 'tabpaint']}, 16:22:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['a11yr', 16:22:08 INFO - 'ts_paint', 16:22:08 INFO - 'tpaint', 16:22:08 INFO - 'sessionrestore', 16:22:08 INFO - 'sessionrestore_no_auto_restore', 16:22:08 INFO - 'tabpaint']}, 16:22:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['a11yr', 16:22:08 INFO - 'ts_paint', 16:22:08 INFO - 'tpaint', 16:22:08 INFO - 'sessionrestore', 16:22:08 INFO - 'sessionrestore_no_auto_restore', 16:22:08 INFO - 'tabpaint']}, 16:22:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['tsvgx', 16:22:08 INFO - 'tsvgr_opacity', 16:22:08 INFO - 'tart', 16:22:08 INFO - 'tscrollx', 16:22:08 INFO - 'cart']}, 16:22:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:08 INFO - 'tsvgr_opacity', 16:22:08 INFO - 'tart', 16:22:08 INFO - 'tscrollx', 16:22:08 INFO - 'cart']}, 16:22:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'talos_options': ['--disable-e10s'], 16:22:08 INFO - 'tests': ['tp5o']}, 16:22:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'tests': ['tp5o']}, 16:22:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'talos_options': ['--disable-e10s', 16:22:08 INFO - '--xperf_path', 16:22:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:08 INFO - 'tests': ['tp5n']}, 16:22:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:08 INFO - 'talos_options': ['--xperf_path', 16:22:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:08 INFO - 'tests': ['tp5n']}}, 16:22:08 INFO - 'talos.zip': {'path': '', 16:22:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:22:08 INFO - Running post-action listener: _resource_record_post_action 16:22:08 INFO - ##### 16:22:08 INFO - ##### Running create-virtualenv step. 16:22:08 INFO - ##### 16:22:08 INFO - Running pre-action listener: _resource_record_pre_action 16:22:08 INFO - Running main action method: create_virtualenv 16:22:08 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:08 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:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:22:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:08 INFO - Using real prefix '/usr' 16:22:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:10 INFO - Installing pip.................done. 16:22:10 INFO - Return code: 0 16:22:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:10 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 16:22:10 INFO - 'HOME': '/home/cltbld', 16:22:10 INFO - 'LANG': 'en_US.UTF-8', 16:22:10 INFO - 'LANGUAGE': 'en_US:en', 16:22:10 INFO - 'LOGNAME': 'cltbld', 16:22:10 INFO - 'MAIL': '/var/mail/cltbld', 16:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:10 INFO - 'MOZ_NO_REMOTE': '1', 16:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:10 INFO - 'NO_EM_RESTART': '1', 16:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:10 INFO - 'PWD': '/builds/slave/test', 16:22:10 INFO - 'SHELL': '/bin/bash', 16:22:10 INFO - 'SHLVL': '1', 16:22:10 INFO - 'TERM': 'linux', 16:22:10 INFO - 'TMOUT': '86400', 16:22:10 INFO - 'USER': 'cltbld', 16:22:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:10 INFO - '_': '/tools/buildbot/bin/python'} 16:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:11 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:11 INFO - Cleaning up... 16:22:11 INFO - Return code: 0 16:22:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:11 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 16:22:11 INFO - 'HOME': '/home/cltbld', 16:22:11 INFO - 'LANG': 'en_US.UTF-8', 16:22:11 INFO - 'LANGUAGE': 'en_US:en', 16:22:11 INFO - 'LOGNAME': 'cltbld', 16:22:11 INFO - 'MAIL': '/var/mail/cltbld', 16:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:11 INFO - 'MOZ_NO_REMOTE': '1', 16:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:11 INFO - 'NO_EM_RESTART': '1', 16:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:11 INFO - 'PWD': '/builds/slave/test', 16:22:11 INFO - 'SHELL': '/bin/bash', 16:22:11 INFO - 'SHLVL': '1', 16:22:11 INFO - 'TERM': 'linux', 16:22:11 INFO - 'TMOUT': '86400', 16:22:11 INFO - 'USER': 'cltbld', 16:22:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:11 INFO - '_': '/tools/buildbot/bin/python'} 16:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:11 INFO - Downloading/unpacking psutil>=0.7.1 16:22:11 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:11 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:11 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:11 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:11 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:11 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:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:13 INFO - Installing collected packages: psutil 16:22:13 INFO - Running setup.py install for psutil 16:22:13 INFO - building 'psutil._psutil_linux' extension 16:22:13 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:13 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:13 INFO - building 'psutil._psutil_posix' extension 16:22:13 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:13 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:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:13 INFO - Successfully installed psutil 16:22:13 INFO - Cleaning up... 16:22:13 INFO - Return code: 0 16:22:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:22: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:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 16:22:13 INFO - 'HOME': '/home/cltbld', 16:22:13 INFO - 'LANG': 'en_US.UTF-8', 16:22:13 INFO - 'LANGUAGE': 'en_US:en', 16:22:13 INFO - 'LOGNAME': 'cltbld', 16:22:13 INFO - 'MAIL': '/var/mail/cltbld', 16:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:13 INFO - 'MOZ_NO_REMOTE': '1', 16:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:13 INFO - 'NO_EM_RESTART': '1', 16:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:13 INFO - 'PWD': '/builds/slave/test', 16:22:13 INFO - 'SHELL': '/bin/bash', 16:22:13 INFO - 'SHLVL': '1', 16:22:13 INFO - 'TERM': 'linux', 16:22:13 INFO - 'TMOUT': '86400', 16:22:13 INFO - 'USER': 'cltbld', 16:22:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:13 INFO - '_': '/tools/buildbot/bin/python'} 16:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:22:14 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:14 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:14 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:14 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:14 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:14 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:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:16 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:16 INFO - Installing collected packages: mozsystemmonitor 16:22:16 INFO - Running setup.py install for mozsystemmonitor 16:22:16 INFO - Successfully installed mozsystemmonitor 16:22:16 INFO - Cleaning up... 16:22:16 INFO - Return code: 0 16:22:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22: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:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:16 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 16:22:16 INFO - 'HOME': '/home/cltbld', 16:22:16 INFO - 'LANG': 'en_US.UTF-8', 16:22:16 INFO - 'LANGUAGE': 'en_US:en', 16:22:16 INFO - 'LOGNAME': 'cltbld', 16:22:16 INFO - 'MAIL': '/var/mail/cltbld', 16:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:16 INFO - 'MOZ_NO_REMOTE': '1', 16:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:16 INFO - 'NO_EM_RESTART': '1', 16:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:16 INFO - 'PWD': '/builds/slave/test', 16:22:16 INFO - 'SHELL': '/bin/bash', 16:22:16 INFO - 'SHLVL': '1', 16:22:16 INFO - 'TERM': 'linux', 16:22:16 INFO - 'TMOUT': '86400', 16:22:16 INFO - 'USER': 'cltbld', 16:22:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:16 INFO - '_': '/tools/buildbot/bin/python'} 16:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:16 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:16 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:16 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:16 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:16 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:16 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:16 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:18 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:19 INFO - Downloading docopt-0.6.1.tar.gz 16:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:19 INFO - Running setup.py install for blobuploader 16:22:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:19 INFO - Running setup.py install for requests 16:22:19 INFO - Running setup.py install for docopt 16:22:19 INFO - Successfully installed blobuploader requests docopt 16:22:19 INFO - Cleaning up... 16:22:19 INFO - Return code: 0 16:22:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22: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:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:19 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 16:22:19 INFO - 'HOME': '/home/cltbld', 16:22:19 INFO - 'LANG': 'en_US.UTF-8', 16:22:19 INFO - 'LANGUAGE': 'en_US:en', 16:22:19 INFO - 'LOGNAME': 'cltbld', 16:22:19 INFO - 'MAIL': '/var/mail/cltbld', 16:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:19 INFO - 'MOZ_NO_REMOTE': '1', 16:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:19 INFO - 'NO_EM_RESTART': '1', 16:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:19 INFO - 'PWD': '/builds/slave/test', 16:22:19 INFO - 'SHELL': '/bin/bash', 16:22:19 INFO - 'SHLVL': '1', 16:22:19 INFO - 'TERM': 'linux', 16:22:19 INFO - 'TMOUT': '86400', 16:22:19 INFO - 'USER': 'cltbld', 16:22:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:19 INFO - '_': '/tools/buildbot/bin/python'} 16:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:19 INFO - Running setup.py (path:/tmp/pip-tC7CF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:20 INFO - Running setup.py (path:/tmp/pip-dxWfNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:20 INFO - Running setup.py (path:/tmp/pip-u54LzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:20 INFO - Running setup.py (path:/tmp/pip-FDRJa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:20 INFO - Running setup.py (path:/tmp/pip-78vxxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:20 INFO - Running setup.py (path:/tmp/pip-lZs2kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:20 INFO - Running setup.py (path:/tmp/pip-Rh3SCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:20 INFO - Running setup.py (path:/tmp/pip-xxGQE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:20 INFO - Running setup.py (path:/tmp/pip-5iwaJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:20 INFO - Running setup.py (path:/tmp/pip-8rqLcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:20 INFO - Running setup.py (path:/tmp/pip-RwlVO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:20 INFO - Running setup.py (path:/tmp/pip-mw7ixy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:20 INFO - Running setup.py (path:/tmp/pip-JGk_O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:20 INFO - Running setup.py (path:/tmp/pip-uATwvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:20 INFO - Running setup.py (path:/tmp/pip-uMCNun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:21 INFO - Running setup.py (path:/tmp/pip-wiFrL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:21 INFO - Running setup.py (path:/tmp/pip-O0NmHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:21 INFO - Running setup.py install for manifestparser 16:22:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Running setup.py install for mozcrash 16:22:21 INFO - Running setup.py install for mozdebug 16:22:21 INFO - Running setup.py install for mozdevice 16:22:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Running setup.py install for mozfile 16:22:21 INFO - Running setup.py install for mozhttpd 16:22:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Running setup.py install for mozinfo 16:22:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Running setup.py install for mozInstall 16:22:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:21 INFO - Running setup.py install for mozleak 16:22:22 INFO - Running setup.py install for mozlog 16:22:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Running setup.py install for moznetwork 16:22:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Running setup.py install for mozprocess 16:22:22 INFO - Running setup.py install for mozprofile 16:22:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Running setup.py install for mozrunner 16:22:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Running setup.py install for mozscreenshot 16:22:22 INFO - Running setup.py install for moztest 16:22:22 INFO - Running setup.py install for mozversion 16:22:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:22 INFO - Cleaning up... 16:22:22 INFO - Return code: 0 16:22:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:22 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 16:22:22 INFO - 'HOME': '/home/cltbld', 16:22:22 INFO - 'LANG': 'en_US.UTF-8', 16:22:22 INFO - 'LANGUAGE': 'en_US:en', 16:22:22 INFO - 'LOGNAME': 'cltbld', 16:22:22 INFO - 'MAIL': '/var/mail/cltbld', 16:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:22 INFO - 'MOZ_NO_REMOTE': '1', 16:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:22 INFO - 'NO_EM_RESTART': '1', 16:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:22 INFO - 'PWD': '/builds/slave/test', 16:22:22 INFO - 'SHELL': '/bin/bash', 16:22:22 INFO - 'SHLVL': '1', 16:22:22 INFO - 'TERM': 'linux', 16:22:22 INFO - 'TMOUT': '86400', 16:22:22 INFO - 'USER': 'cltbld', 16:22:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:22 INFO - '_': '/tools/buildbot/bin/python'} 16:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:23 INFO - Running setup.py (path:/tmp/pip-XVibC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:23 INFO - Running setup.py (path:/tmp/pip-T5KUUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:23 INFO - Running setup.py (path:/tmp/pip-xJfbyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:23 INFO - Running setup.py (path:/tmp/pip-A3tYoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:23 INFO - Running setup.py (path:/tmp/pip-YvSrqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:23 INFO - Running setup.py (path:/tmp/pip-uOsHBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:23 INFO - Running setup.py (path:/tmp/pip-J9XWC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:23 INFO - Running setup.py (path:/tmp/pip-XomdsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:23 INFO - Running setup.py (path:/tmp/pip-UBBlM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:23 INFO - Running setup.py (path:/tmp/pip-LEF4v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:23 INFO - Running setup.py (path:/tmp/pip-VntgZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:23 INFO - Running setup.py (path:/tmp/pip-WiLbaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:24 INFO - Running setup.py (path:/tmp/pip-RSIFKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:24 INFO - Running setup.py (path:/tmp/pip-COYLep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:24 INFO - Running setup.py (path:/tmp/pip-rkwpYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:24 INFO - Running setup.py (path:/tmp/pip-Hv0j4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:24 INFO - Running setup.py (path:/tmp/pip-NPNoeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:26 INFO - Downloading blessings-1.6.tar.gz 16:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:26 INFO - Installing collected packages: blessings 16:22:26 INFO - Running setup.py install for blessings 16:22:26 INFO - Successfully installed blessings 16:22:26 INFO - Cleaning up... 16:22:26 INFO - Return code: 0 16:22:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:26 INFO - Reading from file tmpfile_stdout 16:22:26 INFO - Current package versions: 16:22:26 INFO - argparse == 1.2.1 16:22:26 INFO - blessings == 1.6 16:22:26 INFO - blobuploader == 1.2.4 16:22:26 INFO - docopt == 0.6.1 16:22:26 INFO - manifestparser == 1.1 16:22:26 INFO - mozInstall == 1.12 16:22:26 INFO - mozcrash == 0.17 16:22:26 INFO - mozdebug == 0.1 16:22:26 INFO - mozdevice == 0.48 16:22:26 INFO - mozfile == 1.2 16:22:26 INFO - mozhttpd == 0.7 16:22:26 INFO - mozinfo == 0.9 16:22:26 INFO - mozleak == 0.1 16:22:26 INFO - mozlog == 3.1 16:22:26 INFO - moznetwork == 0.27 16:22:26 INFO - mozprocess == 0.22 16:22:26 INFO - mozprofile == 0.28 16:22:26 INFO - mozrunner == 6.11 16:22:26 INFO - mozscreenshot == 0.1 16:22:26 INFO - mozsystemmonitor == 0.0 16:22:26 INFO - moztest == 0.7 16:22:26 INFO - mozversion == 1.4 16:22:26 INFO - psutil == 3.1.1 16:22:26 INFO - requests == 1.2.3 16:22:26 INFO - wsgiref == 0.1.2 16:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:26 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:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:26 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:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:26 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 16:22:26 INFO - 'HOME': '/home/cltbld', 16:22:26 INFO - 'LANG': 'en_US.UTF-8', 16:22:26 INFO - 'LANGUAGE': 'en_US:en', 16:22:26 INFO - 'LOGNAME': 'cltbld', 16:22:26 INFO - 'MAIL': '/var/mail/cltbld', 16:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:26 INFO - 'MOZ_NO_REMOTE': '1', 16:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:26 INFO - 'NO_EM_RESTART': '1', 16:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:26 INFO - 'PWD': '/builds/slave/test', 16:22:26 INFO - 'SHELL': '/bin/bash', 16:22:26 INFO - 'SHLVL': '1', 16:22:26 INFO - 'TERM': 'linux', 16:22:26 INFO - 'TMOUT': '86400', 16:22:26 INFO - 'USER': 'cltbld', 16:22:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:26 INFO - '_': '/tools/buildbot/bin/python'} 16:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 INFO - Cleaning up... 16:22:26 INFO - Return code: 0 16:22:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:22:26 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:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:26 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:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:26 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 16:22:26 INFO - 'HOME': '/home/cltbld', 16:22:26 INFO - 'LANG': 'en_US.UTF-8', 16:22:26 INFO - 'LANGUAGE': 'en_US:en', 16:22:26 INFO - 'LOGNAME': 'cltbld', 16:22:26 INFO - 'MAIL': '/var/mail/cltbld', 16:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:26 INFO - 'MOZ_NO_REMOTE': '1', 16:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:26 INFO - 'NO_EM_RESTART': '1', 16:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:26 INFO - 'PWD': '/builds/slave/test', 16:22:26 INFO - 'SHELL': '/bin/bash', 16:22:26 INFO - 'SHLVL': '1', 16:22:26 INFO - 'TERM': 'linux', 16:22:26 INFO - 'TMOUT': '86400', 16:22:26 INFO - 'USER': 'cltbld', 16:22:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:26 INFO - '_': '/tools/buildbot/bin/python'} 16:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:27 INFO - Downloading/unpacking jsonschema 16:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:29 INFO - Downloading/unpacking functools32 (from jsonschema) 16:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:29 INFO - warning: no files found matching '*.txt' 16:22:29 INFO - no previously-included directories found matching 'build' 16:22:29 INFO - no previously-included directories found matching 'dist' 16:22:29 INFO - no previously-included directories found matching '.git*' 16:22:29 INFO - Installing collected packages: jsonschema, functools32 16:22:29 INFO - Running setup.py install for functools32 16:22:29 INFO - warning: no files found matching '*.txt' 16:22:29 INFO - no previously-included directories found matching 'build' 16:22:29 INFO - no previously-included directories found matching 'dist' 16:22:29 INFO - no previously-included directories found matching '.git*' 16:22:29 INFO - Successfully installed jsonschema functools32 16:22:29 INFO - Cleaning up... 16:22:29 INFO - Return code: 0 16:22:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:29 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 0x7fa2dce09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22457d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, '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': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 16:22:29 INFO - 'HOME': '/home/cltbld', 16:22:29 INFO - 'LANG': 'en_US.UTF-8', 16:22:29 INFO - 'LANGUAGE': 'en_US:en', 16:22:29 INFO - 'LOGNAME': 'cltbld', 16:22:29 INFO - 'MAIL': '/var/mail/cltbld', 16:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:29 INFO - 'MOZ_NO_REMOTE': '1', 16:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:29 INFO - 'NO_EM_RESTART': '1', 16:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:29 INFO - 'PWD': '/builds/slave/test', 16:22:29 INFO - 'SHELL': '/bin/bash', 16:22:29 INFO - 'SHLVL': '1', 16:22:29 INFO - 'TERM': 'linux', 16:22:29 INFO - 'TMOUT': '86400', 16:22:29 INFO - 'USER': 'cltbld', 16:22:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:29 INFO - '_': '/tools/buildbot/bin/python'} 16:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:29 INFO - Downloading/unpacking flake8 16:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:22:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:22:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:22:32 INFO - no previously-included directories found matching 'docs/_build' 16:22:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:22:32 INFO - Running setup.py install for pep8 16:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:22:32 INFO - no previously-included directories found matching 'docs/_build' 16:22:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:22:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:22:32 INFO - Cleaning up... 16:22:32 INFO - Return code: 0 16:22:32 INFO - Running post-action listener: _resource_record_post_action 16:22:32 INFO - Running post-action listener: _start_resource_monitoring 16:22:32 INFO - Starting resource monitoring. 16:22:32 INFO - ##### 16:22:32 INFO - ##### Running install step. 16:22:32 INFO - ##### 16:22:32 INFO - Running pre-action listener: _resource_record_pre_action 16:22:32 INFO - Running main action method: install 16:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:32 INFO - Reading from file tmpfile_stdout 16:22:32 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:32 INFO - Reading from file tmpfile_stdout 16:22:32 INFO - Output received: 16:22:32 INFO - Usage: mozinstall [options] installer 16:22:32 INFO - Options: 16:22:32 INFO - -h, --help show this help message and exit 16:22:32 INFO - -d DEST, --destination=DEST 16:22:32 INFO - Directory to install application into. [default: 16:22:32 INFO - "/builds/slave/test"] 16:22:32 INFO - --app=APP Application being installed. [default: firefox] 16:22:32 INFO - mkdir: /builds/slave/test/build/application 16:22:32 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:32 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:22:48 INFO - Reading from file tmpfile_stdout 16:22:48 INFO - Output received: 16:22:48 INFO - /builds/slave/test/build/application/firefox/firefox 16:22:48 INFO - Running post-action listener: _resource_record_post_action 16:22:48 INFO - ##### 16:22:48 INFO - ##### Running run-tests step. 16:22:48 INFO - ##### 16:22:48 INFO - Running pre-action listener: _resource_record_pre_action 16:22:48 INFO - Running main action method: run_tests 16:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:48 INFO - Python 2.7.3 16:22:48 INFO - Return code: 0 16:22:48 INFO - grabbing minidump binary from tooltool 16:22:48 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:48 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 0x22d4640>, '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 0x22d5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d59d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:48 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:22:48 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:22:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:48 INFO - Return code: 0 16:22:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:22:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:22:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:22:49 INFO - Return code: 0 16:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:22:49 INFO - Using env: {'DISPLAY': ':0', 16:22:49 INFO - 'HOME': '/home/cltbld', 16:22:49 INFO - 'LANG': 'en_US.UTF-8', 16:22:49 INFO - 'LANGUAGE': 'en_US:en', 16:22:49 INFO - 'LOGNAME': 'cltbld', 16:22:49 INFO - 'MAIL': '/var/mail/cltbld', 16:22:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:49 INFO - 'MOZ_NO_REMOTE': '1', 16:22:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:49 INFO - 'NO_EM_RESTART': '1', 16:22:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:49 INFO - 'PWD': '/builds/slave/test', 16:22:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:49 INFO - 'SHELL': '/bin/bash', 16:22:49 INFO - 'SHLVL': '1', 16:22:49 INFO - 'TERM': 'linux', 16:22:49 INFO - 'TMOUT': '86400', 16:22:49 INFO - 'USER': 'cltbld', 16:22:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373', 16:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:49 INFO - '_': '/tools/buildbot/bin/python'} 16:22:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eTxEbh3_RtumTzWMSjhpiQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:22:49 INFO - mozversion application_buildid: 20160502133436 16:22:49 INFO - mozversion application_changeset: cb7afc6a6450dd75d89b10825f719178eb15437b 16:22:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:22:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:49 INFO - mozversion application_name: Firefox 16:22:49 INFO - mozversion application_remotingname: firefox-dev 16:22:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:22:49 INFO - mozversion application_vendor: Mozilla 16:22:49 INFO - mozversion application_version: 48.0a2 16:22:49 INFO - mozversion platform_buildid: 20160502133436 16:22:49 INFO - mozversion platform_changeset: cb7afc6a6450dd75d89b10825f719178eb15437b 16:22:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:22:49 INFO - mozversion platform_version: 48.0a2 16:22:49 INFO - using testdate: 1462231369 16:22:49 INFO - actual date: 1462231369 16:22:49 INFO - starting webserver on 'localhost:36247' 16:22:49 INFO - SUITE-START | Running 2 tests 16:22:49 INFO - TEST-START | dromaeo_css 16:22:49 INFO - operating with platform_type : linux_ 16:22:49 INFO - Initialising browser for dromaeo_css test... 16:22:49 INFO - TEST-INFO | started process 19145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbkqYfD/profile http://localhost:36247/getInfo.html) 16:22:53 INFO - PROCESS | 19145 | 16:22:53 INFO - PROCESS | 19145 | (process:19221): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:22:54 INFO - PROCESS | 19145 | __metrics Screen width/height:1600/1200 16:22:54 INFO - PROCESS | 19145 | colorDepth:24 16:22:54 INFO - PROCESS | 19145 | Browser inner width/height: 1024/697 16:22:54 INFO - PROCESS | 19145 | __metrics 16:22:54 ERROR - PROCESS | 19145 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:22:55 INFO - TEST-INFO | 19145: exit 0 16:22:55 INFO - Browser initialized. 16:22:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:55 INFO - TEST-INFO | started process 19272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbkqYfD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:57 INFO - PROCESS | 19272 | 16:22:57 INFO - PROCESS | 19272 | (process:19342): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:23:07 INFO - PROCESS | 19272 | RSS: Main: 152358912 16:23:07 INFO - PROCESS | 19272 | 16:23:57 INFO - PROCESS | 19272 | 1462231437162 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:05 INFO - PROCESS | 19272 | Cycle 1(1): loaded http://localhost:36247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36247/tests/dromaeo/cssquery-ext.html) 16:26:06 INFO - PROCESS | 19272 | RSS: Main: 156393472 16:26:06 INFO - PROCESS | 19272 | 16:29:07 INFO - PROCESS | 19272 | Cycle 1(1): loaded http://localhost:36247/tests/dromaeo/cssquery-ext.html (next: http://localhost:36247/tests/dromaeo/cssquery-jquery.html) 16:29:08 INFO - PROCESS | 19272 | RSS: Main: 154714112 16:29:08 INFO - PROCESS | 19272 | 16:32:10 INFO - PROCESS | 19272 | Cycle 1(1): loaded http://localhost:36247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36247/tests/dromaeo/cssquery-mootools.html) 16:32:10 INFO - PROCESS | 19272 | RSS: Main: 153702400 16:32:10 INFO - PROCESS | 19272 | 16:35:12 INFO - PROCESS | 19272 | Cycle 1(1): loaded http://localhost:36247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36247/tests/dromaeo/cssquery-prototype.html) 16:35:13 INFO - PROCESS | 19272 | RSS: Main: 153776128 16:35:13 INFO - PROCESS | 19272 | 16:38:15 INFO - PROCESS | 19272 | Cycle 1(1): loaded http://localhost:36247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36247/tests/dromaeo/cssquery-yui.html) 16:38:16 INFO - PROCESS | 19272 | RSS: Main: 154914816 16:38:16 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | Cycle 1(1): loaded http://localhost:36247/tests/dromaeo/cssquery-yui.html (next: http://localhost:36247/tests/dromaeo/cssquery-dojo.html) 16:41:18 INFO - PROCESS | 19272 | RSS: Main: 155840512 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | __start_tp_report 16:41:18 INFO - PROCESS | 19272 | _x_x_mozilla_page_load 16:41:18 INFO - PROCESS | 19272 | _x_x_mozilla_page_load_details 16:41:18 INFO - PROCESS | 19272 | |i|pagename|runs| 16:41:18 INFO - PROCESS | 19272 | |0;dojo.html;3366.528685983962;3396.813175275359;3409.4374428219344;3434.484827275908;3441.5698037745265;5576.665400075998;5615.6069075164705;5621.578381621374;5625.493705566499;5656;5580.330360356763;5586.329640443152;5590.580706447023;5618.185363122355;5635.887282254353;5034.219695947125;5098.4136824265315;5103.413107492649;5106.387233531981;5129.281900533928;4999.200127979524;5112.1564941784745;5217.37391513019;5228.790848366079;5269.288646032794;5100.744962751866;5119.641625086246;5164.096283150452;5183.326167598226;5202.453742357055;5181.715005674687;5198.662086964335;5198.844034678947;5207.062728708831;5215.791368345262;5052.520010598987;5097.974510127426;5154.30416893722;5166.664166829144;5184.533391994701;5379.919301210485;5410.702411367373;5412.945870541323;5454.809081682161;5458.344998600193;5940.227770389865;5962.463378295931;5985.700714964234;5994.580379373446;6005.129256257862;5912.793052243193;6070.21087258658;6070.484008859252;6085.208922840003;6089.360617135181;5645.266115405012;5673.801416950387;5687.317521897357;5692.857678558028;5735.827925162252;6170.907436388457;6179.474744646755;6191.288001879751;6192.195014648067;6192.752289908353;5814.186013958049;5902.439268269508;5948.434898684618;5974.133750606138;5982.222311099529;6024.548158888101;6042.607230530001;6043;6049.606775559662;6084.209052823105;5891.116332550066;5949.940500595025;5972.701364931823;5993.310769261503;6027.819165424957;5906.3207731110615;5928.170056192136;5956.583039187215;6030.427109424598;6034.577579569475;4588.2888152336445;4597.655175861757;4600.171969045537;4604.907901841944;4622.560856718606;4102.261592913244;4112.670986321087;4123.731957422758;4124.835006599762;4151.27352713274;5690.487856092972;5709.743061562157;5731.742071606787;5774.162746401748;5779.624324418899;5942.910856337158;5986.311574169026;6078.240219972504;6084.148219249309;6087.908681369783;5660.773569057274;5667.659940403589;5694.259746232963;5699.914501282484;5707.0583353747;4820.084184005098;4846.3699719037;4938.925916111261;4951.3810773653295;4969.701817890938;6169.5064394848305;6182.227221597301;6190.566660333733;6237.752449510116;6240.500759939194;5993.6403815769445;5999.430054144849;6003.309619393651;6013.609115407485;6018.3680713524445;6202.534809889186;6290.811275661737;6310.5267104968225;6317.6209427434505;6344.841378965562;5941.67320797343;5954.166416701579;5970.731317090655;5984.760609575568;5985.730642121202;5909.645421274738;5983.162357270073;5984.012637914695;6053.909191362045;6065.484433823174;5860.765569377348;5873.353931067493;5904;5904.734286957011;5942.257217847769;5834.533237340917;5845.41545845412;5852.619579727304;5874.794382196603;5880.353161152184;5661.46216109469;5774.422557744192;5777.480026797609;5793.507551857971;5831.241938547962;5938.109283607493;5997.400259973968;5997.430244126801;6009.669468179292;6014.248218972629;5805;5849.970750146222;5866.208061911758;5872.324682661549;5872.794452194153 16:41:18 INFO - PROCESS | 19272 | |1;ext.html;609.2719200555335;668.8695704337655;674.5885010143811;675.7364627795159;679.2731776998613;32722;38370.23259534811;39426.408603870965;39482.210355792864;39531.209375812505;41957.370639440436;42672.35991460131;42817;42821.7858910705;42923.570764292344;8846.95576522118;8994.28045756338;9061.637534498612;9078.455292682427;9082.727518174466;8772.780680482974;8927.77680557988;8929.821403571925;8930.419522731034;8942;9172.174504294611;9194.770130746718;9246.76883077925;9252.861207081865;9285.721428357127;9128.634854605807;9178.265738740918;9238.260939124853;9241.676541321021;9264.25885929124;9095.363324567283;9233.353665243436;9253.259739220846;9287.442753434749;9289.16397524226;42880.571194288284;43269.91825204364;43361.132777344596;43362.566374336486;43446.78276608628;3749.418840079792;3916.667083297923;3995.1210733638845;4019.7295908952615;4027.013381721468;32750.508742368882;32831.50752738711;32995;33020;33151.336973260644;4011.578784227643;4102.953746794578;4168.541460439349;4238.237117318881;4306.267934451151;293816;295035;298164;299186;299543;63994;64684.67657661682;64962;65097.67451162714;65126.34873651298;58297.54256143545;58506.12240816391;58719;59146.408535914954;67739.64520709559;15338.846611533965;15397.846021539865;15424.922875385551;15569;15605.60985975337;13102.606921792361;13115.868841311465;13132.080754347104;13142.671433214246;13190.47238110484;20589.794102059088;20892.895535522224;20938.476538086365;20967;21038.78961210399;7283.198848126702;7399;7563.810904727426;7759.844803103906;7775.1447340792465;1127.2109523333536;1150.1316506037888;1153.9769204615861;1188.7442954223857;1205.7467931734259;32472;32688.509672354932;33106.17234569155;33494.157821319575;33531.32937341288;1154.9595764148214;1194.2297218294325;1241.900647948162;1254.5546331052344;1288.7486940046601;17257.65484690299;17442.302307907543;17465.91267043682;17533.21100550478;17642.294308227785;306739;339563;346629;347398;501401;56098;56893;57248.42751572514;57429.71285143548;57649.71175144181;1499.3327969053666;1518.476125736619;1538.4384699584796;1541.9383224671112;1544.1275679241194;31663.20841978969;32595.511067333533;34436;34457.310853782285;34699.30601388009;53498.73250633722;53662.19506707325;53963.190552140964;54036;54077.45922540881;461392;463820;464336;465594;467387;30258.54612180775;40732.1853562933;41731.53939612099;41821;42236.78881605695;44077.77961110174;45020.32469512895;45410.31884521669;45626;47181.29228061513;39866.80066599648;40224.597754023256;40592.594074058885;41186.588134118276;41777.37333940054;39292;39839.60160398359;39972.600273998054;40239.396409053305;40949.97625059397;41067.794661026506;41764.58235417607;41965.58034419739;42215.155696886504;42257.154856902074;35180.29639407249;35776.64223357837;36271.27457450889;36700.26599467942;36753.26493470169;28452.43095138127;29006.7099329004;29151;29211.561826573045;29433.411331773674 16:41:18 INFO - PROCESS | 19272 | |2;jquery.html;403.8707613563659;411.500027466628;417.10739018500396;422.25893556807836;427.45712944560404;18403.63192736146;18948.999999999967;19074.42776716699;19077.332293369716;19864.60270794587;19161.61676766464;19364.709529357035;19929.302474413398;19940.800591994113;19976.300829470973;5314.202869569557;5587.832365029056;5595.832125036235;5598.1322894951345;5858.238429004224;5514.91727624086;5517.668939863601;5551.139573366115;6607.174103237096;6620.139381880349;6460.321666225049;6568.408843204134;6575.473962083021;6579.506537009719;6582.3417658234275;5620;5774.451427114417;5781.306243250795;5788.739506722229;6466.93533064668;5443.591730620219;5564.4991950724625;5586.91619625706;5603.187537807036;5604.271444712162;12407.317597532132;12417.565385211565;12512.124151309412;12688.492460301577;12771.744565108738;2457.2259738182415;2590.119359417788;2612.1510509084433;2613.9869300653377;2917.2560996945854;9787.804243915081;9840.65557705484;9908.10827025564;10171.64399246023;10237.795244095076;2006.7993200679816;2020.8282296004857;2038.8266997305248;2039.3576023552534;2084.833213342929;78534;79147.60426197833;81322;82585.58707206485;83663.5816820912;10957.616483423042;11198;11390.829137562943;11408.600698975495;11536.25014374063;15925.522234332988;15983.200839957955;16079.758803617955;16088.436904708278;16118.67762644764;8204.343652507785;8428.241458268785;8460.788480288042;8490.617922193516;8500.957495212484;7787.727429540052;7955.443118981616;7957.562334071682;7982.640781164861;7998.4001199910235;4448.599626033672;4459.063596644676;4846.7818948147415;4861.465238823726;4937.950620493749;1939.864209505321;2002.67957126859;2006.438197304757;2047.4574237826987;2138.957220855574;1047.1151926532211;1061.4215252687304;1138.829175623663;1142.5886680794906;1158.5887010111458;19327.936963467146;19727;19828.306009289605;20293.49266268355;20539.38381848547;1018.4144117132678;1112.1325366214367;1112.3548341961643;1144.5364627325946;1160.8665003524702;10649.840252396065;10810.243282970274;10950.616728414627;10985;11067.833982490269;523003;526031;534396;537301;544201;93171.53414233022;96753;97090;97485;101192.49403752934;1136.5113001409472;1154.2785758900686;1160.1530882455686;1161.3206274329443;1171.5138217639756;17142.828571714123;17149.971001739934;17273.39543115985;17360;17409.30362785525;38671;39002.60997390103;39557.40663889986;39637.405438917864;40892.79553602332;52755.47244527659;53366;54589.72705136449;58216.4178358211;59600.70199649147;7468.5145465544565;7708.075030996316;7774.222577742181;8053.35573154158;8071.59642017885;11202.21584489078;11445.42772861337;11564.710882228012;12320.137590368588;12332.445039973401;10290.279680422298;10863.945680271549;11067.83398249043;11218.943905280748;11481.655550333504;10689.732756681145;10698.89301106979;10805.135589152691;11612.419379031184;11686.590969316034;10928.180386470887;10931.344119352865;11405.54377824911;11454.770904582028;11477.48351324209;8183.83632327362;8239;8258.215469530625;8472.898523191945;8752;8131.9593402032615;10140.645077422254;11126.221164518405;11139.220254582102;11332.206745527734 16:41:18 INFO - PROCESS | 19272 | |3;mootools.html;1530.3343045775084;1564.8904576679631;1731.896086234826;1834.2846289946915;1867.2064372641623;7709.6916123354995;7840.764777056683;8071.717489887855;8474.830503389936;8489.702860399895;7826;7842.921570784305;7861.8034549136155;7954.602269886512;7963.402744794134;2247.6291411917055;2264.535770167112;2273.818094552432;2275.590393729128;2281.3954302109955;2241.4396400899777;2262.536180083079;2271.0802125139344;2273.0794028418436;2281.783230593091;2231.7656646052174;2266.6260067088992;2271.46620544172;2300.3214051854743;2302.102180149743;2266.2294819761278;2269.239804665439;2277.840551161428;2287.9084836606517;2289.645105008726;2253.7971582557648;2268.7844654757773;2273.181654604341;2281.7718228177214;2282.657601359793;8117.269445749911;8208.179182081803;8210.630521626541;8214.096449390563;8219.54792486413;5156.690598564098;5330.653507521999;5361.892762144775;5362.65142765719;5362.973185134049;3264.461363874958;3355.9664403355896;3459.3600183965796;3500.579930408367;3522.559680039995;1055.1558752997648;1060.289605964006;1081.8972197641212;1100.5872797700863;1100.6918062942389;11754.64736057911;11774.293542387484;11793.94103029488;11815.527378904833;11841.822372664417;4394.648428125743;4480.395146655225;4561.817527298937;4574.016586433866;4635.188841952645;9946.20430365569;9976.351537150207;9984.700458986243;9994.450305233282;10026.047525485068;5216.973915130476;5325.547328477122;5338.46615338463;5339.279197308391;5342.198670199501;4287.164003019381;4695.9530404695515;4723.338732577442;4802.27965805132;4876.073546026244;3961.9009524761536;3982.303096958021;4021.3766866135797;4026.6174713402766;4061.593840615974;1240.1814802230485;1250.9804509324872;1252.7619752247044;1254.084518301645;1257.3336131850135;1005.3967619428284;1015.9586423915398;1087.526925787285;1111.4776055254017;1117.5027112934665;5764.394738552475;5815.767369305265;5932.169496270526;5947.851303717442;6046.093086037042;1052.3002203534718;1054.9578016879238;1074.8441475985937;1084.6800193942806;1100.5432745410726;4045.211183819127;4057.188562287495;4107.383892416162;4184.623383895403;4234.618884300427;10307.793844123225;10575.841362379571;10643.94678026605;10767.407792571485;10842.132629389629;10684.57261709523;10782.892171078345;10816.567337306577;10846.891531084746;10893.618723344645;7632.885506717404;8101.716439924574;8126.390520710852;8197;8222.876656850272;5800.709964501673;5942.227510423617;5997.4002599741425;6046.123312119806;6077.848053798691;9824.263180261367;9847.507624618596;10043.949780251052;10046.24653151002;10053.447060411456;9235.26117910579;9641.807163856824;9782.413055216424;9833.01669833011;9906.950465247628;7033.296670332926;7305.926940730525;7388.298111679382;7518.323350898446;7699.230076992256;8277.213664701843;8279.337652987626;8342.499450033018;8347.582620869054;8348.958255208685;7378.704851805867;7464.589447580435;7631.771046868603;7664.578448185403;7688.8462230756195;7487.737929172671;7544.924550754422;7566.31903128721;7617.704990151577;7684.6157692116285;6739.123913891359;6785.355391237825;6796.286389928986;6857.794266172023;6859.759908403182;5209.192575150858;5323.840284791462;5411.540019098421;5497.257870187474;5580.888382232251;5437.456254374689;5621.353544342453;5667.659940403589;5708.686022268815;5923.585349025527 16:41:18 INFO - PROCESS | 19272 | |4;prototype.html;312.8623405701491;315.0595472514544;315.783688173601;323.5874260318094;327.06133397150177;5786.305643322802;5832.912506312404;5866.181483740043;5872.823815285548;5895.528357731382;5690.743916523756;5707.857303567413;5733.598648094635;5738.454846789558;5738.626989245696;4156.334986402177;4237.131388065439;4359.760213188273;4396.384506169139;4404.823807047715;4370.448490785773;4373.103513779683;4385.429894113777;4387.29803231483;4397.230484665187;4362.607365337119;4363.120340575221;4365.083332500163;4370.8033138508845;4387.451568553931;4261.680373971949;4322.891927701801;4351.26028575143;4361.214981303364;4383.123375324916;3800.6959443244473;3823.674987626055;3831.6359945805384;3850.09420336935;3871.8838434847;5568.387477377485;5582.553395728372;5586.932834851091;5613.578981576398;5640.110562961413;4942.713288931181;4981.327520784684;5006.374203224597;5036.841526448938;5086.669366491166;5956.7319470623925;5961.152042866725;5975.223220981288;5977;6034.456898879122;4210.305299625558;4217.578242175789;4223.936640950388;4238.554951730055;4248.872533823959;6048.576599638027;6275.278342990523;6325.620462772248;6393.520485963525;6408.296616011753;4216.746995180299;4266.978665106654;4309.784510774449;4318.417013703172;4342;4377.430933978562;4379;4382.956170438319;4386.363977223285;4404.229259879508;4801.18379875422;5051.292819005343;5054.823081192214;5077.949220507748;5082.313887625123;6126.590884096683;6133.1413602095745;6143.109249158847;6200.0699895015205;6211.3167551569295;1589.2848218301579;1602.5993501624594;1607.7106120898118;1612.7822743929419;1620.440947872982;989.1938070472542;1039.8440233964966;1046.9267151299337;1051.5530899367739;1066.935983840972;6152.261728592597;6170.352113028157;6195.070739389038;6223.37766223374;6244.2819075805955;6502.642354670444;6576.473882089422;6579.374959378852;6615.503837212228;6634.270230274666;6135.693215339215;6140.600860944024;6142.617910969996;6153.015787343135;6171.413715697002;3510.57873055235;3540.1149712571855;3549.538559987185;3560.181158333598;3563.9287214256087;6749.19230404327;6786.59280443175;6835.897461538081;6864.38220560152;6882.8623427531165;6727.663616819237;6751.662416879137;6769.8646027079185;6795.558288711218;6796.490263230277;6670.39966403026;6784.491163162783;6854.149379667462;6866.210385805596;6866.862662746717;6568.704408301543;6593;6607.108040414482;6612.702428390638;6658.234303055211;6424.710888009958;6502.057201705632;6545.116409284686;6585.275619681927;6609.636469994197;6828.9658551706925;6834.521583489108;6846.7945961621235;6854.246032936273;6860.5197636164985;4569.725816451024;4574.588287054181;4580.748058856661;4585.266357382803;4601.677882548323;6115.960286751352;6303.684815759286;6378.553501254868;6379.681015949277;6401.775937842153;6142.757893368977;6156.322804491592;6164.167837342081;6214.471769899428;6236.469900058546;5992.711567012939;6100.572959892765;6124.479419249414;6155.969220153871;6209.937900620936;5931.703414829328;6056.727447264796;6079.939200608114;6102.206713127265;6111.266648002268;6135.907961380493;6158.846028849314;6192.6995330981;6213.37866213375;6226.1905952225925;5908.763649453974;6007.146605362418;6023;6047.697615119315;6057.151998720271 16:41:18 INFO - PROCESS | 19272 | |5;yui.html;823.1562648285504;858.8368210040092;894.6779159502582;895.1004240738057;900.5137225898015;13907.513237036706;13939.860601393983;14008.999999999987;14017.08888922222;14878.628034299134;12347;14329.570112896603;14380;14384.208868512227;14388.424463021493;844.4511067805914;876.2726936642604;877.2324216310728;880.3881302494736;883.5802993578063;887.5872719185577;888.6534251641865;893.1202765276198;896.995515022424;897.9865302020474;918.8070505193917;921.5852866210199;924.533110779059;928.9163975242227;930.2186163622556;913.8811954445913;917.3165991336464;917.5504003038529;919.1957037592107;921.3596550397476;675.166169780321;676.1413005483058;676.7157793726598;678.3453966921944;678.9287124851918;14596.343164557515;14728.337224824802;14770.852291477055;14838.406463741438;14945.327460264314;13732.519361822287;14019.789703154462;14236.288185590782;14488.492902748354;14587.489028963544;11263.43682815856;11301.773964520746;11414.771704565945;11478.483468243949;11555.711107222303;4004.739691920016;4047.9595204048173;4060.1879624075304;4132.628063474272;4163.7293575917465;55307.44692553063;55586.16620750692;55779.442205577834;55960.440395596335;57142.42857571454;11237.550497980154;11361.171502111734;11409.42952852354;11485.540578376938;11579;20037.799622003884;20081.29715459981;20088;20100.296489623084;20101.29645462431;8504.914950850536;8547.487150770974;8614.267787238156;8678.262347700389;8703.434276772115;4919.434265059564;4937.308776771255;4996.975015124974;5034.270030845507;5113.284140220372;3309.7848639838335;3400.7619466637098;3403.030136411111;3416.982915085409;3425.2293234022145;548.297759252523;595.9463648271676;604.4227762486814;606.2694453183902;606.9575129740964;691.5574032619128;696.022088965005;728.8287252495659;776.3090849144266;777.3975169243769;9618.807623847484;9799.16707079892;9819.459929703791;10216.284860059724;10400.843987340197;716.1370548489058;774.4607145345716;782.3936449251762;810.7932477218271;816.8652172391608;4673.439187297546;4920.680155789933;4922.064807686528;4929.186684197068;4945.381827271591;66439.33560664428;68080.6595967017;68983.3101668987;70643.29356706367;71265.2873471269;59330.703346482995;60438;60904.695476522335;60958.695206523684;61898.69050654808;54837.451625483234;55101.72449137729;55106.72446637821;55819.441805581424;55977.72011139918;9295.349325547148;9384.296177786557;9386.530673466163;9458.810823783624;9599.800523625483;33453.49819752657;34735.82632086823;35167.12082197965;35342;35905.64094359023;42749.35875961801;44841.10317793691;47836.760816195696;47849.28226076542;47931.28103078526;12001.819972700241;12136.75726485483;12159.756804863677;12189.634310970685;12517.123801333819;12763.744725105631;12869.613911582668;12890.419931102935;12966.675833104247;13105.737885242432;11650.533978641099;11756.70608234801;12304.385721643188;12414.131010829517;12586.496540138292;12635.94819500707;12675.112742108333;12703.618891433272;12717.258994672293;13428.530001449903;11541.538338466704;13582.185068895898;13733.176009439465;13862.722745545234;13887.513937012156;11320.150988676047;11348.943255283672;11541.126102103699;11676.94161529187;11747.647570572897;11279.718007049889;11497.310161390344;11572.59495917639;11648.242864213798;11734.354610496504 16:41:18 INFO - PROCESS | 19272 | __end_tp_report 16:41:18 INFO - PROCESS | 19272 | __start_cc_report 16:41:18 INFO - PROCESS | 19272 | _x_x_mozilla_cycle_collect,346 16:41:18 INFO - PROCESS | 19272 | __end_cc_report 16:41:18 INFO - PROCESS | 19272 | __startTimestamp1462232478583__endTimestamp 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | ------- Summary: start ------- 16:41:18 INFO - PROCESS | 19272 | Number of tests: 6 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | [#0] dojo.html Cycles:165 Average:5591.91 Median:5834.53 stddev:623.56 (10.7%) stddev-sans-first:600.53 16:41:18 INFO - PROCESS | 19272 | Values: 3366.5 3396.8 3409.4 3434.5 3441.6 5576.7 5615.6 5621.6 5625.5 5656.0 5580.3 5586.3 5590.6 5618.2 5635.9 5034.2 5098.4 5103.4 5106.4 5129.3 4999.2 5112.2 5217.4 5228.8 5269.3 5100.7 5119.6 5164.1 5183.3 5202.5 5181.7 5198.7 5198.8 5207.1 5215.8 5052.5 5098.0 5154.3 5166.7 5184.5 5379.9 5410.7 5412.9 5454.8 5458.3 5940.2 5962.5 5985.7 5994.6 6005.1 5912.8 6070.2 6070.5 6085.2 6089.4 5645.3 5673.8 5687.3 5692.9 5735.8 6170.9 6179.5 6191.3 6192.2 6192.8 5814.2 5902.4 5948.4 5974.1 5982.2 6024.5 6042.6 6043.0 6049.6 6084.2 5891.1 5949.9 5972.7 5993.3 6027.8 5906.3 5928.2 5956.6 6030.4 6034.6 4588.3 4597.7 4600.2 4604.9 4622.6 4102.3 4112.7 4123.7 4124.8 4151.3 5690.5 5709.7 5731.7 5774.2 5779.6 5942.9 5986.3 6078.2 6084.1 6087.9 5660.8 5667.7 5694.3 5699.9 5707.1 4820.1 4846.4 4938.9 4951.4 4969.7 6169.5 6182.2 6190.6 6237.8 6240.5 5993.6 5999.4 6003.3 6013.6 6018.4 6202.5 6290.8 6310.5 6317.6 6344.8 5941.7 5954.2 5970.7 5984.8 5985.7 5909.6 5983.2 5984.0 6053.9 6065.5 5860.8 5873.4 5904.0 5904.7 5942.3 5834.5 5845.4 5852.6 5874.8 5880.4 5661.5 5774.4 5777.5 5793.5 5831.2 5938.1 5997.4 5997.4 6009.7 6014.2 5805.0 5850.0 5866.2 5872.3 5872.8 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | [#1] ext.html Cycles:180 Average:55416.43 Median:22585.37 stddev:101493.92 (449.4%) stddev-sans-first:101695.22 16:41:18 INFO - PROCESS | 19272 | Values: 609.3 668.9 674.6 675.7 679.3 32722.0 38370.2 39426.4 39482.2 39531.2 41957.4 42672.4 42817.0 42821.8 42923.6 8847.0 8994.3 9061.6 9078.5 9082.7 8772.8 8927.8 8929.8 8930.4 8942.0 9172.2 9194.8 9246.8 9252.9 9285.7 9128.6 9178.3 9238.3 9241.7 9264.3 9095.4 9233.4 9253.3 9287.4 9289.2 42880.6 43269.9 43361.1 43362.6 43446.8 3749.4 3916.7 3995.1 4019.7 4027.0 32750.5 32831.5 32995.0 33020.0 33151.3 4011.6 4103.0 4168.5 4238.2 4306.3 293816.0 295035.0 298164.0 299186.0 299543.0 63994.0 64684.7 64962.0 65097.7 65126.3 58297.5 58506.1 58719.0 59146.4 67739.6 15338.8 15397.8 15424.9 15569.0 15605.6 13102.6 13115.9 13132.1 13142.7 13190.5 20589.8 20892.9 20938.5 20967.0 21038.8 7283.2 7399.0 7563.8 7759.8 7775.1 1127.2 1150.1 1154.0 1188.7 1205.7 32472.0 32688.5 33106.2 33494.2 33531.3 1155.0 1194.2 1241.9 1254.6 1288.7 17257.7 17442.3 17465.9 17533.2 17642.3 306739.0 339563.0 346629.0 347398.0 501401.0 56098.0 56893.0 57248.4 57429.7 57649.7 1499.3 1518.5 1538.4 1541.9 1544.1 31663.2 32595.5 34436.0 34457.3 34699.3 53498.7 53662.2 53963.2 54036.0 54077.5 461392.0 463820.0 464336.0 465594.0 467387.0 30258.5 40732.2 41731.5 41821.0 42236.8 44077.8 45020.3 45410.3 45626.0 47181.3 39866.8 40224.6 40592.6 41186.6 41777.4 39292.0 39839.6 39972.6 40239.4 40950.0 41067.8 41764.6 41965.6 42215.2 42257.2 35180.3 35776.6 36271.3 36700.3 36753.3 28452.4 29006.7 29151.0 29211.6 29433.4 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | [#2] jquery.html Cycles:180 Average:29887.49 Median:2111.90 stddev:87799.96 (4157.4%) stddev-sans-first:88018.35 16:41:18 INFO - PROCESS | 19272 | Values: 403.9 411.5 417.1 422.3 427.5 18403.6 18949.0 19074.4 19077.3 19864.6 19161.6 19364.7 19929.3 19940.8 19976.3 5314.2 5587.8 5595.8 5598.1 5858.2 5514.9 5517.7 5551.1 6607.2 6620.1 6460.3 6568.4 6575.5 6579.5 6582.3 5620.0 5774.5 5781.3 5788.7 6466.9 5443.6 5564.5 5586.9 5603.2 5604.3 12407.3 12417.6 12512.1 12688.5 12771.7 2457.2 2590.1 2612.2 2614.0 2917.3 9787.8 9840.7 9908.1 10171.6 10237.8 2006.8 2020.8 2038.8 2039.4 2084.8 78534.0 79147.6 81322.0 82585.6 83663.6 10957.6 11198.0 11390.8 11408.6 11536.3 15925.5 15983.2 16079.8 16088.4 16118.7 8204.3 8428.2 8460.8 8490.6 8501.0 7787.7 7955.4 7957.6 7982.6 7998.4 4448.6 4459.1 4846.8 4861.5 4938.0 1939.9 2002.7 2006.4 2047.5 2139.0 1047.1 1061.4 1138.8 1142.6 1158.6 19327.9 19727.0 19828.3 20293.5 20539.4 1018.4 1112.1 1112.4 1144.5 1160.9 10649.8 10810.2 10950.6 10985.0 11067.8 523003.0 526031.0 534396.0 537301.0 544201.0 93171.5 96753.0 97090.0 97485.0 101192.5 1136.5 1154.3 1160.2 1161.3 1171.5 17142.8 17150.0 17273.4 17360.0 17409.3 38671.0 39002.6 39557.4 39637.4 40892.8 52755.5 53366.0 54589.7 58216.4 59600.7 7468.5 7708.1 7774.2 8053.4 8071.6 11202.2 11445.4 11564.7 12320.1 12332.4 10290.3 10863.9 11067.8 11218.9 11481.7 10689.7 10698.9 10805.1 11612.4 11686.6 10928.2 10931.3 11405.5 11454.8 11477.5 8183.8 8239.0 8258.2 8472.9 8752.0 8132.0 10140.6 11126.2 11139.2 11332.2 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | [#3] mootools.html Cycles:180 Average:5684.83 Median:4709.65 stddev:3139.65 (66.7%) stddev-sans-first:3132.94 16:41:18 INFO - PROCESS | 19272 | Values: 1530.3 1564.9 1731.9 1834.3 1867.2 7709.7 7840.8 8071.7 8474.8 8489.7 7826.0 7842.9 7861.8 7954.6 7963.4 2247.6 2264.5 2273.8 2275.6 2281.4 2241.4 2262.5 2271.1 2273.1 2281.8 2231.8 2266.6 2271.5 2300.3 2302.1 2266.2 2269.2 2277.8 2287.9 2289.6 2253.8 2268.8 2273.2 2281.8 2282.7 8117.3 8208.2 8210.6 8214.1 8219.5 5156.7 5330.7 5361.9 5362.7 5363.0 3264.5 3356.0 3459.4 3500.6 3522.6 1055.2 1060.3 1081.9 1100.6 1100.7 11754.6 11774.3 11793.9 11815.5 11841.8 4394.6 4480.4 4561.8 4574.0 4635.2 9946.2 9976.4 9984.7 9994.5 10026.0 5217.0 5325.5 5338.5 5339.3 5342.2 4287.2 4696.0 4723.3 4802.3 4876.1 3961.9 3982.3 4021.4 4026.6 4061.6 1240.2 1251.0 1252.8 1254.1 1257.3 1005.4 1016.0 1087.5 1111.5 1117.5 5764.4 5815.8 5932.2 5947.9 6046.1 1052.3 1055.0 1074.8 1084.7 1100.5 4045.2 4057.2 4107.4 4184.6 4234.6 10307.8 10575.8 10643.9 10767.4 10842.1 10684.6 10782.9 10816.6 10846.9 10893.6 7632.9 8101.7 8126.4 8197.0 8222.9 5800.7 5942.2 5997.4 6046.1 6077.8 9824.3 9847.5 10043.9 10046.2 10053.4 9235.3 9641.8 9782.4 9833.0 9907.0 7033.3 7305.9 7388.3 7518.3 7699.2 8277.2 8279.3 8342.5 8347.6 8349.0 7378.7 7464.6 7631.8 7664.6 7688.8 7487.7 7544.9 7566.3 7617.7 7684.6 6739.1 6785.4 6796.3 6857.8 6859.8 5209.2 5323.8 5411.5 5497.3 5580.9 5437.5 5621.4 5667.7 5708.7 5923.6 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | [#4] prototype.html Cycles:180 Average:5195.57 Median:5944.22 stddev:1598.45 (26.9%) stddev-sans-first:1560.36 16:41:18 INFO - PROCESS | 19272 | Values: 312.9 315.1 315.8 323.6 327.1 5786.3 5832.9 5866.2 5872.8 5895.5 5690.7 5707.9 5733.6 5738.5 5738.6 4156.3 4237.1 4359.8 4396.4 4404.8 4370.4 4373.1 4385.4 4387.3 4397.2 4362.6 4363.1 4365.1 4370.8 4387.5 4261.7 4322.9 4351.3 4361.2 4383.1 3800.7 3823.7 3831.6 3850.1 3871.9 5568.4 5582.6 5586.9 5613.6 5640.1 4942.7 4981.3 5006.4 5036.8 5086.7 5956.7 5961.2 5975.2 5977.0 6034.5 4210.3 4217.6 4223.9 4238.6 4248.9 6048.6 6275.3 6325.6 6393.5 6408.3 4216.7 4267.0 4309.8 4318.4 4342.0 4377.4 4379.0 4383.0 4386.4 4404.2 4801.2 5051.3 5054.8 5077.9 5082.3 6126.6 6133.1 6143.1 6200.1 6211.3 1589.3 1602.6 1607.7 1612.8 1620.4 989.2 1039.8 1046.9 1051.6 1066.9 6152.3 6170.4 6195.1 6223.4 6244.3 6502.6 6576.5 6579.4 6615.5 6634.3 6135.7 6140.6 6142.6 6153.0 6171.4 3510.6 3540.1 3549.5 3560.2 3563.9 6749.2 6786.6 6835.9 6864.4 6882.9 6727.7 6751.7 6769.9 6795.6 6796.5 6670.4 6784.5 6854.1 6866.2 6866.9 6568.7 6593.0 6607.1 6612.7 6658.2 6424.7 6502.1 6545.1 6585.3 6609.6 6829.0 6834.5 6846.8 6854.2 6860.5 4569.7 4574.6 4580.7 4585.3 4601.7 6116.0 6303.7 6378.6 6379.7 6401.8 6142.8 6156.3 6164.2 6214.5 6236.5 5992.7 6100.6 6124.5 6156.0 6209.9 5931.7 6056.7 6079.9 6102.2 6111.3 6135.9 6158.8 6192.7 6213.4 6226.2 5908.8 6007.1 6023.0 6047.7 6057.2 16:41:18 INFO - PROCESS | 19272 | 16:41:18 INFO - PROCESS | 19272 | [#5] yui.html Cycles:180 Average:15594.21 Median:47843.02 stddev:18433.96 (38.5%) stddev-sans-first:18452.30 16:41:18 INFO - PROCESS | 19272 | Values: 823.2 858.8 894.7 895.1 900.5 13907.5 13939.9 14009.0 14017.1 14878.6 12347.0 14329.6 14380.0 14384.2 14388.4 844.5 876.3 877.2 880.4 883.6 887.6 888.7 893.1 897.0 898.0 918.8 921.6 924.5 928.9 930.2 913.9 917.3 917.6 919.2 921.4 675.2 676.1 676.7 678.3 678.9 14596.3 14728.3 14770.9 14838.4 14945.3 13732.5 14019.8 14236.3 14488.5 14587.5 11263.4 11301.8 11414.8 11478.5 11555.7 4004.7 4048.0 4060.2 4132.6 4163.7 55307.4 55586.2 55779.4 55960.4 57142.4 11237.6 11361.2 11409.4 11485.5 11579.0 20037.8 20081.3 20088.0 20100.3 20101.3 8504.9 8547.5 8614.3 8678.3 8703.4 4919.4 4937.3 4997.0 5034.3 5113.3 3309.8 3400.8 3403.0 3417.0 3425.2 548.3 595.9 604.4 606.3 607.0 691.6 696.0 728.8 776.3 777.4 9618.8 9799.2 9819.5 10216.3 10400.8 716.1 774.5 782.4 810.8 816.9 4673.4 4920.7 4922.1 4929.2 4945.4 66439.3 68080.7 68983.3 70643.3 71265.3 59330.7 60438.0 60904.7 60958.7 61898.7 54837.5 55101.7 55106.7 55819.4 55977.7 9295.3 9384.3 9386.5 9458.8 9599.8 33453.5 34735.8 35167.1 35342.0 35905.6 42749.4 44841.1 47836.8 47849.3 47931.3 12001.8 12136.8 12159.8 12189.6 12517.1 12763.7 12869.6 12890.4 12966.7 13105.7 11650.5 11756.7 12304.4 12414.1 12586.5 12635.9 12675.1 12703.6 12717.3 13428.5 11541.5 13582.2 13733.2 13862.7 13887.5 11320.2 11348.9 11541.1 11676.9 11747.6 11279.7 11497.3 11572.6 11648.2 11734.4 16:41:18 INFO - PROCESS | 19272 | -------- Summary: end -------- 16:41:18 INFO - PROCESS | 19272 | 16:41:19 INFO - TEST-INFO | 19272: exit 0 16:41:19 INFO - TEST-OK | dromaeo_css | took 1109545ms 16:41:19 INFO - TEST-START | kraken 16:41:19 INFO - operating with platform_type : linux_ 16:41:19 INFO - Initialising browser for kraken test... 16:41:19 INFO - TEST-INFO | started process 19509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA6o6SS/profile http://localhost:36247/getInfo.html) 16:41:22 INFO - PROCESS | 19509 | 16:41:22 INFO - PROCESS | 19509 | (process:19584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:41:23 INFO - PROCESS | 19509 | __metrics Screen width/height:1600/1200 16:41:23 INFO - PROCESS | 19509 | colorDepth:24 16:41:23 INFO - PROCESS | 19509 | Browser inner width/height: 1024/697 16:41:23 INFO - PROCESS | 19509 | __metrics 16:41:24 ERROR - PROCESS | 19509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:41:25 INFO - TEST-INFO | 19509: exit 0 16:41:25 INFO - Browser initialized. 16:41:25 INFO - Running cycle 1/1 for kraken test... 16:41:25 INFO - TEST-INFO | started process 19635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA6o6SS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:26 INFO - PROCESS | 19635 | 16:41:26 INFO - PROCESS | 19635 | (process:19703): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:41:36 INFO - PROCESS | 19635 | RSS: Main: 152547328 16:41:36 INFO - PROCESS | 19635 | 16:41:39 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36247/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:40 INFO - PROCESS | 19635 | RSS: Main: 157343744 16:41:40 INFO - PROCESS | 19635 | 16:41:42 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36247/tests/kraken/driver.html?testName=audio-dft) 16:41:43 INFO - PROCESS | 19635 | RSS: Main: 157188096 16:41:43 INFO - PROCESS | 19635 | 16:41:46 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36247/tests/kraken/driver.html?testName=audio-fft) 16:41:47 INFO - PROCESS | 19635 | RSS: Main: 157470720 16:41:47 INFO - PROCESS | 19635 | 16:41:49 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36247/tests/kraken/driver.html?testName=audio-oscillator) 16:41:49 INFO - PROCESS | 19635 | RSS: Main: 157708288 16:41:49 INFO - PROCESS | 19635 | 16:41:51 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:52 INFO - PROCESS | 19635 | RSS: Main: 157503488 16:41:52 INFO - PROCESS | 19635 | 16:41:55 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36247/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:56 INFO - PROCESS | 19635 | RSS: Main: 157622272 16:41:56 INFO - PROCESS | 19635 | 16:41:59 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36247/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:00 INFO - PROCESS | 19635 | RSS: Main: 158273536 16:42:00 INFO - PROCESS | 19635 | 16:42:03 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36247/tests/kraken/driver.html?testName=json-parse-financial) 16:42:03 INFO - PROCESS | 19635 | RSS: Main: 158064640 16:42:03 INFO - PROCESS | 19635 | 16:42:05 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:05 INFO - PROCESS | 19635 | RSS: Main: 157634560 16:42:05 INFO - PROCESS | 19635 | 16:42:07 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:08 INFO - PROCESS | 19635 | RSS: Main: 157835264 16:42:08 INFO - PROCESS | 19635 | 16:42:10 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:10 INFO - PROCESS | 19635 | RSS: Main: 158531584 16:42:10 INFO - PROCESS | 19635 | 16:42:13 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:13 INFO - PROCESS | 19635 | RSS: Main: 158404608 16:42:13 INFO - PROCESS | 19635 | 16:42:16 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:17 INFO - PROCESS | 19635 | RSS: Main: 158740480 16:42:17 INFO - PROCESS | 19635 | 16:42:18 INFO - PROCESS | 19635 | Cycle 1(1): loaded http://localhost:36247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36247/tests/kraken/driver.html?testName=ai-astar) 16:42:19 INFO - PROCESS | 19635 | RSS: Main: 160325632 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | __start_tp_report 16:42:19 INFO - PROCESS | 19635 | _x_x_mozilla_page_load 16:42:19 INFO - PROCESS | 19635 | _x_x_mozilla_page_load_details 16:42:19 INFO - PROCESS | 19635 | |i|pagename|runs| 16:42:19 INFO - PROCESS | 19635 | |0;ai-astar;112;108;110;112;112;122;111;109;110;111 16:42:19 INFO - PROCESS | 19635 | |1;audio-beat-detection;159;140;152;172;129;155;173;129;177;128 16:42:19 INFO - PROCESS | 19635 | |2;audio-dft;166;163;163;163;166;163;165;163;165;163 16:42:19 INFO - PROCESS | 19635 | |3;audio-fft;79;76;77;186;75;73;73;74;171;76 16:42:19 INFO - PROCESS | 19635 | |4;audio-oscillator;92;95;152;93;93;92;147;91;93;147 16:42:19 INFO - PROCESS | 19635 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;119;117;118 16:42:19 INFO - PROCESS | 19635 | |6;imaging-darkroom;147;147;146;147;147;146;147;147;147;146 16:42:19 INFO - PROCESS | 19635 | |7;imaging-desaturate;95;95;96;96;96;95;95;94;96;95 16:42:19 INFO - PROCESS | 19635 | |8;json-parse-financial;55;56;56;57;57;56;57;74;57;54 16:42:19 INFO - PROCESS | 19635 | |9;json-stringify-tinderbox;60;60;59;60;60;60;59;60;60;60 16:42:19 INFO - PROCESS | 19635 | |10;stanford-crypto-aes;74;72;73;72;75;75;76;75;82;74 16:42:19 INFO - PROCESS | 19635 | |11;stanford-crypto-ccm;123;123;118;127;118;120;126;122;158;122 16:42:19 INFO - PROCESS | 19635 | |12;stanford-crypto-pbkdf2;165;167;169;165;165;161;158;161;161;157 16:42:19 INFO - PROCESS | 19635 | |13;stanford-crypto-sha256-iterative;67;66;67;68;67;68;67;67;67;65 16:42:19 INFO - PROCESS | 19635 | __end_tp_report 16:42:19 INFO - PROCESS | 19635 | __start_cc_report 16:42:19 INFO - PROCESS | 19635 | _x_x_mozilla_cycle_collect,843 16:42:19 INFO - PROCESS | 19635 | __end_cc_report 16:42:19 INFO - PROCESS | 19635 | __startTimestamp1462232539198__endTimestamp 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | ------- Summary: start ------- 16:42:19 INFO - PROCESS | 19635 | Number of tests: 14 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:3.86 (3.5%) stddev-sans-first:4.09 16:42:19 INFO - PROCESS | 19635 | Values: 112.0 108.0 110.0 112.0 112.0 122.0 111.0 109.0 110.0 111.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:157.00 stddev:19.14 (12.2%) stddev-sans-first:20.11 16:42:19 INFO - PROCESS | 19635 | Values: 159.0 140.0 152.0 172.0 129.0 155.0 173.0 129.0 177.0 128.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:1.33 (0.8%) stddev-sans-first:1.20 16:42:19 INFO - PROCESS | 19635 | Values: 166.0 163.0 163.0 163.0 166.0 163.0 165.0 163.0 165.0 163.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.50 stddev:43.66 (57.8%) stddev-sans-first:45.88 16:42:19 INFO - PROCESS | 19635 | Values: 79.0 76.0 77.0 186.0 75.0 73.0 73.0 74.0 171.0 76.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.50 stddev:27.08 (29.3%) stddev-sans-first:27.97 16:42:19 INFO - PROCESS | 19635 | Values: 92.0 95.0 152.0 93.0 93.0 92.0 147.0 91.0 93.0 147.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 16:42:19 INFO - PROCESS | 19635 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 117.0 118.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:42:19 INFO - PROCESS | 19635 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:42:19 INFO - PROCESS | 19635 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 94.0 96.0 95.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:5.74 (10.1%) stddev-sans-first:6.00 16:42:19 INFO - PROCESS | 19635 | Values: 55.0 56.0 56.0 57.0 57.0 56.0 57.0 74.0 57.0 54.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:42:19 INFO - PROCESS | 19635 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:2.86 (3.8%) stddev-sans-first:3.02 16:42:19 INFO - PROCESS | 19635 | Values: 74.0 72.0 73.0 72.0 75.0 75.0 76.0 75.0 82.0 74.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:123.00 stddev:11.73 (9.5%) stddev-sans-first:12.40 16:42:19 INFO - PROCESS | 19635 | Values: 123.0 123.0 118.0 127.0 118.0 120.0 126.0 122.0 158.0 122.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:165.00 stddev:3.90 (2.4%) stddev-sans-first:4.06 16:42:19 INFO - PROCESS | 19635 | Values: 165.0 167.0 169.0 165.0 165.0 161.0 158.0 161.0 161.0 157.0 16:42:19 INFO - PROCESS | 19635 | 16:42:19 INFO - PROCESS | 19635 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 16:42:19 INFO - PROCESS | 19635 | Values: 67.0 66.0 67.0 68.0 67.0 68.0 67.0 67.0 67.0 65.0 16:42:19 INFO - PROCESS | 19635 | -------- Summary: end -------- 16:42:19 INFO - PROCESS | 19635 | 16:42:20 INFO - TEST-INFO | 19635: exit 0 16:42:20 INFO - TEST-OK | kraken | took 60829ms 16:42:20 INFO - SUITE-END | took 1170s 16:42:20 INFO - Completed test suite (00:19:30) 16:42:20 INFO - javascript benchmark 16:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.528685983962, 3396.813175275359, 3409.4374428219344, 3434.484827275908, 3441.5698037745265, 5576.665400075998, 5615.6069075164705, 5621.578381621374, 5625.493705566499, 5656.0, 5580.330360356763, 5586.329640443152, 5590.580706447023, 5618.185363122355, 5635.887282254353, 5034.219695947125, 5098.4136824265315, 5103.413107492649, 5106.387233531981, 5129.281900533928, 4999.200127979524, 5112.1564941784745, 5217.37391513019, 5228.790848366079, 5269.288646032794, 5100.744962751866, 5119.641625086246, 5164.096283150452, 5183.326167598226, 5202.453742357055, 5181.715005674687, 5198.662086964335, 5198.844034678947, 5207.062728708831, 5215.791368345262, 5052.520010598987, 5097.974510127426, 5154.30416893722, 5166.664166829144, 5184.533391994701, 5379.919301210485, 5410.702411367373, 5412.945870541323, 5454.809081682161, 5458.344998600193, 5940.227770389865, 5962.463378295931, 5985.700714964234, 5994.580379373446, 6005.129256257862, 5912.793052243193, 6070.21087258658, 6070.484008859252, 6085.208922840003, 6089.360617135181, 5645.266115405012, 5673.801416950387, 5687.317521897357, 5692.857678558028, 5735.827925162252, 6170.907436388457, 6179.474744646755, 6191.288001879751, 6192.195014648067, 6192.752289908353, 5814.186013958049, 5902.439268269508, 5948.434898684618, 5974.133750606138, 5982.222311099529, 6024.548158888101, 6042.607230530001, 6043.0, 6049.606775559662, 6084.209052823105, 5891.116332550066, 5949.940500595025, 5972.701364931823, 5993.310769261503, 6027.819165424957, 5906.3207731110615, 5928.170056192136, 5956.583039187215, 6030.427109424598, 6034.577579569475, 4588.2888152336445, 4597.655175861757, 4600.171969045537, 4604.907901841944, 4622.560856718606, 4102.261592913244, 4112.670986321087, 4123.731957422758, 4124.835006599762, 4151.27352713274, 5690.487856092972, 5709.743061562157, 5731.742071606787, 5774.162746401748, 5779.624324418899, 5942.910856337158, 5986.311574169026, 6078.240219972504, 6084.148219249309, 6087.908681369783, 5660.773569057274, 5667.659940403589, 5694.259746232963, 5699.914501282484, 5707.0583353747, 4820.084184005098, 4846.3699719037, 4938.925916111261, 4951.3810773653295, 4969.701817890938, 6169.5064394848305, 6182.227221597301, 6190.566660333733, 6237.752449510116, 6240.500759939194, 5993.6403815769445, 5999.430054144849, 6003.309619393651, 6013.609115407485, 6018.3680713524445, 6202.534809889186, 6290.811275661737, 6310.5267104968225, 6317.6209427434505, 6344.841378965562, 5941.67320797343, 5954.166416701579, 5970.731317090655, 5984.760609575568, 5985.730642121202, 5909.645421274738, 5983.162357270073, 5984.012637914695, 6053.909191362045, 6065.484433823174, 5860.765569377348, 5873.353931067493, 5904.0, 5904.734286957011, 5942.257217847769, 5834.533237340917, 5845.41545845412, 5852.619579727304, 5874.794382196603, 5880.353161152184, 5661.46216109469, 5774.422557744192, 5777.480026797609, 5793.507551857971, 5831.241938547962, 5938.109283607493, 5997.400259973968, 5997.430244126801, 6009.669468179292, 6014.248218972629, 5805.0, 5849.970750146222, 5866.208061911758, 5872.324682661549, 5872.794452194153], "value": 5551.434050975468, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.2719200555335, 668.8695704337655, 674.5885010143811, 675.7364627795159, 679.2731776998613, 32722.0, 38370.23259534811, 39426.408603870965, 39482.210355792864, 39531.209375812505, 41957.370639440436, 42672.35991460131, 42817.0, 42821.7858910705, 42923.570764292344, 8846.95576522118, 8994.28045756338, 9061.637534498612, 9078.455292682427, 9082.727518174466, 8772.780680482974, 8927.77680557988, 8929.821403571925, 8930.419522731034, 8942.0, 9172.174504294611, 9194.770130746718, 9246.76883077925, 9252.861207081865, 9285.721428357127, 9128.634854605807, 9178.265738740918, 9238.260939124853, 9241.676541321021, 9264.25885929124, 9095.363324567283, 9233.353665243436, 9253.259739220846, 9287.442753434749, 9289.16397524226, 42880.571194288284, 43269.91825204364, 43361.132777344596, 43362.566374336486, 43446.78276608628, 3749.418840079792, 3916.667083297923, 3995.1210733638845, 4019.7295908952615, 4027.013381721468, 32750.508742368882, 32831.50752738711, 32995.0, 33020.0, 33151.336973260644, 4011.578784227643, 4102.953746794578, 4168.541460439349, 4238.237117318881, 4306.267934451151, 293816.0, 295035.0, 298164.0, 299186.0, 299543.0, 63994.0, 64684.67657661682, 64962.0, 65097.67451162714, 65126.34873651298, 58297.54256143545, 58506.12240816391, 58719.0, 59146.408535914954, 67739.64520709559, 15338.846611533965, 15397.846021539865, 15424.922875385551, 15569.0, 15605.60985975337, 13102.606921792361, 13115.868841311465, 13132.080754347104, 13142.671433214246, 13190.47238110484, 20589.794102059088, 20892.895535522224, 20938.476538086365, 20967.0, 21038.78961210399, 7283.198848126702, 7399.0, 7563.810904727426, 7759.844803103906, 7775.1447340792465, 1127.2109523333536, 1150.1316506037888, 1153.9769204615861, 1188.7442954223857, 1205.7467931734259, 32472.0, 32688.509672354932, 33106.17234569155, 33494.157821319575, 33531.32937341288, 1154.9595764148214, 1194.2297218294325, 1241.900647948162, 1254.5546331052344, 1288.7486940046601, 17257.65484690299, 17442.302307907543, 17465.91267043682, 17533.21100550478, 17642.294308227785, 306739.0, 339563.0, 346629.0, 347398.0, 501401.0, 56098.0, 56893.0, 57248.42751572514, 57429.71285143548, 57649.71175144181, 1499.3327969053666, 1518.476125736619, 1538.4384699584796, 1541.9383224671112, 1544.1275679241194, 31663.20841978969, 32595.511067333533, 34436.0, 34457.310853782285, 34699.30601388009, 53498.73250633722, 53662.19506707325, 53963.190552140964, 54036.0, 54077.45922540881, 461392.0, 463820.0, 464336.0, 465594.0, 467387.0, 30258.54612180775, 40732.1853562933, 41731.53939612099, 41821.0, 42236.78881605695, 44077.77961110174, 45020.32469512895, 45410.31884521669, 45626.0, 47181.29228061513, 39866.80066599648, 40224.597754023256, 40592.594074058885, 41186.588134118276, 41777.37333940054, 39292.0, 39839.60160398359, 39972.600273998054, 40239.396409053305, 40949.97625059397, 41067.794661026506, 41764.58235417607, 41965.58034419739, 42215.155696886504, 42257.154856902074, 35180.29639407249, 35776.64223357837, 36271.27457450889, 36700.26599467942, 36753.26493470169, 28452.43095138127, 29006.7099329004, 29151.0, 29211.561826573045, 29433.411331773674], "value": 20505.08309119232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.8707613563659, 411.500027466628, 417.10739018500396, 422.25893556807836, 427.45712944560404, 18403.63192736146, 18948.999999999967, 19074.42776716699, 19077.332293369716, 19864.60270794587, 19161.61676766464, 19364.709529357035, 19929.302474413398, 19940.800591994113, 19976.300829470973, 5314.202869569557, 5587.832365029056, 5595.832125036235, 5598.1322894951345, 5858.238429004224, 5514.91727624086, 5517.668939863601, 5551.139573366115, 6607.174103237096, 6620.139381880349, 6460.321666225049, 6568.408843204134, 6575.473962083021, 6579.506537009719, 6582.3417658234275, 5620.0, 5774.451427114417, 5781.306243250795, 5788.739506722229, 6466.93533064668, 5443.591730620219, 5564.4991950724625, 5586.91619625706, 5603.187537807036, 5604.271444712162, 12407.317597532132, 12417.565385211565, 12512.124151309412, 12688.492460301577, 12771.744565108738, 2457.2259738182415, 2590.119359417788, 2612.1510509084433, 2613.9869300653377, 2917.2560996945854, 9787.804243915081, 9840.65557705484, 9908.10827025564, 10171.64399246023, 10237.795244095076, 2006.7993200679816, 2020.8282296004857, 2038.8266997305248, 2039.3576023552534, 2084.833213342929, 78534.0, 79147.60426197833, 81322.0, 82585.58707206485, 83663.5816820912, 10957.616483423042, 11198.0, 11390.829137562943, 11408.600698975495, 11536.25014374063, 15925.522234332988, 15983.200839957955, 16079.758803617955, 16088.436904708278, 16118.67762644764, 8204.343652507785, 8428.241458268785, 8460.788480288042, 8490.617922193516, 8500.957495212484, 7787.727429540052, 7955.443118981616, 7957.562334071682, 7982.640781164861, 7998.4001199910235, 4448.599626033672, 4459.063596644676, 4846.7818948147415, 4861.465238823726, 4937.950620493749, 1939.864209505321, 2002.67957126859, 2006.438197304757, 2047.4574237826987, 2138.957220855574, 1047.1151926532211, 1061.4215252687304, 1138.829175623663, 1142.5886680794906, 1158.5887010111458, 19327.936963467146, 19727.0, 19828.306009289605, 20293.49266268355, 20539.38381848547, 1018.4144117132678, 1112.1325366214367, 1112.3548341961643, 1144.5364627325946, 1160.8665003524702, 10649.840252396065, 10810.243282970274, 10950.616728414627, 10985.0, 11067.833982490269, 523003.0, 526031.0, 534396.0, 537301.0, 544201.0, 93171.53414233022, 96753.0, 97090.0, 97485.0, 101192.49403752934, 1136.5113001409472, 1154.2785758900686, 1160.1530882455686, 1161.3206274329443, 1171.5138217639756, 17142.828571714123, 17149.971001739934, 17273.39543115985, 17360.0, 17409.30362785525, 38671.0, 39002.60997390103, 39557.40663889986, 39637.405438917864, 40892.79553602332, 52755.47244527659, 53366.0, 54589.72705136449, 58216.4178358211, 59600.70199649147, 7468.5145465544565, 7708.075030996316, 7774.222577742181, 8053.35573154158, 8071.59642017885, 11202.21584489078, 11445.42772861337, 11564.710882228012, 12320.137590368588, 12332.445039973401, 10290.279680422298, 10863.945680271549, 11067.83398249043, 11218.943905280748, 11481.655550333504, 10689.732756681145, 10698.89301106979, 10805.135589152691, 11612.419379031184, 11686.590969316034, 10928.180386470887, 10931.344119352865, 11405.54377824911, 11454.770904582028, 11477.48351324209, 8183.83632327362, 8239.0, 8258.215469530625, 8472.898523191945, 8752.0, 8131.9593402032615, 10140.645077422254, 11126.221164518405, 11139.220254582102, 11332.206745527734], "value": 9188.03392266105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.3343045775084, 1564.8904576679631, 1731.896086234826, 1834.2846289946915, 1867.2064372641623, 7709.6916123354995, 7840.764777056683, 8071.717489887855, 8474.830503389936, 8489.702860399895, 7826.0, 7842.921570784305, 7861.8034549136155, 7954.602269886512, 7963.402744794134, 2247.6291411917055, 2264.535770167112, 2273.818094552432, 2275.590393729128, 2281.3954302109955, 2241.4396400899777, 2262.536180083079, 2271.0802125139344, 2273.0794028418436, 2281.783230593091, 2231.7656646052174, 2266.6260067088992, 2271.46620544172, 2300.3214051854743, 2302.102180149743, 2266.2294819761278, 2269.239804665439, 2277.840551161428, 2287.9084836606517, 2289.645105008726, 2253.7971582557648, 2268.7844654757773, 2273.181654604341, 2281.7718228177214, 2282.657601359793, 8117.269445749911, 8208.179182081803, 8210.630521626541, 8214.096449390563, 8219.54792486413, 5156.690598564098, 5330.653507521999, 5361.892762144775, 5362.65142765719, 5362.973185134049, 3264.461363874958, 3355.9664403355896, 3459.3600183965796, 3500.579930408367, 3522.559680039995, 1055.1558752997648, 1060.289605964006, 1081.8972197641212, 1100.5872797700863, 1100.6918062942389, 11754.64736057911, 11774.293542387484, 11793.94103029488, 11815.527378904833, 11841.822372664417, 4394.648428125743, 4480.395146655225, 4561.817527298937, 4574.016586433866, 4635.188841952645, 9946.20430365569, 9976.351537150207, 9984.700458986243, 9994.450305233282, 10026.047525485068, 5216.973915130476, 5325.547328477122, 5338.46615338463, 5339.279197308391, 5342.198670199501, 4287.164003019381, 4695.9530404695515, 4723.338732577442, 4802.27965805132, 4876.073546026244, 3961.9009524761536, 3982.303096958021, 4021.3766866135797, 4026.6174713402766, 4061.593840615974, 1240.1814802230485, 1250.9804509324872, 1252.7619752247044, 1254.084518301645, 1257.3336131850135, 1005.3967619428284, 1015.9586423915398, 1087.526925787285, 1111.4776055254017, 1117.5027112934665, 5764.394738552475, 5815.767369305265, 5932.169496270526, 5947.851303717442, 6046.093086037042, 1052.3002203534718, 1054.9578016879238, 1074.8441475985937, 1084.6800193942806, 1100.5432745410726, 4045.211183819127, 4057.188562287495, 4107.383892416162, 4184.623383895403, 4234.618884300427, 10307.793844123225, 10575.841362379571, 10643.94678026605, 10767.407792571485, 10842.132629389629, 10684.57261709523, 10782.892171078345, 10816.567337306577, 10846.891531084746, 10893.618723344645, 7632.885506717404, 8101.716439924574, 8126.390520710852, 8197.0, 8222.876656850272, 5800.709964501673, 5942.227510423617, 5997.4002599741425, 6046.123312119806, 6077.848053798691, 9824.263180261367, 9847.507624618596, 10043.949780251052, 10046.24653151002, 10053.447060411456, 9235.26117910579, 9641.807163856824, 9782.413055216424, 9833.01669833011, 9906.950465247628, 7033.296670332926, 7305.926940730525, 7388.298111679382, 7518.323350898446, 7699.230076992256, 8277.213664701843, 8279.337652987626, 8342.499450033018, 8347.582620869054, 8348.958255208685, 7378.704851805867, 7464.589447580435, 7631.771046868603, 7664.578448185403, 7688.8462230756195, 7487.737929172671, 7544.924550754422, 7566.31903128721, 7617.704990151577, 7684.6157692116285, 6739.123913891359, 6785.355391237825, 6796.286389928986, 6857.794266172023, 6859.759908403182, 5209.192575150858, 5323.840284791462, 5411.540019098421, 5497.257870187474, 5580.888382232251, 5437.456254374689, 5621.353544342453, 5667.659940403589, 5708.686022268815, 5923.585349025527], "value": 4608.943548747864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8623405701491, 315.0595472514544, 315.783688173601, 323.5874260318094, 327.06133397150177, 5786.305643322802, 5832.912506312404, 5866.181483740043, 5872.823815285548, 5895.528357731382, 5690.743916523756, 5707.857303567413, 5733.598648094635, 5738.454846789558, 5738.626989245696, 4156.334986402177, 4237.131388065439, 4359.760213188273, 4396.384506169139, 4404.823807047715, 4370.448490785773, 4373.103513779683, 4385.429894113777, 4387.29803231483, 4397.230484665187, 4362.607365337119, 4363.120340575221, 4365.083332500163, 4370.8033138508845, 4387.451568553931, 4261.680373971949, 4322.891927701801, 4351.26028575143, 4361.214981303364, 4383.123375324916, 3800.6959443244473, 3823.674987626055, 3831.6359945805384, 3850.09420336935, 3871.8838434847, 5568.387477377485, 5582.553395728372, 5586.932834851091, 5613.578981576398, 5640.110562961413, 4942.713288931181, 4981.327520784684, 5006.374203224597, 5036.841526448938, 5086.669366491166, 5956.7319470623925, 5961.152042866725, 5975.223220981288, 5977.0, 6034.456898879122, 4210.305299625558, 4217.578242175789, 4223.936640950388, 4238.554951730055, 4248.872533823959, 6048.576599638027, 6275.278342990523, 6325.620462772248, 6393.520485963525, 6408.296616011753, 4216.746995180299, 4266.978665106654, 4309.784510774449, 4318.417013703172, 4342.0, 4377.430933978562, 4379.0, 4382.956170438319, 4386.363977223285, 4404.229259879508, 4801.18379875422, 5051.292819005343, 5054.823081192214, 5077.949220507748, 5082.313887625123, 6126.590884096683, 6133.1413602095745, 6143.109249158847, 6200.0699895015205, 6211.3167551569295, 1589.2848218301579, 1602.5993501624594, 1607.7106120898118, 1612.7822743929419, 1620.440947872982, 989.1938070472542, 1039.8440233964966, 1046.9267151299337, 1051.5530899367739, 1066.935983840972, 6152.261728592597, 6170.352113028157, 6195.070739389038, 6223.37766223374, 6244.2819075805955, 6502.642354670444, 6576.473882089422, 6579.374959378852, 6615.503837212228, 6634.270230274666, 6135.693215339215, 6140.600860944024, 6142.617910969996, 6153.015787343135, 6171.413715697002, 3510.57873055235, 3540.1149712571855, 3549.538559987185, 3560.181158333598, 3563.9287214256087, 6749.19230404327, 6786.59280443175, 6835.897461538081, 6864.38220560152, 6882.8623427531165, 6727.663616819237, 6751.662416879137, 6769.8646027079185, 6795.558288711218, 6796.490263230277, 6670.39966403026, 6784.491163162783, 6854.149379667462, 6866.210385805596, 6866.862662746717, 6568.704408301543, 6593.0, 6607.108040414482, 6612.702428390638, 6658.234303055211, 6424.710888009958, 6502.057201705632, 6545.116409284686, 6585.275619681927, 6609.636469994197, 6828.9658551706925, 6834.521583489108, 6846.7945961621235, 6854.246032936273, 6860.5197636164985, 4569.725816451024, 4574.588287054181, 4580.748058856661, 4585.266357382803, 4601.677882548323, 6115.960286751352, 6303.684815759286, 6378.553501254868, 6379.681015949277, 6401.775937842153, 6142.757893368977, 6156.322804491592, 6164.167837342081, 6214.471769899428, 6236.469900058546, 5992.711567012939, 6100.572959892765, 6124.479419249414, 6155.969220153871, 6209.937900620936, 5931.703414829328, 6056.727447264796, 6079.939200608114, 6102.206713127265, 6111.266648002268, 6135.907961380493, 6158.846028849314, 6192.6995330981, 6213.37866213375, 6226.1905952225925, 5908.763649453974, 6007.146605362418, 6023.0, 6047.697615119315, 6057.151998720271], "value": 4675.1302396193405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.1562648285504, 858.8368210040092, 894.6779159502582, 895.1004240738057, 900.5137225898015, 13907.513237036706, 13939.860601393983, 14008.999999999987, 14017.08888922222, 14878.628034299134, 12347.0, 14329.570112896603, 14380.0, 14384.208868512227, 14388.424463021493, 844.4511067805914, 876.2726936642604, 877.2324216310728, 880.3881302494736, 883.5802993578063, 887.5872719185577, 888.6534251641865, 893.1202765276198, 896.995515022424, 897.9865302020474, 918.8070505193917, 921.5852866210199, 924.533110779059, 928.9163975242227, 930.2186163622556, 913.8811954445913, 917.3165991336464, 917.5504003038529, 919.1957037592107, 921.3596550397476, 675.166169780321, 676.1413005483058, 676.7157793726598, 678.3453966921944, 678.9287124851918, 14596.343164557515, 14728.337224824802, 14770.852291477055, 14838.406463741438, 14945.327460264314, 13732.519361822287, 14019.789703154462, 14236.288185590782, 14488.492902748354, 14587.489028963544, 11263.43682815856, 11301.773964520746, 11414.771704565945, 11478.483468243949, 11555.711107222303, 4004.739691920016, 4047.9595204048173, 4060.1879624075304, 4132.628063474272, 4163.7293575917465, 55307.44692553063, 55586.16620750692, 55779.442205577834, 55960.440395596335, 57142.42857571454, 11237.550497980154, 11361.171502111734, 11409.42952852354, 11485.540578376938, 11579.0, 20037.799622003884, 20081.29715459981, 20088.0, 20100.296489623084, 20101.29645462431, 8504.914950850536, 8547.487150770974, 8614.267787238156, 8678.262347700389, 8703.434276772115, 4919.434265059564, 4937.308776771255, 4996.975015124974, 5034.270030845507, 5113.284140220372, 3309.7848639838335, 3400.7619466637098, 3403.030136411111, 3416.982915085409, 3425.2293234022145, 548.297759252523, 595.9463648271676, 604.4227762486814, 606.2694453183902, 606.9575129740964, 691.5574032619128, 696.022088965005, 728.8287252495659, 776.3090849144266, 777.3975169243769, 9618.807623847484, 9799.16707079892, 9819.459929703791, 10216.284860059724, 10400.843987340197, 716.1370548489058, 774.4607145345716, 782.3936449251762, 810.7932477218271, 816.8652172391608, 4673.439187297546, 4920.680155789933, 4922.064807686528, 4929.186684197068, 4945.381827271591, 66439.33560664428, 68080.6595967017, 68983.3101668987, 70643.29356706367, 71265.2873471269, 59330.703346482995, 60438.0, 60904.695476522335, 60958.695206523684, 61898.69050654808, 54837.451625483234, 55101.72449137729, 55106.72446637821, 55819.441805581424, 55977.72011139918, 9295.349325547148, 9384.296177786557, 9386.530673466163, 9458.810823783624, 9599.800523625483, 33453.49819752657, 34735.82632086823, 35167.12082197965, 35342.0, 35905.64094359023, 42749.35875961801, 44841.10317793691, 47836.760816195696, 47849.28226076542, 47931.28103078526, 12001.819972700241, 12136.75726485483, 12159.756804863677, 12189.634310970685, 12517.123801333819, 12763.744725105631, 12869.613911582668, 12890.419931102935, 12966.675833104247, 13105.737885242432, 11650.533978641099, 11756.70608234801, 12304.385721643188, 12414.131010829517, 12586.496540138292, 12635.94819500707, 12675.112742108333, 12703.618891433272, 12717.258994672293, 13428.530001449903, 11541.538338466704, 13582.185068895898, 13733.176009439465, 13862.722745545234, 13887.513937012156, 11320.150988676047, 11348.943255283672, 11541.126102103699, 11676.94161529187, 11747.647570572897, 11279.718007049889, 11497.310161390344, 11572.59495917639, 11648.242864213798, 11734.354610496504], "value": 7061.158058154796, "unit": "score"}], "name": "dromaeo_css", "value": 7361.510648945922, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 110.0, 112.0, 112.0, 122.0, 111.0, 109.0, 110.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 140.0, 152.0, 172.0, 129.0, 155.0, 173.0, 129.0, 177.0, 128.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 163.0, 166.0, 163.0, 165.0, 163.0, 165.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 186.0, 75.0, 73.0, 73.0, 74.0, 171.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 152.0, 93.0, 93.0, 92.0, 147.0, 91.0, 93.0, 147.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 57.0, 57.0, 56.0, 57.0, 74.0, 57.0, 54.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 72.0, 75.0, 75.0, 76.0, 75.0, 82.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 118.0, 127.0, 118.0, 120.0, 126.0, 122.0, 158.0, 122.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 169.0, 165.0, 165.0, 161.0, 158.0, 161.0, 161.0, 157.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1540.3000000000002, "alertThreshold": 2.0}]} 16:42:20 INFO - Return code: 0 16:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:42:20 ERROR - # TBPL SUCCESS # 16:42:20 INFO - Running post-action listener: _resource_record_post_action 16:42:20 INFO - Running post-run listener: _resource_record_post_run 16:42:21 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 322519040; Read time: 32; Write time: 211796 16:42:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78049280; Read time: 0; Write time: 64180 16:42:21 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 244469760; Read time: 32; Write time: 147616 16:42:21 INFO - Running post-run listener: _upload_blobber_files 16:42:21 INFO - Blob upload gear active. 16:42:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:21 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:21 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:21 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:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:42:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:22 INFO - (blobuploader) - INFO - Done attempting. 16:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:23 INFO - (blobuploader) - INFO - Done attempting. 16:42:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:23 INFO - Return code: 0 16:42:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da6241730879af75522ef7b47de680e63fd10ab9810be129ee0c9b41a0a11169de9d509e0fede397e17e497a1e7a56ad19ffe4afb8da4df0bc15b4b2b8ae4170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d2e5884ea9644ffd86bfa2e8392e9bd1692d3e88a5434d8dd16959ce6c451814e31a0691b4d4475e2fcce28a4f2782fe2b8a227339f1e66d93f5f5b322752f7"} 16:42:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:23 INFO - Contents: 16:42:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da6241730879af75522ef7b47de680e63fd10ab9810be129ee0c9b41a0a11169de9d509e0fede397e17e497a1e7a56ad19ffe4afb8da4df0bc15b4b2b8ae4170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d2e5884ea9644ffd86bfa2e8392e9bd1692d3e88a5434d8dd16959ce6c451814e31a0691b4d4475e2fcce28a4f2782fe2b8a227339f1e66d93f5f5b322752f7"} 16:42:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:23 INFO - Copying logs to upload dir... 16:42:23 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2126.641290 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 26 secs) (at 2016-05-02 16:42:21.199595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:21.205075) ========= 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=523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da6241730879af75522ef7b47de680e63fd10ab9810be129ee0c9b41a0a11169de9d509e0fede397e17e497a1e7a56ad19ffe4afb8da4df0bc15b4b2b8ae4170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d2e5884ea9644ffd86bfa2e8392e9bd1692d3e88a5434d8dd16959ce6c451814e31a0691b4d4475e2fcce28a4f2782fe2b8a227339f1e66d93f5f5b322752f7"} 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.011247 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da6241730879af75522ef7b47de680e63fd10ab9810be129ee0c9b41a0a11169de9d509e0fede397e17e497a1e7a56ad19ffe4afb8da4df0bc15b4b2b8ae4170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d2e5884ea9644ffd86bfa2e8392e9bd1692d3e88a5434d8dd16959ce6c451814e31a0691b4d4475e2fcce28a4f2782fe2b8a227339f1e66d93f5f5b322752f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:21.228962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:21.229254) ========= 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=523ca41ca1e0623de333ad52000001bf-1462230415.37665-566390373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 16:42:21.312285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-02 16:42:21.312588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-02 16:42:21.312885) ========= ========= Total master_lag: 0.14 =========