builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0073 starttime: 1461844255.63 results: success (0) buildid: 20160428035553 builduid: b2f73bc3cb5243808f5c88c962d930ab revision: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.628177) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.628595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.628868) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.646456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.646719) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-28 04:50:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 152M=0s 2016-04-28 04:50:55 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143293 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.806683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.806996) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019963 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:55.855976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 04:50:55.856386) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-28 04:50:55,932 truncating revision to first 12 chars 2016-04-28 04:50:55,932 Setting DEBUG logging. 2016-04-28 04:50:55,932 attempt 1/10 2016-04-28 04:50:55,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03eac758d8d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 04:50:57,039 unpacking tar archive at: fx-team-03eac758d8d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 04:50:57.218522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:57.218850) ========= script_repo_revision: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:57.219241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:57.219509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:50:57.232862) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-04-28 04:50:57.233131) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:50:57 INFO - MultiFileLogger online at 20160428 04:50:57 in /builds/slave/test 04:50:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:50:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:57 INFO - {'append_to_log': False, 04:50:57 INFO - 'base_work_dir': '/builds/slave/test', 04:50:57 INFO - 'blob_upload_branch': 'Fx-Team', 04:50:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:57 INFO - 'branch': 'Fx-Team', 04:50:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:57 INFO - 'config_files': ('talos/mac_config.py',), 04:50:57 INFO - 'default_actions': ('clobber', 04:50:57 INFO - 'read-buildbot-config', 04:50:57 INFO - 'download-and-extract', 04:50:57 INFO - 'populate-webroot', 04:50:57 INFO - 'create-virtualenv', 04:50:57 INFO - 'install', 04:50:57 INFO - 'run-tests'), 04:50:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:57 INFO - 'download_minidump_stackwalk': True, 04:50:57 INFO - 'download_symbols': 'ondemand', 04:50:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:57 INFO - 'installer_path': 'installer.exe', 04:50:57 INFO - 'log_level': 'info', 04:50:57 INFO - 'log_name': 'talos', 04:50:57 INFO - 'log_to_console': True, 04:50:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:50:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:50:57 INFO - 'opt_config_files': (), 04:50:57 INFO - 'pip_index': False, 04:50:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:57 INFO - 'cmd': ('bash', 04:50:57 INFO - '-c', 04:50:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:57 INFO - 'enabled': True, 04:50:57 INFO - 'halt_on_failure': False, 04:50:57 INFO - 'name': 'check_screen_resolution'},), 04:50:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:57 INFO - 'cmd': ('bash', 04:50:57 INFO - '-c', 04:50:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:57 INFO - 'enabled': True, 04:50:57 INFO - 'halt_on_failure': False, 04:50:57 INFO - 'name': 'check_screen_resolution'},), 04:50:57 INFO - 'run_cmd_checks_enabled': True, 04:50:57 INFO - 'sps_profile': False, 04:50:57 INFO - 'sps_profile_interval': 0, 04:50:57 INFO - 'suite': 'dromaeojs', 04:50:57 INFO - 'system_bits': '32', 04:50:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:57 INFO - 'title': 't-yosemite-r7-0073', 04:50:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:57 INFO - 'use_talos_json': True, 04:50:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:57 INFO - 'work_dir': 'build'} 04:50:57 INFO - ##### 04:50:57 INFO - ##### Running clobber step. 04:50:57 INFO - ##### 04:50:57 INFO - Running pre-action listener: _resource_record_pre_action 04:50:57 INFO - Running main action method: clobber 04:50:57 INFO - rmtree: /builds/slave/test/build 04:50:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:58 INFO - Running post-action listener: _resource_record_post_action 04:50:58 INFO - ##### 04:50:58 INFO - ##### Running read-buildbot-config step. 04:50:58 INFO - ##### 04:50:58 INFO - Running pre-action listener: _resource_record_pre_action 04:50:58 INFO - Running main action method: read_buildbot_config 04:50:58 INFO - Using buildbot properties: 04:50:58 INFO - { 04:50:58 INFO - "project": "", 04:50:58 INFO - "product": "firefox", 04:50:58 INFO - "script_repo_revision": "production", 04:50:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:50:58 INFO - "repository": "", 04:50:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:50:58 INFO - "buildid": "20160428035553", 04:50:58 INFO - "pgo_build": "False", 04:50:58 INFO - "basedir": "/builds/slave/test", 04:50:58 INFO - "buildnumber": 742, 04:50:58 INFO - "slavename": "t-yosemite-r7-0073", 04:50:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:50:58 INFO - "platform": "yosemite_r7", 04:50:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:50:58 INFO - "branch": "fx-team", 04:50:58 INFO - "repo_path": "integration/fx-team", 04:50:58 INFO - "revision": "03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e", 04:50:58 INFO - "stage_platform": "macosx64", 04:50:58 INFO - "builduid": "b2f73bc3cb5243808f5c88c962d930ab", 04:50:58 INFO - "slavebuilddir": "test" 04:50:58 INFO - } 04:50:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 04:50:58 INFO - Running post-action listener: _resource_record_post_action 04:50:58 INFO - ##### 04:50:58 INFO - ##### Running download-and-extract step. 04:50:58 INFO - ##### 04:50:58 INFO - Running pre-action listener: _resource_record_pre_action 04:50:58 INFO - Running main action method: download_and_extract 04:50:58 INFO - mkdir: /builds/slave/test/build/tests 04:50: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')]} 04:50:58 INFO - https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 04:51:00 INFO - Downloaded 1199 bytes. 04:51:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:51:00 INFO - Using the following test package requirements: 04:51:00 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:51:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 04:51:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 04:51:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'jsshell-mac.zip'], 04:51:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 04:51:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:51:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 04:51:00 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 04:51:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 04:51:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:51:00 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 04:51:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:00 INFO - https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:51:01 INFO - Downloaded 18116496 bytes. 04:51:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:51:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:51:04 INFO - Return code: 0 04:51:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:04 INFO - https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:51:05 INFO - Downloaded 18116496 bytes. 04:51:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:51:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:51:09 INFO - Return code: 0 04:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:09 INFO - https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:51:10 INFO - Downloaded 10840145 bytes. 04:51:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:51:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:51:10 INFO - Return code: 0 04:51: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')]} 04:51:10 INFO - https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 04:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 04:51:13 INFO - Downloaded 110192628 bytes. 04:51:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:51:13 INFO - mkdir: /builds/slave/test/properties 04:51:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:13 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:13 INFO - Contents: 04:51:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:51:14 INFO - Running post-action listener: _resource_record_post_action 04:51:14 INFO - Running post-action listener: set_extra_try_arguments 04:51:14 INFO - ##### 04:51:14 INFO - ##### Running populate-webroot step. 04:51:14 INFO - ##### 04:51:14 INFO - Running pre-action listener: _resource_record_pre_action 04:51:14 INFO - Running main action method: populate_webroot 04:51:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:14 INFO - '--tppagecycles', 04:51:14 INFO - '7'], 04:51:14 INFO - 'tests': ['tsvgm']}}, 04:51:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:51:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:51:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:51:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['damp', 'tps']}, 04:51:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'tests': ['damp', 'tps']}, 04:51:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['dromaeo_dom']}, 04:51:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['a11yr', 04:51:14 INFO - 'ts_paint', 04:51:14 INFO - 'tpaint', 04:51:14 INFO - 'sessionrestore', 04:51:14 INFO - 'sessionrestore_no_auto_restore', 04:51:14 INFO - 'tabpaint']}, 04:51:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:51:14 INFO - 'ts_paint', 04:51:14 INFO - 'tpaint', 04:51:14 INFO - 'sessionrestore', 04:51:14 INFO - 'sessionrestore_no_auto_restore', 04:51:14 INFO - 'tabpaint']}, 04:51:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:51:14 INFO - 'ts_paint', 04:51:14 INFO - 'tpaint', 04:51:14 INFO - 'sessionrestore', 04:51:14 INFO - 'sessionrestore_no_auto_restore', 04:51:14 INFO - 'tabpaint']}, 04:51:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:51:14 INFO - 'ts_paint', 04:51:14 INFO - 'tpaint', 04:51:14 INFO - 'sessionrestore', 04:51:14 INFO - 'sessionrestore_no_auto_restore', 04:51:14 INFO - 'tabpaint']}, 04:51:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['a11yr', 04:51:14 INFO - 'ts_paint', 04:51:14 INFO - 'tpaint', 04:51:14 INFO - 'sessionrestore', 04:51:14 INFO - 'sessionrestore_no_auto_restore', 04:51:14 INFO - 'tabpaint']}, 04:51:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['a11yr', 04:51:14 INFO - 'ts_paint', 04:51:14 INFO - 'tpaint', 04:51:14 INFO - 'sessionrestore', 04:51:14 INFO - 'sessionrestore_no_auto_restore', 04:51:14 INFO - 'tabpaint']}, 04:51:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['tsvgx', 04:51:14 INFO - 'tsvgr_opacity', 04:51:14 INFO - 'tart', 04:51:14 INFO - 'tscrollx', 04:51:14 INFO - 'cart']}, 04:51:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:51:14 INFO - 'tsvgr_opacity', 04:51:14 INFO - 'tart', 04:51:14 INFO - 'tscrollx', 04:51:14 INFO - 'cart']}, 04:51:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'talos_options': ['--disable-e10s'], 04:51:14 INFO - 'tests': ['tp5o']}, 04:51:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'tests': ['tp5o']}, 04:51:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'talos_options': ['--disable-e10s', 04:51:14 INFO - '--xperf_path', 04:51:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:14 INFO - 'tests': ['tp5n']}, 04:51:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:14 INFO - 'talos_options': ['--xperf_path', 04:51:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:14 INFO - 'tests': ['tp5n']}}, 04:51:14 INFO - 'talos.zip': {'path': '', 04:51:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:14 INFO - Running post-action listener: _resource_record_post_action 04:51:14 INFO - ##### 04:51:14 INFO - ##### Running create-virtualenv step. 04:51:14 INFO - ##### 04:51:14 INFO - Running pre-action listener: _resource_record_pre_action 04:51:14 INFO - Running main action method: create_virtualenv 04:51:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:51:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:14 INFO - Using real prefix '/tools/python27' 04:51:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:15 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:18 INFO - Installing pip.................done. 04:51:18 INFO - Return code: 0 04:51:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:18 INFO - 'HOME': '/Users/cltbld', 04:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:18 INFO - 'LOGNAME': 'cltbld', 04:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:18 INFO - 'MOZ_NO_REMOTE': '1', 04:51:18 INFO - 'NO_EM_RESTART': '1', 04:51:18 INFO - 'PAGER': '/bin/cat', 04:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:18 INFO - 'PWD': '/builds/slave/test', 04:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:18 INFO - 'SHELL': '/bin/bash', 04:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:18 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:18 INFO - 'USER': 'cltbld', 04:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:18 INFO - 'XPC_FLAGS': '0x0', 04:51:18 INFO - 'XPC_SERVICE_NAME': '0', 04:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:51:18 INFO - Cleaning up... 04:51:19 INFO - Return code: 0 04:51:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:19 INFO - 'HOME': '/Users/cltbld', 04:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:19 INFO - 'LOGNAME': 'cltbld', 04:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:19 INFO - 'MOZ_NO_REMOTE': '1', 04:51:19 INFO - 'NO_EM_RESTART': '1', 04:51:19 INFO - 'PAGER': '/bin/cat', 04:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:19 INFO - 'PWD': '/builds/slave/test', 04:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:19 INFO - 'SHELL': '/bin/bash', 04:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:19 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:19 INFO - 'USER': 'cltbld', 04:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:19 INFO - 'XPC_FLAGS': '0x0', 04:51:19 INFO - 'XPC_SERVICE_NAME': '0', 04:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:19 INFO - Downloading/unpacking psutil>=0.7.1 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:21 INFO - Installing collected packages: psutil 04:51:21 INFO - Running setup.py install for psutil 04:51:21 INFO - building 'psutil._psutil_osx' extension 04:51:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:51:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:51:22 INFO - building 'psutil._psutil_posix' extension 04:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:51:22 INFO - ^ 04:51:22 INFO - 1 warning generated. 04:51:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:22 INFO - Successfully installed psutil 04:51:22 INFO - Cleaning up... 04:51:22 INFO - Return code: 0 04:51:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:22 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 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:22 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 04:51:22 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 04:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:22 INFO - 'HOME': '/Users/cltbld', 04:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:22 INFO - 'LOGNAME': 'cltbld', 04:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:22 INFO - 'MOZ_NO_REMOTE': '1', 04:51:22 INFO - 'NO_EM_RESTART': '1', 04:51:22 INFO - 'PAGER': '/bin/cat', 04:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:22 INFO - 'PWD': '/builds/slave/test', 04:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:22 INFO - 'SHELL': '/bin/bash', 04:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:22 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:22 INFO - 'USER': 'cltbld', 04:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:22 INFO - 'XPC_FLAGS': '0x0', 04:51:22 INFO - 'XPC_SERVICE_NAME': '0', 04:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:51:25 INFO - Installing collected packages: mozsystemmonitor 04:51:25 INFO - Running setup.py install for mozsystemmonitor 04:51:25 INFO - Successfully installed mozsystemmonitor 04:51:25 INFO - Cleaning up... 04:51:25 INFO - Return code: 0 04:51:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:25 INFO - 'HOME': '/Users/cltbld', 04:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:25 INFO - 'LOGNAME': 'cltbld', 04:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:25 INFO - 'MOZ_NO_REMOTE': '1', 04:51:25 INFO - 'NO_EM_RESTART': '1', 04:51:25 INFO - 'PAGER': '/bin/cat', 04:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:25 INFO - 'PWD': '/builds/slave/test', 04:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:25 INFO - 'SHELL': '/bin/bash', 04:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:25 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:25 INFO - 'USER': 'cltbld', 04:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:25 INFO - 'XPC_FLAGS': '0x0', 04:51:25 INFO - 'XPC_SERVICE_NAME': '0', 04:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:29 INFO - Downloading docopt-0.6.1.tar.gz 04:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:29 INFO - Running setup.py install for blobuploader 04:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:29 INFO - Running setup.py install for requests 04:51:30 INFO - Running setup.py install for docopt 04:51:30 INFO - Successfully installed blobuploader requests docopt 04:51:30 INFO - Cleaning up... 04:51:30 INFO - Return code: 0 04:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:30 INFO - 'HOME': '/Users/cltbld', 04:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:30 INFO - 'LOGNAME': 'cltbld', 04:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:30 INFO - 'MOZ_NO_REMOTE': '1', 04:51:30 INFO - 'NO_EM_RESTART': '1', 04:51:30 INFO - 'PAGER': '/bin/cat', 04:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:30 INFO - 'PWD': '/builds/slave/test', 04:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:30 INFO - 'SHELL': '/bin/bash', 04:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:30 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:30 INFO - 'USER': 'cltbld', 04:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:30 INFO - 'XPC_FLAGS': '0x0', 04:51:30 INFO - 'XPC_SERVICE_NAME': '0', 04:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-N8xIic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-GzRsGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-xDZFEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-bLh9b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-N2PADj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-zyaJHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-TSUdP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Csneqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-f8qNvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-sI5hiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ArGFoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0iVM9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-S_H6lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-PwgTxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-G4R1Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-usyBP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-1ex4vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:32 INFO - Running setup.py install for manifestparser 04:51:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:32 INFO - Running setup.py install for mozcrash 04:51:32 INFO - Running setup.py install for mozdebug 04:51:32 INFO - Running setup.py install for mozdevice 04:51:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Running setup.py install for mozfile 04:51:33 INFO - Running setup.py install for mozhttpd 04:51:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Running setup.py install for mozinfo 04:51:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Running setup.py install for mozInstall 04:51:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:51:33 INFO - Running setup.py install for mozleak 04:51:33 INFO - Running setup.py install for mozlog 04:51:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:51:34 INFO - Running setup.py install for moznetwork 04:51:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:51:34 INFO - Running setup.py install for mozprocess 04:51:34 INFO - Running setup.py install for mozprofile 04:51:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:51:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:51:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:51:34 INFO - Running setup.py install for mozrunner 04:51:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:51:34 INFO - Running setup.py install for mozscreenshot 04:51:34 INFO - Running setup.py install for moztest 04:51:34 INFO - Running setup.py install for mozversion 04:51:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:51:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:51:35 INFO - Cleaning up... 04:51:35 INFO - Return code: 0 04:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:35 INFO - 'HOME': '/Users/cltbld', 04:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:35 INFO - 'LOGNAME': 'cltbld', 04:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:35 INFO - 'MOZ_NO_REMOTE': '1', 04:51:35 INFO - 'NO_EM_RESTART': '1', 04:51:35 INFO - 'PAGER': '/bin/cat', 04:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:35 INFO - 'PWD': '/builds/slave/test', 04:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:35 INFO - 'SHELL': '/bin/bash', 04:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:35 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:35 INFO - 'USER': 'cltbld', 04:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:35 INFO - 'XPC_FLAGS': '0x0', 04:51:35 INFO - 'XPC_SERVICE_NAME': '0', 04:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ITnIyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-qLPL48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-dQaw4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pyDnhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-JbGpqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9Wvp61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-toeIPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ukPZFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-JJRTia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-8IkaMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:36 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)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MiH3Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0M7ACr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:36 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)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-HmOkY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Ntt6e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:36 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)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MjCnTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-K2IhWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-kfvZQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:39 INFO - Downloading blessings-1.6.tar.gz 04:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:51:39 INFO - Installing collected packages: blessings 04:51:39 INFO - Running setup.py install for blessings 04:51:39 INFO - Successfully installed blessings 04:51:39 INFO - Cleaning up... 04:51:39 INFO - Return code: 0 04:51:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:40 INFO - Reading from file tmpfile_stdout 04:51:40 INFO - Current package versions: 04:51:40 INFO - blessings == 1.6 04:51:40 INFO - blobuploader == 1.2.4 04:51:40 INFO - docopt == 0.6.1 04:51:40 INFO - manifestparser == 1.1 04:51:40 INFO - mozInstall == 1.12 04:51:40 INFO - mozcrash == 0.17 04:51:40 INFO - mozdebug == 0.1 04:51:40 INFO - mozdevice == 0.48 04:51:40 INFO - mozfile == 1.2 04:51:40 INFO - mozhttpd == 0.7 04:51:40 INFO - mozinfo == 0.9 04:51:40 INFO - mozleak == 0.1 04:51:40 INFO - mozlog == 3.1 04:51:40 INFO - moznetwork == 0.27 04:51:40 INFO - mozprocess == 0.22 04:51:40 INFO - mozprofile == 0.28 04:51:40 INFO - mozrunner == 6.11 04:51:40 INFO - mozscreenshot == 0.1 04:51:40 INFO - mozsystemmonitor == 0.0 04:51:40 INFO - moztest == 0.7 04:51:40 INFO - mozversion == 1.4 04:51:40 INFO - psutil == 3.1.1 04:51:40 INFO - requests == 1.2.3 04:51:40 INFO - wsgiref == 0.1.2 04:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:40 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 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:40 INFO - 'HOME': '/Users/cltbld', 04:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:40 INFO - 'LOGNAME': 'cltbld', 04:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:40 INFO - 'MOZ_NO_REMOTE': '1', 04:51:40 INFO - 'NO_EM_RESTART': '1', 04:51:40 INFO - 'PAGER': '/bin/cat', 04:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:40 INFO - 'PWD': '/builds/slave/test', 04:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:40 INFO - 'SHELL': '/bin/bash', 04:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:40 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:40 INFO - 'USER': 'cltbld', 04:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:40 INFO - 'XPC_FLAGS': '0x0', 04:51:40 INFO - 'XPC_SERVICE_NAME': '0', 04:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:51:40 INFO - Cleaning up... 04:51:40 INFO - Return code: 0 04:51:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:40 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 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:40 INFO - 'HOME': '/Users/cltbld', 04:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:40 INFO - 'LOGNAME': 'cltbld', 04:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:40 INFO - 'MOZ_NO_REMOTE': '1', 04:51:40 INFO - 'NO_EM_RESTART': '1', 04:51:40 INFO - 'PAGER': '/bin/cat', 04:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:40 INFO - 'PWD': '/builds/slave/test', 04:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:40 INFO - 'SHELL': '/bin/bash', 04:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:40 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:40 INFO - 'USER': 'cltbld', 04:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:40 INFO - 'XPC_FLAGS': '0x0', 04:51:40 INFO - 'XPC_SERVICE_NAME': '0', 04:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:40 INFO - Downloading/unpacking jsonschema 04:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:51:44 INFO - Downloading/unpacking functools32 (from jsonschema) 04:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:51:44 INFO - warning: no files found matching '*.txt' 04:51:44 INFO - no previously-included directories found matching 'build' 04:51:44 INFO - no previously-included directories found matching 'dist' 04:51:44 INFO - no previously-included directories found matching '.git*' 04:51:44 INFO - Installing collected packages: jsonschema, functools32 04:51:44 INFO - Running setup.py install for functools32 04:51:44 INFO - warning: no files found matching '*.txt' 04:51:44 INFO - no previously-included directories found matching 'build' 04:51:44 INFO - no previously-included directories found matching 'dist' 04:51:44 INFO - no previously-included directories found matching '.git*' 04:51:44 INFO - Successfully installed jsonschema functools32 04:51:44 INFO - Cleaning up... 04:51:44 INFO - Return code: 0 04:51:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:44 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 0x1094c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b8c92670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:51:44 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 04:51:44 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 04:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:44 INFO - 'HOME': '/Users/cltbld', 04:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:44 INFO - 'LOGNAME': 'cltbld', 04:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:44 INFO - 'MOZ_NO_REMOTE': '1', 04:51:44 INFO - 'NO_EM_RESTART': '1', 04:51:44 INFO - 'PAGER': '/bin/cat', 04:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:44 INFO - 'PWD': '/builds/slave/test', 04:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:44 INFO - 'SHELL': '/bin/bash', 04:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:51:44 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:44 INFO - 'USER': 'cltbld', 04:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:44 INFO - 'XPC_FLAGS': '0x0', 04:51:44 INFO - 'XPC_SERVICE_NAME': '0', 04:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:45 INFO - Downloading/unpacking flake8 04:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:51:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:51:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:51:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:51:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:51:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:51:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:51:48 INFO - no previously-included directories found matching 'docs/_build' 04:51:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:51:48 INFO - Running setup.py install for pep8 04:51:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:51:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:51:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:51:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:51:49 INFO - no previously-included directories found matching 'docs/_build' 04:51:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:51:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:51:49 INFO - Cleaning up... 04:51:49 INFO - Return code: 0 04:51:49 INFO - Running post-action listener: _resource_record_post_action 04:51:49 INFO - Running post-action listener: _start_resource_monitoring 04:51:49 INFO - Starting resource monitoring. 04:51:49 INFO - ##### 04:51:49 INFO - ##### Running install step. 04:51:49 INFO - ##### 04:51:49 INFO - Running pre-action listener: _resource_record_pre_action 04:51:49 INFO - Running main action method: install 04:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:49 INFO - Reading from file tmpfile_stdout 04:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:49 INFO - Reading from file tmpfile_stdout 04:51:49 INFO - Output received: 04:51:49 INFO - Usage: mozinstall [options] installer 04:51:49 INFO - Options: 04:51:49 INFO - -h, --help show this help message and exit 04:51:49 INFO - -d DEST, --destination=DEST 04:51:49 INFO - Directory to install application into. [default: 04:51:49 INFO - "/builds/slave/test"] 04:51:49 INFO - --app=APP Application being installed. [default: firefox] 04:51:49 INFO - mkdir: /builds/slave/test/build/application 04:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:52:24 INFO - Reading from file tmpfile_stdout 04:52:24 INFO - Output received: 04:52:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:52:24 INFO - Running post-action listener: _resource_record_post_action 04:52:24 INFO - ##### 04:52:24 INFO - ##### Running run-tests step. 04:52:24 INFO - ##### 04:52:24 INFO - Running pre-action listener: _resource_record_pre_action 04:52:24 INFO - Running main action method: run_tests 04:52:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:24 INFO - 2016-04-28 04:52:24.068 screenresolution[1917:16169] starting screenresolution argv=screenresolution get 04:52:24 INFO - 2016-04-28 04:52:24.071 screenresolution[1917:16169] Display 0: 1600x1200x32@60 04:52:24 INFO - 2016-04-28 04:52:24.077 screenresolution[1918:16173] starting screenresolution argv=screenresolution list 04:52:24 INFO - Available Modes on Display 0 04:52:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:24 INFO - Intel Iris: 04:52:24 INFO - Chipset Model: Intel Iris 04:52:24 INFO - Type: GPU 04:52:24 INFO - Bus: Built-In 04:52:24 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:24 INFO - Vendor: Intel (0x8086) 04:52:24 INFO - Device ID: 0x0a2e 04:52:24 INFO - Revision ID: 0x0009 04:52:24 INFO - Displays: 04:52:24 INFO - Display: 04:52:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:24 INFO - Display Serial Number: 1600x1200 60 04:52:24 INFO - Main Display: Yes 04:52:24 INFO - Mirror: Off 04:52:24 INFO - Online: Yes 04:52:24 INFO - Rotation: Supported 04:52:24 INFO - Return code: 0 04:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:24 INFO - Python 2.7.3 04:52:24 INFO - Return code: 0 04:52:24 INFO - grabbing minidump binary from tooltool 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:24 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368e00>, '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 0x109191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109363b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:24 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:52:24 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:52:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:24 INFO - Return code: 0 04:52:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:52:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:52:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:52:25 INFO - Return code: 0 04:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render', 04:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:25 INFO - 'HOME': '/Users/cltbld', 04:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:25 INFO - 'LOGNAME': 'cltbld', 04:52:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:25 INFO - 'MOZ_NO_REMOTE': '1', 04:52:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:25 INFO - 'NO_EM_RESTART': '1', 04:52:25 INFO - 'PAGER': '/bin/cat', 04:52:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:25 INFO - 'PWD': '/builds/slave/test', 04:52:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:25 INFO - 'SHELL': '/bin/bash', 04:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners', 04:52:25 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:25 INFO - 'USER': 'cltbld', 04:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:25 INFO - 'XPC_FLAGS': '0x0', 04:52:25 INFO - 'XPC_SERVICE_NAME': '0', 04:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:52:25 INFO - mozversion application_buildid: 20160428035553 04:52:25 INFO - mozversion application_changeset: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e 04:52:25 INFO - mozversion application_display_name: Nightly 04:52:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:25 INFO - mozversion application_name: Firefox 04:52:25 INFO - mozversion application_remotingname: firefox 04:52:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:52:25 INFO - mozversion application_vendor: Mozilla 04:52:25 INFO - mozversion application_version: 49.0a1 04:52:25 INFO - mozversion platform_buildid: 20160428035553 04:52:25 INFO - mozversion platform_changeset: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e 04:52:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:52:25 INFO - mozversion platform_version: 49.0a1 04:52:25 INFO - using testdate: 1461844345 04:52:25 INFO - actual date: 1461844345 04:52:25 INFO - starting webserver on 'localhost:52282' 04:52:25 INFO - SUITE-START | Running 2 tests 04:52:25 INFO - TEST-START | dromaeo_css 04:52:25 INFO - operating with platform_type : mac_ 04:52:25 INFO - Initialising browser for dromaeo_css test... 04:52:25 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpOgEAbU/profile http://localhost:52282/getInfo.html) 04:52:28 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 04:52:28 INFO - PROCESS | 1936 | colorDepth:24 04:52:28 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 04:52:28 INFO - PROCESS | 1936 | __metrics 04:52:28 INFO - PROCESS | 1936 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:52:28 ERROR - PROCESS | 1936 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:52:28 INFO - TEST-INFO | 1936: exit 0 04:52:28 INFO - Browser initialized. 04:52:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:28 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpOgEAbU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:40 INFO - PROCESS | 1938 | RSS: Main: 239226880 04:52:40 INFO - PROCESS | 1938 | 04:53:32 INFO - PROCESS | 1938 | 1461844412372 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:55:42 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52282/tests/dromaeo/cssquery-ext.html) 04:55:43 INFO - PROCESS | 1938 | RSS: Main: 349134848 04:55:43 INFO - PROCESS | 1938 | 04:58:46 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52282/tests/dromaeo/cssquery-ext.html (next: http://localhost:52282/tests/dromaeo/cssquery-jquery.html) 04:58:47 INFO - PROCESS | 1938 | RSS: Main: 371855360 04:58:47 INFO - PROCESS | 1938 | 05:01:49 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52282/tests/dromaeo/cssquery-mootools.html) 05:01:50 INFO - PROCESS | 1938 | RSS: Main: 376934400 05:01:50 INFO - PROCESS | 1938 | 05:04:52 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52282/tests/dromaeo/cssquery-prototype.html) 05:04:52 INFO - PROCESS | 1938 | RSS: Main: 375386112 05:04:52 INFO - PROCESS | 1938 | 05:07:56 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52282/tests/dromaeo/cssquery-yui.html) 05:07:56 INFO - PROCESS | 1938 | RSS: Main: 343793664 05:07:56 INFO - PROCESS | 1938 | 05:10:59 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52282/tests/dromaeo/cssquery-yui.html (next: http://localhost:52282/tests/dromaeo/cssquery-dojo.html) 05:11:00 INFO - PROCESS | 1938 | RSS: Main: 387141632 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | __start_tp_report 05:11:00 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 05:11:00 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 05:11:00 INFO - PROCESS | 1938 | |i|pagename|runs| 05:11:00 INFO - PROCESS | 1938 | |0;dojo.html;3296.6373698893117;3385.2890892912487;3418.350513402455;3422.948655770163;3473.808940508273;4622.953770462299;5499.835004949848;5602.971985140069;5605.047141985867;5624.29696287964;4909.239067944474;5551.361593416748;5552.639078459897;5559.861003474905;5632.493075623193;5038.2190760432195;5075.695458272497;5082.2122571001555;5085.415177254607;5243.056249875021;5178.585713142939;5197.610179236573;5220.973895130519;5236.502532259429;5244.895102097956;5022.196448568248;5099.4390617032095;5118.309028281172;5121.28302037715;5185.792568297264;4195.349720793282;5030.748462576893;5065.974670126626;5111.361079865017;5145.151050076733;4872.512748725135;5051.191809310492;5051.318072060261;5055.545000949932;5123.718195499246;5539.196816461631;5541.833744987657;5543.1408131739645;5546.861328466821;5555.138953462219;5956.702164891738;6067.041556991311;6095.438338978142;6185.876282474325;6192.721327540226;6165.876682466325;6196.566240363177;6214.844628884269;6228.781992630236;6243.719032643497;5762.74067666956;5794.768209271666;5799.159121927339;5811.941880581225;5814.244148260784;6119.350229749466;6195.535334849904;6260.060990851318;6286.8428289292215;6301.023341382093;6046.032634778502;6120.816375508742;6139.293981192131;6141.938580614226;6149.569530132937;6215.223097112861;6227.813165605039;6241.531885108635;6246.250449946036;6251.437370636573;6011.09833524966;6111.388861113853;6116.061877111602;6176;6178.938210617926;6144.41628045335;6205.410486003822;6205.968970155121;6208.782692605737;6210.223722034746;4896.143174944371;4901.264810278487;4905.435874874363;4906.950930490721;4931.186354251508;3572.214112895159;4322.438083049246;4329.415528903621;4414.646828253732;4480.036792089716;5585.218069470277;5595.21666966625;5599.160125981135;5607.243022191952;5609.691466969274;6099.878002439927;6206.534509911775;6214.130021796952;6225.968870155621;6229.96885015572;4605.286180642006;5510.862228444321;5658.830235092953;5670.631408958487;5680;4446.6220371268155;5307.071262529119;5315.920261196085;5325.201219817059;5336.573074154058;6160.969195153995;6310.842228944313;6323.620582765049;6327.303996560467;6340.397662222082;6111.561351782648;6114.3277820888225;6237.625742455467;6252.655679029031;6269.153664255449;6277.874442511215;6291.811245662638;6297.653629050446;6298.055291706098;6306;5938.049912014057;6143.600665956698;6146.815595532141;6154.661493617894;6154.876902462015;5858.882822343615;6126.975740326223;6172.166757487682;6223.96888015557;6251.031090181029;5959.642421454727;5975.133605627073;5984.970075149597;5995.250593675791;6024.487918526975;5835.037218858841;5868.178455016216;5996.160537524663;6007.849803754941;6020.247469066367;4192.4759405074365;5691.26013618227;5826.621269617462;5856.267966504187;5895.322037965689;5984.760609575568;6018.7291571878495;6026.819195424145;6041.607295525777;6085.208922840003;5629.718514074198;5744.167095771007;5815.709214539341;5848.883022339614;5849.912251316148 05:11:00 INFO - PROCESS | 1938 | |1;ext.html;519.693380905266;525.9684418934864;583.16316086416;583.7507733450419;616.7779599344235;26728.732712672867;37032.07419814506;38101.428478572845;38116.809415952914;38255;40884;41697.58302416975;41705.374419383734;41769.16461670773;41773.7911310443;8412.242898139166;9405.623775049007;9660.082292182231;9665.178459830922;9666.323357364987;8479.19447652472;8634.050254472004;8640.65437382504;8644.092370301121;10963.945180274088;9531;9673.22614190863;11135.610253641124;11342.71643208918;11359.318440893532;11332.150088743336;11410;11418.71453213668;11429.942850285779;11430.028447581966;8345.54099524526;11022.724431889266;11168.106551475863;11273.605423810128;11289;36628.267434651156;37196.442053369225;37227.25545489075;37254.25491490155;37312.440313395324;3149.9685003150134;3180.5098991874033;3186.633537143235;3236.3203727217315;3358.5969683637877;26337.20988370352;26349.20952371432;26392.47215055688;26564.601530977052;26593;2675.598660200966;2715.226160544255;2723.714010028958;2725.318670332417;2777.222377734238;320616.3969180139;322003;322966;323372;323963;55765.72117139388;56071;56160.43839561552;56289.43710562924;56308.43691563032;58088.70955645195;58112.41887581155;58305.5423614413;58405;58442.12336814866;15629.68740625181;16119.838801612068;16130.677386452206;16134.354625814836;16144.596385090466;12818;12875.613731588068;12895.548655797002;12913.483460661468;12916.483340666457;13384.866151338361;13664.31678416095;15009.17449540264;15121.017133886262;15394.692106158038;6030.427109424598;6127.295361033538;6195.141457562713;6199.721012554446;6222.253329600477;911.252772726358;965.3966271080575;1002.7192386131894;1026.9075783179549;1090.2804149261449;27841.30396740057;27899.023534176205;28269;28407.28981775472;28584.285392865346;1062.2988827373897;1095.7260684828793;1095.9287646302964;1097.7255686078481;1103.6523495099018;14456.98801083935;14480.927595361956;14653.706925861423;14803.92598037003;14823.629409264855;417669;420821;427823;427987;428023;54789;54917.72541137269;54933.72533137309;55020;55200.61998449991;1422.3101795629111;1447.6091455307007;1473.896827222127;1474.233398632705;1483.5920121966547;27952.860235698692;28066.85966570154;28340.57489137706;28587.856485740336;28806.567901481914;44190.33714494349;44231.77884110559;44630.3305450425;44631.55368446274;44728.329075064554;319830;320967;321200;321276;321413.3929330338;21091.156353746293;22878.885605571864;23285.020773234464;23967.04131834707;36201.818990904874;37195.07012324713;38383.80808095942;38432.42351364676;38508.22983540258;38513.03717407087;29836.104916851662;31724.365512690078;32484.675153248165;32902.34195316032;34428.31143377168;28549.571756424084;30021.849890750407;31798.52302215515;32201.35597287994;32670;32820.67179328176;33328.66671333255;33517.66482335146;33775;33834.66165338414;28733.28166795847;29840;30168.09495715132;30224.30352562194;30232.546511801902;22496.32511024672;22714.864256786765;23046.884765576066;23123.537529248984;23152.652710209022 05:11:00 INFO - PROCESS | 1938 | |2;jquery.html;393.2665578695732;396.44893597898925;398.663129655441;402.5029089074994;410.07732601646296;19193;19659;20184.69722954157;20343.69484457734;20372.879491627973;15468.613284667888;16773.329066837312;19934.302299419523;20568.69146962793;20615.587688246225;5076.746162691869;6076.969615151918;6137.631742095488;6151.72317245725;6153.738483610871;5820.534357251409;6011.5491338149595;6047.213862197908;6048.969755151218;6065.787697430591;5794.217780599628;5862.32583252925;5977.073553599199;5991.981363168272;6027.879442411149;5855.268091488521;5880.970595146997;5994.640321580698;6024.939750602503;6030.788922387717;5171.612129090296;5242.5281724644965;5264.052470555337;5282.366116066059;5287.973560132214;12567.308798016105;13190.472381104744;13203.943684505217;13213.669658258525;25482.235532934043;1869.9439016829517;2017.5460521382718;2249.1902914950606;2371.727251366098;2523.9147166718303;9529.618815247382;9792.551862034492;9947.850782238273;9956.850647240297;10363.792724145474;1678.3286685325845;1739.4607671621711;1757.66604345174;1780.2078075256386;1822.8359447649775;68801;84752;87078.56460717719;95453;100048.9995100047;9544.236461083097;11331.490082946122;11375.715607109723;11751.529938802352;11758.450889684966;12554.309512976692;13028.41372138256;31497.377801552655;31828.840855796036;32792.67207327944;10761.623343183108;10778.13774898022;10823;10897.945510272399;11449.427528623535;8736.475811451333;9085.727428177166;9109.635614575476;9131.77170570741;9254.629814807333;8852.674962827015;9168.808054952948;9428.481433521221;9429.292803039662;9446;3059.1855492946097;3086.36729470458;3660.7419396736927;3667.798271095062;3749.606291339425;896.2650626486349;979.8628192053118;981.40134517944;991.6182269826024;1055.7096798380508;19288.888444562202;19419.32032378888;19827.40517784469;19914.30299939524;20119.798802011792;939.2579861909152;978.6281213138961;1012.6708819633649;1023.2070145637191;1038.4911393417171;6849.760258390932;8798.47209167452;10517.84223236652;10727.40999245049;10757.515911783988;500314.9968500341;516863;517713;593835;593838;116930;119188;121058.78941210476;124228;128045;1055.6885718712997;1065.2436769893307;1096.5339730614457;1147.1969621265148;1147.7761836441814;16969;17329.30682772675;17330.740038899174;17494.825051749318;17501.03661369511;49243.50756492533;49889;49937.50187494381;50530.49469505258;51357.743211283705;69292.26769330807;69865;70816.64591677008;71930;72361.6381918087;5450.454954504517;5767.826965191051;7321.816954576178;8044.718434854752;8116.2695357418115;10127.848082278919;10306.484675766033;12088.75822483563;12162.270263784201;12228.694282643006;10132.848007279748;10608.204384671335;10719.785604287714;10725.249232553646;10840.186985975926;10171.440570768678;10202.693919182437;10452.972114419057;10585.465107559516;10636.255462117577;10639.787204256027;10737.624183153865;10752.13982881352;10964.28732132409;11054.336739795637;7971.760847174594;8138.389620778347;8158.510489370657;8186.754397368089;8352.791180220544;10238.180945524191;10760.46197690128;10845;11096.667099987013;11139 05:11:00 INFO - PROCESS | 1938 | |3;mootools.html;1446.3636000159936;1633.1262774415686;1633.640599068205;1900.3253844885066;2003.2087325506425;7809.765707028784;8509.957450212749;8705.390622656401;8727;8741.606627701745;8313.334933205344;8556.101609331025;8564.871526927102;8570.142985701443;8592.054873963874;2418.093215044358;2454.6686197363306;2455.4597988442515;2457.6436416719566;2461.360046387943;2388.9249837573075;2446.4006318452;2447.4248551590363;2447.8041756659513;2463.1502131764514;2390.1634427950253;2406.68713067301;2423.7091549014144;2424.3454267347806;2429.441228517442;2370.8577485350934;2398.4723360860585;2401.2436082634003;2404.903803847853;2418.238254949685;2294.6328587425933;2324.4072761445723;2326.6161083421216;2328.1851352026824;2328.871912044837;8501.95749021251;8553.786155346104;8658.523781192032;8659.740207793777;8683.739487815312;5205.687658740488;5442.346918369821;5471.288732464794;5482.095454250044;5482.862928426782;3397.779144355634;3494.5457090578316;3531.364354416204;3554.733394995386;3559.430491121434;1024.2881197567694;1037.1029059863165;1037.5175543372293;1037.7754249985014;1041.671873359889;11533.308001519936;11692.006179474669;11693.239939403911;11693.415329233505;11699.649010529698;4584.472785629629;4588.059447813191;4725.503822098699;4749.240121580599;4761.142994261067;9207.355485115977;9220.53897305132;9221.262299016063;9227.492487913096;9238.722838314861;5194.77922688168;5291.444398338196;5301.284326615858;5302.416734159239;5316.6544174628525;4391.912161756747;4601.148787474328;4751.904961900743;4861.683990540603;4928.654994150446;3199.6640352762624;3697.149655579232;3724.4413337999517;3769.6041915598466;3810.790406527612;1037.823569993103;1207.5471698113208;1211.418519110814;1223;1239.1883316427754;651.8989556618732;790.7390561114819;847.6228078505006;859.4070091636751;862.5988915154484;5466.72666366688;5503.587230957694;5547.667139971614;5799.797007104731;5817.854553636108;500.36453703795974;503.8009986055487;508.72528834428994;519.8154655097461;641.7689631732572;3727.3849814780256;3927.9803600981813;4008.2985477541315;4020;4063.7358571693335;9969.80060398788;10373.377597344184;10408.47957602117;10530.36817790935;10537.84193237102;10340.965903409598;10387.220958427997;10485.842712359321;10495.10791582724;10496.265261431627;7883.842323153504;8206.425550211547;8235.670573177125;8245.79385515355;8251.504909705316;5554.97222513901;5767.365589785204;5841;5916.26046744157;5957.940420595912;9389.906100938902;9588.904110958802;9677.22582193437;9843.064908833649;9855.556499957662;7813.921860781319;9410.294227932796;9935.20518358544;9939.701808945743;9950.950245248727;7199;7562.470627056054;7614.238576142563;7622.466427350032;7628.8855667163925;7815.648295826588;8108.716194933149;8163.591820409075;8255.587220638823;8264.752057438287;7242.203357630551;7260.237675044255;7356.632168391666;7403.000594919832;7439;7071.398931090709;7232.566046037255;7304.123505179413;7311.122665280201;7433.331000210007;6905.516613836983;6988.056612357267;6989.26612705679;6991.2659170788365;7004.649767511706;4150.858513908699;4402.877266297074;4690.648201384842;4942.061008408391;4961.677490963076;4752.120857641347;4989.750512474435;5035.16919708244;5055.317532133115;5066.138756411493 05:11:00 INFO - PROCESS | 1938 | |4;prototype.html;278.26399174184274;306.7055626598465;312.21166554450014;318.4157071773296;324.41605110800555;4322.459692538433;5246.108161612526;5299.283637562572;5301.390340110893;5347.786088556453;3850.3261929162422;4031;4161.583841615837;5286.7885284588665;5287.524122828944;3609.151849315409;3827.636374544428;3888.844446222162;3932.2725295820364;4002;4000.659943904772;4053.6217685986758;4057.695672824535;4074.9388759168637;4084.813066606737;3109.9844500777463;3580.4629305604108;3803.790791506466;4020.211006102286;4033.7983100844986;3334.4664853623303;3772.830422568985;3813.3326667833157;3881.961180388202;4091.9156423547784;3322.9532697200307;3534.1871369584883;3563.4120370138894;3570.553680789901;3581.8925432237074;3914.921701565953;4675.649326300541;4822.348982887301;5129.333186685707;5135.460776618439;4304.80628371724;4596.7931443085145;4619.8152073917;4638.7733887734075;4656.253904785705;5027.542012816315;5094.133997220481;5570.220169176318;5587.469190426903;5624.21261023457;3195.5526226328334;3765.7363984521094;3785.2240290740333;3823.636754508317;3848.9992601923423;5190.71451070191;5554.527865131468;5806.564507661942;5855.824325270249;5860.212635146278;3836.290286297044;3841.193349396602;3850.6919446444217;3860.3630400983525;3863.265979463949;3559.9320203938714;3664.340418724655;3922.686185105185;3928.705347098979;3951.1110000249714;4394.890127746768;4555.954440455553;4563.977180114144;4575.977120114445;4589.5639914208095;5195.454477279831;5537.252470916455;5590.301212348457;5605.467480589337;5624.268845050117;1224.3510939202238;1333.4999375234288;1424.7720364741592;1427.964300892486;1429.9428022879176;761.9657115429819;882.1266945723816;902.6299217320998;935.2891802230354;955.2358113509165;4612.74629895359;4749.3588365570895;5113.411957624847;5171.560417364566;5498.835034948958;5087.3974697970025;5604;5796.246487956623;5799;5814.900495150909;5169;5227.26818245446;5245.6852588844795;5265.289185959923;5285.920711189258;3016.5475178722927;3059.831709255968;3148.275896543808;3299.373119107362;3299.6205436374644;5999.250093738283;6070.939290607126;6199.783007594712;6225.782097626561;6550.246721626979;5640.351359593699;6156.538259630545;6447.677616119176;6448.387403196689;6489.415952564292;6147.385261473817;6474.4496717778575;6514.446272066927;6515.641639709862;6540.869182616226;4348.978255108705;6260.7495700171485;6280.811575652738;6295.496360291258;6300.369963003663;4787.0798812723515;5505.642133261325;5633.0987042073075;5703.714814259353;5734.741936612779;5309.415964243853;5792.565557583114;5978.176656119926;6017.224918649096;6031.819045428644;3276.9016929492154;3442.6729460701195;3650.324689932371;3889.669378102893;3915.647591716759;4665.5567721066445;5629.746661400329;5737.368889422244;5742.626729262584;5760.510356619734;5093.159628661229;5215.895682086261;5324.440933702061;5595.440455954372;5641.407652196624;4752.500987396274;5552.167174923794;5572.498475137257;5604.607677462538;5620.016497113071;4607.6083532900075;5261.369315342329;5446.537044351275;5463.438029245624;5515;5442.210879422382;5568.415316391721;5584.86037849057;5606.215129881902;5618.971905140448;5119.590432765444;5199.4020687621405;5454.536364409069;5454.990826697073;5455.263539422286 05:11:00 INFO - PROCESS | 1938 | |5;yui.html;611.2390074357426;653.6796969484952;683.2689022745664;699.6466784273941;751.6429695894451;12169.695757606065;15038.473653422132;15288.541343759705;15290.464833730794;15303.770443443358;13937.58187254384;13972.301384930739;13980.440782368718;14086.225257610828;14092.506762263323;905.8641203819446;916.7341470973442;917.9082091790801;918.1094338491653;919.8068405634825;723.7539236659535;742.7400409856534;744.6053591596462;746.0674157303371;898.9505577193285;771.645043280089;918;969.9321047526676;972.0959507657875;974.3179774158082;963.9710808675751;965.5317171171976;965.5654955270121;966.5022513405602;966.5505539923934;562.3308263166819;580.4659713063949;714.2143641993817;716.5628966330535;716.6201912986073;12196.878031219663;12278.815817762741;13301;13681.110727802761;13770.311484425738;12134.271943683407;12181.208221465577;12310.13829031968;12406.883380495708;12613.117081804277;9730.708078757649;9820.950895245478;9874.260722628143;9940.602375904955;10231.948840255825;3462.7056700180515;3537.4870643756512;3545.503629491873;3550.609432962372;3652.853885844563;71476.64261678711;72035.63982180107;72098.27901720969;72116;72134.63932680356;7767.844643107106;8777.963022868067;9174.449533028039;9219.539023048821;9353.204977576983;20883.060262288232;20942.581148376947;21185;21193.36419907405;21213.15147394087;7356.190819010012;7449.851002980018;7469.178390377054;7559.659815308324;7641.044869391326;3929.25344184604;3961.960380396159;3987.641112299907;3990.8204130814183;4016.6184212499766;3414.231797845465;3487.163080860626;3488.337215928965;3493.3886569850683;3494.371013217645;644.8162273751958;651.6155468273741;652.2694582068019;654.8366133041006;658.2397331082607;547.9863003424946;569.6610516742614;577.6591810831545;595.1727099331932;597.6354423801478;7907.288344049063;7972.800679982931;8003.399745019147;8106.432549721463;8226.341892648574;552.3178874090495;576.3372122059582;588.188300145796;610.7282259394527;618.7865186510646;3488.354654388946;3725.1990821972863;3731.850725970985;3865.903352416212;3937.468441760383;84591.15408845956;86947.13052869517;87327.56336218279;87440;94039;75835.62082189663;76838.07904802312;77391.61304193556;79380;82051.25641704834;69011.30988690049;69376.95934560985;69661;69761;70891.2910870895;6812.25065242813;7817.257360550739;7918.129005809472;8074.959625201836;8564.400491965502;35143.71565848211;36592.81703591465;36768.81615591905;37115.44326835046;37386.878393648236;53066.73466632642;53358;53434.732826337175;53579.46420535745;53663;10483;11061.83407248908;11104.61133860311;11262.605808796981;11307.208495405243;11635.961900211876;11674.649760507198;11789.882101178879;11842.76314473723;12402.81395779082;11065.502052407823;11228;11396.601118960796;11997.76004479888;12224.083193760682;11174.720631984266;11240.437978101227;11352.545898164311;11368.602098926498;11468.31190128595;11114.22200445961;11197;11420.600278990196;11468.910453506904;11721.531138754355;9286.257099431894;9516.095970882756;9764.707058788248;9957.20342372594;10001.2999090063;9354.485503297385;9553.379030363005;9592.136707696342;9639.614415423584;9656.75858103553 05:11:00 INFO - PROCESS | 1938 | __end_tp_report 05:11:00 INFO - PROCESS | 1938 | __start_cc_report 05:11:00 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,1139 05:11:00 INFO - PROCESS | 1938 | __end_cc_report 05:11:00 INFO - PROCESS | 1938 | __startTimestamp1461845460053__endTimestamp 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | ------- Summary: start ------- 05:11:00 INFO - PROCESS | 1938 | Number of tests: 6 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | [#0] dojo.html Cycles:165 Average:5633.54 Median:5848.88 stddev:682.04 (11.7%) stddev-sans-first:659.04 05:11:00 INFO - PROCESS | 1938 | Values: 3296.6 3385.3 3418.4 3422.9 3473.8 4623.0 5499.8 5603.0 5605.0 5624.3 4909.2 5551.4 5552.6 5559.9 5632.5 5038.2 5075.7 5082.2 5085.4 5243.1 5178.6 5197.6 5221.0 5236.5 5244.9 5022.2 5099.4 5118.3 5121.3 5185.8 4195.3 5030.7 5066.0 5111.4 5145.2 4872.5 5051.2 5051.3 5055.5 5123.7 5539.2 5541.8 5543.1 5546.9 5555.1 5956.7 6067.0 6095.4 6185.9 6192.7 6165.9 6196.6 6214.8 6228.8 6243.7 5762.7 5794.8 5799.2 5811.9 5814.2 6119.4 6195.5 6260.1 6286.8 6301.0 6046.0 6120.8 6139.3 6141.9 6149.6 6215.2 6227.8 6241.5 6246.3 6251.4 6011.1 6111.4 6116.1 6176.0 6178.9 6144.4 6205.4 6206.0 6208.8 6210.2 4896.1 4901.3 4905.4 4907.0 4931.2 3572.2 4322.4 4329.4 4414.6 4480.0 5585.2 5595.2 5599.2 5607.2 5609.7 6099.9 6206.5 6214.1 6226.0 6230.0 4605.3 5510.9 5658.8 5670.6 5680.0 4446.6 5307.1 5315.9 5325.2 5336.6 6161.0 6310.8 6323.6 6327.3 6340.4 6111.6 6114.3 6237.6 6252.7 6269.2 6277.9 6291.8 6297.7 6298.1 6306.0 5938.0 6143.6 6146.8 6154.7 6154.9 5858.9 6127.0 6172.2 6224.0 6251.0 5959.6 5975.1 5985.0 5995.3 6024.5 5835.0 5868.2 5996.2 6007.8 6020.2 4192.5 5691.3 5826.6 5856.3 5895.3 5984.8 6018.7 6026.8 6041.6 6085.2 5629.7 5744.2 5815.7 5848.9 5849.9 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | [#1] ext.html Cycles:180 Average:50492.78 Median:320791.70 stddev:94814.23 (29.6%) stddev-sans-first:95005.97 05:11:00 INFO - PROCESS | 1938 | Values: 519.7 526.0 583.2 583.8 616.8 26728.7 37032.1 38101.4 38116.8 38255.0 40884.0 41697.6 41705.4 41769.2 41773.8 8412.2 9405.6 9660.1 9665.2 9666.3 8479.2 8634.1 8640.7 8644.1 10963.9 9531.0 9673.2 11135.6 11342.7 11359.3 11332.2 11410.0 11418.7 11429.9 11430.0 8345.5 11022.7 11168.1 11273.6 11289.0 36628.3 37196.4 37227.3 37254.3 37312.4 3150.0 3180.5 3186.6 3236.3 3358.6 26337.2 26349.2 26392.5 26564.6 26593.0 2675.6 2715.2 2723.7 2725.3 2777.2 320616.4 322003.0 322966.0 323372.0 323963.0 55765.7 56071.0 56160.4 56289.4 56308.4 58088.7 58112.4 58305.5 58405.0 58442.1 15629.7 16119.8 16130.7 16134.4 16144.6 12818.0 12875.6 12895.5 12913.5 12916.5 13384.9 13664.3 15009.2 15121.0 15394.7 6030.4 6127.3 6195.1 6199.7 6222.3 911.3 965.4 1002.7 1026.9 1090.3 27841.3 27899.0 28269.0 28407.3 28584.3 1062.3 1095.7 1095.9 1097.7 1103.7 14457.0 14480.9 14653.7 14803.9 14823.6 417669.0 420821.0 427823.0 427987.0 428023.0 54789.0 54917.7 54933.7 55020.0 55200.6 1422.3 1447.6 1473.9 1474.2 1483.6 27952.9 28066.9 28340.6 28587.9 28806.6 44190.3 44231.8 44630.3 44631.6 44728.3 319830.0 320967.0 321200.0 321276.0 321413.4 21091.2 22878.9 23285.0 23967.0 36201.8 37195.1 38383.8 38432.4 38508.2 38513.0 29836.1 31724.4 32484.7 32902.3 34428.3 28549.6 30021.8 31798.5 32201.4 32670.0 32820.7 33328.7 33517.7 33775.0 33834.7 28733.3 29840.0 30168.1 30224.3 30232.5 22496.3 22714.9 23046.9 23123.5 23152.7 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | [#2] jquery.html Cycles:180 Average:32199.14 Median:3072.78 stddev:90753.38 (2953.5%) stddev-sans-first:90976.54 05:11:00 INFO - PROCESS | 1938 | Values: 393.3 396.4 398.7 402.5 410.1 19193.0 19659.0 20184.7 20343.7 20372.9 15468.6 16773.3 19934.3 20568.7 20615.6 5076.7 6077.0 6137.6 6151.7 6153.7 5820.5 6011.5 6047.2 6049.0 6065.8 5794.2 5862.3 5977.1 5992.0 6027.9 5855.3 5881.0 5994.6 6024.9 6030.8 5171.6 5242.5 5264.1 5282.4 5288.0 12567.3 13190.5 13203.9 13213.7 25482.2 1869.9 2017.5 2249.2 2371.7 2523.9 9529.6 9792.6 9947.9 9956.9 10363.8 1678.3 1739.5 1757.7 1780.2 1822.8 68801.0 84752.0 87078.6 95453.0 100049.0 9544.2 11331.5 11375.7 11751.5 11758.5 12554.3 13028.4 31497.4 31828.8 32792.7 10761.6 10778.1 10823.0 10897.9 11449.4 8736.5 9085.7 9109.6 9131.8 9254.6 8852.7 9168.8 9428.5 9429.3 9446.0 3059.2 3086.4 3660.7 3667.8 3749.6 896.3 979.9 981.4 991.6 1055.7 19288.9 19419.3 19827.4 19914.3 20119.8 939.3 978.6 1012.7 1023.2 1038.5 6849.8 8798.5 10517.8 10727.4 10757.5 500315.0 516863.0 517713.0 593835.0 593838.0 116930.0 119188.0 121058.8 124228.0 128045.0 1055.7 1065.2 1096.5 1147.2 1147.8 16969.0 17329.3 17330.7 17494.8 17501.0 49243.5 49889.0 49937.5 50530.5 51357.7 69292.3 69865.0 70816.6 71930.0 72361.6 5450.5 5767.8 7321.8 8044.7 8116.3 10127.8 10306.5 12088.8 12162.3 12228.7 10132.8 10608.2 10719.8 10725.2 10840.2 10171.4 10202.7 10453.0 10585.5 10636.3 10639.8 10737.6 10752.1 10964.3 11054.3 7971.8 8138.4 8158.5 8186.8 8352.8 10238.2 10760.5 10845.0 11096.7 11139.0 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | [#3] mootools.html Cycles:180 Average:5592.50 Median:2787.43 stddev:3117.67 (111.8%) stddev-sans-first:3110.85 05:11:00 INFO - PROCESS | 1938 | Values: 1446.4 1633.1 1633.6 1900.3 2003.2 7809.8 8510.0 8705.4 8727.0 8741.6 8313.3 8556.1 8564.9 8570.1 8592.1 2418.1 2454.7 2455.5 2457.6 2461.4 2388.9 2446.4 2447.4 2447.8 2463.2 2390.2 2406.7 2423.7 2424.3 2429.4 2370.9 2398.5 2401.2 2404.9 2418.2 2294.6 2324.4 2326.6 2328.2 2328.9 8502.0 8553.8 8658.5 8659.7 8683.7 5205.7 5442.3 5471.3 5482.1 5482.9 3397.8 3494.5 3531.4 3554.7 3559.4 1024.3 1037.1 1037.5 1037.8 1041.7 11533.3 11692.0 11693.2 11693.4 11699.6 4584.5 4588.1 4725.5 4749.2 4761.1 9207.4 9220.5 9221.3 9227.5 9238.7 5194.8 5291.4 5301.3 5302.4 5316.7 4391.9 4601.1 4751.9 4861.7 4928.7 3199.7 3697.1 3724.4 3769.6 3810.8 1037.8 1207.5 1211.4 1223.0 1239.2 651.9 790.7 847.6 859.4 862.6 5466.7 5503.6 5547.7 5799.8 5817.9 500.4 503.8 508.7 519.8 641.8 3727.4 3928.0 4008.3 4020.0 4063.7 9969.8 10373.4 10408.5 10530.4 10537.8 10341.0 10387.2 10485.8 10495.1 10496.3 7883.8 8206.4 8235.7 8245.8 8251.5 5555.0 5767.4 5841.0 5916.3 5957.9 9389.9 9588.9 9677.2 9843.1 9855.6 7813.9 9410.3 9935.2 9939.7 9951.0 7199.0 7562.5 7614.2 7622.5 7628.9 7815.6 8108.7 8163.6 8255.6 8264.8 7242.2 7260.2 7356.6 7403.0 7439.0 7071.4 7232.6 7304.1 7311.1 7433.3 6905.5 6988.1 6989.3 6991.3 7004.6 4150.9 4402.9 4690.6 4942.1 4961.7 4752.1 4989.8 5035.2 5055.3 5066.1 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | [#4] prototype.html Cycles:180 Average:4556.90 Median:5132.40 stddev:1448.35 (28.2%) stddev-sans-first:1416.36 05:11:00 INFO - PROCESS | 1938 | Values: 278.3 306.7 312.2 318.4 324.4 4322.5 5246.1 5299.3 5301.4 5347.8 3850.3 4031.0 4161.6 5286.8 5287.5 3609.2 3827.6 3888.8 3932.3 4002.0 4000.7 4053.6 4057.7 4074.9 4084.8 3110.0 3580.5 3803.8 4020.2 4033.8 3334.5 3772.8 3813.3 3882.0 4091.9 3323.0 3534.2 3563.4 3570.6 3581.9 3914.9 4675.6 4822.3 5129.3 5135.5 4304.8 4596.8 4619.8 4638.8 4656.3 5027.5 5094.1 5570.2 5587.5 5624.2 3195.6 3765.7 3785.2 3823.6 3849.0 5190.7 5554.5 5806.6 5855.8 5860.2 3836.3 3841.2 3850.7 3860.4 3863.3 3559.9 3664.3 3922.7 3928.7 3951.1 4394.9 4556.0 4564.0 4576.0 4589.6 5195.5 5537.3 5590.3 5605.5 5624.3 1224.4 1333.5 1424.8 1428.0 1429.9 762.0 882.1 902.6 935.3 955.2 4612.7 4749.4 5113.4 5171.6 5498.8 5087.4 5604.0 5796.2 5799.0 5814.9 5169.0 5227.3 5245.7 5265.3 5285.9 3016.5 3059.8 3148.3 3299.4 3299.6 5999.3 6070.9 6199.8 6225.8 6550.2 5640.4 6156.5 6447.7 6448.4 6489.4 6147.4 6474.4 6514.4 6515.6 6540.9 4349.0 6260.7 6280.8 6295.5 6300.4 4787.1 5505.6 5633.1 5703.7 5734.7 5309.4 5792.6 5978.2 6017.2 6031.8 3276.9 3442.7 3650.3 3889.7 3915.6 4665.6 5629.7 5737.4 5742.6 5760.5 5093.2 5215.9 5324.4 5595.4 5641.4 4752.5 5552.2 5572.5 5604.6 5620.0 4607.6 5261.4 5446.5 5463.4 5515.0 5442.2 5568.4 5584.9 5606.2 5619.0 5119.6 5199.4 5454.5 5455.0 5455.3 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - PROCESS | 1938 | [#5] yui.html Cycles:180 Average:17035.99 Median:596.40 stddev:23713.41 (3976.1%) stddev-sans-first:23747.86 05:11:00 INFO - PROCESS | 1938 | Values: 611.2 653.7 683.3 699.6 751.6 12169.7 15038.5 15288.5 15290.5 15303.8 13937.6 13972.3 13980.4 14086.2 14092.5 905.9 916.7 917.9 918.1 919.8 723.8 742.7 744.6 746.1 899.0 771.6 918.0 969.9 972.1 974.3 964.0 965.5 965.6 966.5 966.6 562.3 580.5 714.2 716.6 716.6 12196.9 12278.8 13301.0 13681.1 13770.3 12134.3 12181.2 12310.1 12406.9 12613.1 9730.7 9821.0 9874.3 9940.6 10231.9 3462.7 3537.5 3545.5 3550.6 3652.9 71476.6 72035.6 72098.3 72116.0 72134.6 7767.8 8778.0 9174.4 9219.5 9353.2 20883.1 20942.6 21185.0 21193.4 21213.2 7356.2 7449.9 7469.2 7559.7 7641.0 3929.3 3962.0 3987.6 3990.8 4016.6 3414.2 3487.2 3488.3 3493.4 3494.4 644.8 651.6 652.3 654.8 658.2 548.0 569.7 577.7 595.2 597.6 7907.3 7972.8 8003.4 8106.4 8226.3 552.3 576.3 588.2 610.7 618.8 3488.4 3725.2 3731.9 3865.9 3937.5 84591.2 86947.1 87327.6 87440.0 94039.0 75835.6 76838.1 77391.6 79380.0 82051.3 69011.3 69377.0 69661.0 69761.0 70891.3 6812.3 7817.3 7918.1 8075.0 8564.4 35143.7 36592.8 36768.8 37115.4 37386.9 53066.7 53358.0 53434.7 53579.5 53663.0 10483.0 11061.8 11104.6 11262.6 11307.2 11636.0 11674.6 11789.9 11842.8 12402.8 11065.5 11228.0 11396.6 11997.8 12224.1 11174.7 11240.4 11352.5 11368.6 11468.3 11114.2 11197.0 11420.6 11468.9 11721.5 9286.3 9516.1 9764.7 9957.2 10001.3 9354.5 9553.4 9592.1 9639.6 9656.8 05:11:00 INFO - PROCESS | 1938 | -------- Summary: end -------- 05:11:00 INFO - PROCESS | 1938 | 05:11:00 INFO - TEST-INFO | 1938: exit 0 05:11:00 INFO - TEST-OK | dromaeo_css | took 1114946ms 05:11:00 INFO - TEST-START | kraken 05:11:00 INFO - operating with platform_type : mac_ 05:11:00 INFO - Initialising browser for kraken test... 05:11:00 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpdLPsBg/profile http://localhost:52282/getInfo.html) 05:11:02 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 05:11:02 INFO - PROCESS | 1941 | colorDepth:24 05:11:02 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 05:11:02 INFO - PROCESS | 1941 | __metrics 05:11:02 INFO - PROCESS | 1941 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:11:02 ERROR - PROCESS | 1941 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:11:03 INFO - TEST-INFO | 1941: exit 0 05:11:03 INFO - Browser initialized. 05:11:03 INFO - Running cycle 1/1 for kraken test... 05:11:03 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpdLPsBg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:15 INFO - PROCESS | 1943 | RSS: Main: 239648768 05:11:15 INFO - PROCESS | 1943 | 05:11:18 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52282/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:19 INFO - PROCESS | 1943 | RSS: Main: 286937088 05:11:19 INFO - PROCESS | 1943 | 05:11:21 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52282/tests/kraken/driver.html?testName=audio-dft) 05:11:22 INFO - PROCESS | 1943 | RSS: Main: 300470272 05:11:22 INFO - PROCESS | 1943 | 05:11:26 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52282/tests/kraken/driver.html?testName=audio-fft) 05:11:26 INFO - PROCESS | 1943 | RSS: Main: 389373952 05:11:26 INFO - PROCESS | 1943 | 05:11:29 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52282/tests/kraken/driver.html?testName=audio-oscillator) 05:11:29 INFO - PROCESS | 1943 | RSS: Main: 288243712 05:11:29 INFO - PROCESS | 1943 | 05:11:31 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:32 INFO - PROCESS | 1943 | RSS: Main: 293453824 05:11:32 INFO - PROCESS | 1943 | 05:11:35 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52282/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:35 INFO - PROCESS | 1943 | RSS: Main: 328409088 05:11:35 INFO - PROCESS | 1943 | 05:11:38 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52282/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:39 INFO - PROCESS | 1943 | RSS: Main: 329129984 05:11:39 INFO - PROCESS | 1943 | 05:11:41 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52282/tests/kraken/driver.html?testName=json-parse-financial) 05:11:42 INFO - PROCESS | 1943 | RSS: Main: 330526720 05:11:42 INFO - PROCESS | 1943 | 05:11:44 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:44 INFO - PROCESS | 1943 | RSS: Main: 321953792 05:11:44 INFO - PROCESS | 1943 | 05:11:46 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:47 INFO - PROCESS | 1943 | RSS: Main: 329383936 05:11:47 INFO - PROCESS | 1943 | 05:11:49 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:50 INFO - PROCESS | 1943 | RSS: Main: 330461184 05:11:50 INFO - PROCESS | 1943 | 05:11:53 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:53 INFO - PROCESS | 1943 | RSS: Main: 335101952 05:11:53 INFO - PROCESS | 1943 | 05:11:57 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:11:57 INFO - PROCESS | 1943 | RSS: Main: 333021184 05:11:57 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52282/tests/kraken/driver.html?testName=ai-astar) 05:11:59 INFO - PROCESS | 1943 | RSS: Main: 397549568 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | __start_tp_report 05:11:59 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 05:11:59 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 05:11:59 INFO - PROCESS | 1943 | |i|pagename|runs| 05:11:59 INFO - PROCESS | 1943 | |0;ai-astar;111;112;107;112;112;112;112;110;106;156 05:11:59 INFO - PROCESS | 1943 | |1;audio-beat-detection;161;144;183;170;121;145;140;122;198;145 05:11:59 INFO - PROCESS | 1943 | |2;audio-dft;194;255;218;224;262;183;183;184;179;186 05:11:59 INFO - PROCESS | 1943 | |3;audio-fft;77;74;93;108;61;58;57;85;116;60 05:11:59 INFO - PROCESS | 1943 | |4;audio-oscillator;91;100;137;78;78;79;125;80;77;130 05:11:59 INFO - PROCESS | 1943 | |5;imaging-gaussian-blur;90;86;90;86;88;85;89;86;90;85 05:11:59 INFO - PROCESS | 1943 | |6;imaging-darkroom;95;94;94;101;93;94;95;95;93;95 05:11:59 INFO - PROCESS | 1943 | |7;imaging-desaturate;85;85;100;83;84;85;82;86;70;135 05:11:59 INFO - PROCESS | 1943 | |8;json-parse-financial;60;62;61;59;59;59;59;78;61;58 05:11:59 INFO - PROCESS | 1943 | |9;json-stringify-tinderbox;62;63;70;74;74;70;68;68;68;68 05:11:59 INFO - PROCESS | 1943 | |10;stanford-crypto-aes;86;104;108;107;82;82;82;82;82;84 05:11:59 INFO - PROCESS | 1943 | |11;stanford-crypto-ccm;145;152;137;137;134;138;134;133;177;169 05:11:59 INFO - PROCESS | 1943 | |12;stanford-crypto-pbkdf2;208;266;219;198;197;196;208;197;201;202 05:11:59 INFO - PROCESS | 1943 | |13;stanford-crypto-sha256-iterative;72;71;70;68;73;70;70;71;73;58 05:11:59 INFO - PROCESS | 1943 | __end_tp_report 05:11:59 INFO - PROCESS | 1943 | __start_cc_report 05:11:59 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,2066 05:11:59 INFO - PROCESS | 1943 | __end_cc_report 05:11:59 INFO - PROCESS | 1943 | __startTimestamp1461845519661__endTimestamp 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | ------- Summary: start ------- 05:11:59 INFO - PROCESS | 1943 | Number of tests: 14 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#0] ai-astar Cycles:10 Average:115.00 Median:112.00 stddev:14.58 (13.0%) stddev-sans-first:15.39 05:11:59 INFO - PROCESS | 1943 | Values: 111.0 112.0 107.0 112.0 112.0 112.0 112.0 110.0 106.0 156.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:153.00 stddev:25.04 (16.4%) stddev-sans-first:26.38 05:11:59 INFO - PROCESS | 1943 | Values: 161.0 144.0 183.0 170.0 121.0 145.0 140.0 122.0 198.0 145.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#2] audio-dft Cycles:10 Average:206.80 Median:206.00 stddev:31.29 (15.2%) stddev-sans-first:32.85 05:11:59 INFO - PROCESS | 1943 | Values: 194.0 255.0 218.0 224.0 262.0 183.0 183.0 184.0 179.0 186.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#3] audio-fft Cycles:10 Average:78.90 Median:67.50 stddev:21.29 (31.5%) stddev-sans-first:22.57 05:11:59 INFO - PROCESS | 1943 | Values: 77.0 74.0 93.0 108.0 61.0 58.0 57.0 85.0 116.0 60.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:78.00 stddev:24.15 (31.0%) stddev-sans-first:25.50 05:11:59 INFO - PROCESS | 1943 | Values: 91.0 100.0 137.0 78.0 78.0 79.0 125.0 80.0 77.0 130.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:2.12 (2.4%) stddev-sans-first:2.05 05:11:59 INFO - PROCESS | 1943 | Values: 90.0 86.0 90.0 86.0 88.0 85.0 89.0 86.0 90.0 85.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.50 stddev:2.28 (2.4%) stddev-sans-first:2.42 05:11:59 INFO - PROCESS | 1943 | Values: 95.0 94.0 94.0 101.0 93.0 94.0 95.0 95.0 93.0 95.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#7] imaging-desaturate Cycles:10 Average:89.50 Median:84.50 stddev:17.52 (20.7%) stddev-sans-first:18.51 05:11:59 INFO - PROCESS | 1943 | Values: 85.0 85.0 100.0 83.0 84.0 85.0 82.0 86.0 70.0 135.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:60.50 stddev:5.89 (9.7%) stddev-sans-first:6.22 05:11:59 INFO - PROCESS | 1943 | Values: 60.0 62.0 61.0 59.0 59.0 59.0 59.0 78.0 61.0 58.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.92 (5.7%) stddev-sans-first:3.38 05:11:59 INFO - PROCESS | 1943 | Values: 62.0 63.0 70.0 74.0 74.0 70.0 68.0 68.0 68.0 68.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:82.00 stddev:11.45 (14.0%) stddev-sans-first:12.06 05:11:59 INFO - PROCESS | 1943 | Values: 86.0 104.0 108.0 107.0 82.0 82.0 82.0 82.0 82.0 84.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:141.50 stddev:15.66 (11.1%) stddev-sans-first:16.61 05:11:59 INFO - PROCESS | 1943 | Values: 145.0 152.0 137.0 137.0 134.0 138.0 134.0 133.0 177.0 169.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:209.20 Median:205.00 stddev:21.19 (10.3%) stddev-sans-first:22.47 05:11:59 INFO - PROCESS | 1943 | Values: 208.0 266.0 219.0 198.0 197.0 196.0 208.0 197.0 201.0 202.0 05:11:59 INFO - PROCESS | 1943 | 05:11:59 INFO - PROCESS | 1943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:71.00 stddev:4.35 (6.1%) stddev-sans-first:4.53 05:11:59 INFO - PROCESS | 1943 | Values: 72.0 71.0 70.0 68.0 73.0 70.0 70.0 71.0 73.0 58.0 05:11:59 INFO - PROCESS | 1943 | -------- Summary: end -------- 05:11:59 INFO - PROCESS | 1943 | 05:12:00 INFO - TEST-INFO | 1943: exit 0 05:12:00 INFO - TEST-OK | kraken | took 59894ms 05:12:00 INFO - SUITE-END | took 1174s 05:12:00 INFO - Completed test suite (00:19:35) 05:12:00 INFO - javascript benchmark 05:12:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.6373698893117, 3385.2890892912487, 3418.350513402455, 3422.948655770163, 3473.808940508273, 4622.953770462299, 5499.835004949848, 5602.971985140069, 5605.047141985867, 5624.29696287964, 4909.239067944474, 5551.361593416748, 5552.639078459897, 5559.861003474905, 5632.493075623193, 5038.2190760432195, 5075.695458272497, 5082.2122571001555, 5085.415177254607, 5243.056249875021, 5178.585713142939, 5197.610179236573, 5220.973895130519, 5236.502532259429, 5244.895102097956, 5022.196448568248, 5099.4390617032095, 5118.309028281172, 5121.28302037715, 5185.792568297264, 4195.349720793282, 5030.748462576893, 5065.974670126626, 5111.361079865017, 5145.151050076733, 4872.512748725135, 5051.191809310492, 5051.318072060261, 5055.545000949932, 5123.718195499246, 5539.196816461631, 5541.833744987657, 5543.1408131739645, 5546.861328466821, 5555.138953462219, 5956.702164891738, 6067.041556991311, 6095.438338978142, 6185.876282474325, 6192.721327540226, 6165.876682466325, 6196.566240363177, 6214.844628884269, 6228.781992630236, 6243.719032643497, 5762.74067666956, 5794.768209271666, 5799.159121927339, 5811.941880581225, 5814.244148260784, 6119.350229749466, 6195.535334849904, 6260.060990851318, 6286.8428289292215, 6301.023341382093, 6046.032634778502, 6120.816375508742, 6139.293981192131, 6141.938580614226, 6149.569530132937, 6215.223097112861, 6227.813165605039, 6241.531885108635, 6246.250449946036, 6251.437370636573, 6011.09833524966, 6111.388861113853, 6116.061877111602, 6176.0, 6178.938210617926, 6144.41628045335, 6205.410486003822, 6205.968970155121, 6208.782692605737, 6210.223722034746, 4896.143174944371, 4901.264810278487, 4905.435874874363, 4906.950930490721, 4931.186354251508, 3572.214112895159, 4322.438083049246, 4329.415528903621, 4414.646828253732, 4480.036792089716, 5585.218069470277, 5595.21666966625, 5599.160125981135, 5607.243022191952, 5609.691466969274, 6099.878002439927, 6206.534509911775, 6214.130021796952, 6225.968870155621, 6229.96885015572, 4605.286180642006, 5510.862228444321, 5658.830235092953, 5670.631408958487, 5680.0, 4446.6220371268155, 5307.071262529119, 5315.920261196085, 5325.201219817059, 5336.573074154058, 6160.969195153995, 6310.842228944313, 6323.620582765049, 6327.303996560467, 6340.397662222082, 6111.561351782648, 6114.3277820888225, 6237.625742455467, 6252.655679029031, 6269.153664255449, 6277.874442511215, 6291.811245662638, 6297.653629050446, 6298.055291706098, 6306.0, 5938.049912014057, 6143.600665956698, 6146.815595532141, 6154.661493617894, 6154.876902462015, 5858.882822343615, 6126.975740326223, 6172.166757487682, 6223.96888015557, 6251.031090181029, 5959.642421454727, 5975.133605627073, 5984.970075149597, 5995.250593675791, 6024.487918526975, 5835.037218858841, 5868.178455016216, 5996.160537524663, 6007.849803754941, 6020.247469066367, 4192.4759405074365, 5691.26013618227, 5826.621269617462, 5856.267966504187, 5895.322037965689, 5984.760609575568, 6018.7291571878495, 6026.819195424145, 6041.607295525777, 6085.208922840003, 5629.718514074198, 5744.167095771007, 5815.709214539341, 5848.883022339614, 5849.912251316148], "value": 5590.091987248629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.693380905266, 525.9684418934864, 583.16316086416, 583.7507733450419, 616.7779599344235, 26728.732712672867, 37032.07419814506, 38101.428478572845, 38116.809415952914, 38255.0, 40884.0, 41697.58302416975, 41705.374419383734, 41769.16461670773, 41773.7911310443, 8412.242898139166, 9405.623775049007, 9660.082292182231, 9665.178459830922, 9666.323357364987, 8479.19447652472, 8634.050254472004, 8640.65437382504, 8644.092370301121, 10963.945180274088, 9531.0, 9673.22614190863, 11135.610253641124, 11342.71643208918, 11359.318440893532, 11332.150088743336, 11410.0, 11418.71453213668, 11429.942850285779, 11430.028447581966, 8345.54099524526, 11022.724431889266, 11168.106551475863, 11273.605423810128, 11289.0, 36628.267434651156, 37196.442053369225, 37227.25545489075, 37254.25491490155, 37312.440313395324, 3149.9685003150134, 3180.5098991874033, 3186.633537143235, 3236.3203727217315, 3358.5969683637877, 26337.20988370352, 26349.20952371432, 26392.47215055688, 26564.601530977052, 26593.0, 2675.598660200966, 2715.226160544255, 2723.714010028958, 2725.318670332417, 2777.222377734238, 320616.3969180139, 322003.0, 322966.0, 323372.0, 323963.0, 55765.72117139388, 56071.0, 56160.43839561552, 56289.43710562924, 56308.43691563032, 58088.70955645195, 58112.41887581155, 58305.5423614413, 58405.0, 58442.12336814866, 15629.68740625181, 16119.838801612068, 16130.677386452206, 16134.354625814836, 16144.596385090466, 12818.0, 12875.613731588068, 12895.548655797002, 12913.483460661468, 12916.483340666457, 13384.866151338361, 13664.31678416095, 15009.17449540264, 15121.017133886262, 15394.692106158038, 6030.427109424598, 6127.295361033538, 6195.141457562713, 6199.721012554446, 6222.253329600477, 911.252772726358, 965.3966271080575, 1002.7192386131894, 1026.9075783179549, 1090.2804149261449, 27841.30396740057, 27899.023534176205, 28269.0, 28407.28981775472, 28584.285392865346, 1062.2988827373897, 1095.7260684828793, 1095.9287646302964, 1097.7255686078481, 1103.6523495099018, 14456.98801083935, 14480.927595361956, 14653.706925861423, 14803.92598037003, 14823.629409264855, 417669.0, 420821.0, 427823.0, 427987.0, 428023.0, 54789.0, 54917.72541137269, 54933.72533137309, 55020.0, 55200.61998449991, 1422.3101795629111, 1447.6091455307007, 1473.896827222127, 1474.233398632705, 1483.5920121966547, 27952.860235698692, 28066.85966570154, 28340.57489137706, 28587.856485740336, 28806.567901481914, 44190.33714494349, 44231.77884110559, 44630.3305450425, 44631.55368446274, 44728.329075064554, 319830.0, 320967.0, 321200.0, 321276.0, 321413.3929330338, 21091.156353746293, 22878.885605571864, 23285.020773234464, 23967.04131834707, 36201.818990904874, 37195.07012324713, 38383.80808095942, 38432.42351364676, 38508.22983540258, 38513.03717407087, 29836.104916851662, 31724.365512690078, 32484.675153248165, 32902.34195316032, 34428.31143377168, 28549.571756424084, 30021.849890750407, 31798.52302215515, 32201.35597287994, 32670.0, 32820.67179328176, 33328.66671333255, 33517.66482335146, 33775.0, 33834.66165338414, 28733.28166795847, 29840.0, 30168.09495715132, 30224.30352562194, 30232.546511801902, 22496.32511024672, 22714.864256786765, 23046.884765576066, 23123.537529248984, 23152.652710209022], "value": 18161.61378043059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.2665578695732, 396.44893597898925, 398.663129655441, 402.5029089074994, 410.07732601646296, 19193.0, 19659.0, 20184.69722954157, 20343.69484457734, 20372.879491627973, 15468.613284667888, 16773.329066837312, 19934.302299419523, 20568.69146962793, 20615.587688246225, 5076.746162691869, 6076.969615151918, 6137.631742095488, 6151.72317245725, 6153.738483610871, 5820.534357251409, 6011.5491338149595, 6047.213862197908, 6048.969755151218, 6065.787697430591, 5794.217780599628, 5862.32583252925, 5977.073553599199, 5991.981363168272, 6027.879442411149, 5855.268091488521, 5880.970595146997, 5994.640321580698, 6024.939750602503, 6030.788922387717, 5171.612129090296, 5242.5281724644965, 5264.052470555337, 5282.366116066059, 5287.973560132214, 12567.308798016105, 13190.472381104744, 13203.943684505217, 13213.669658258525, 25482.235532934043, 1869.9439016829517, 2017.5460521382718, 2249.1902914950606, 2371.727251366098, 2523.9147166718303, 9529.618815247382, 9792.551862034492, 9947.850782238273, 9956.850647240297, 10363.792724145474, 1678.3286685325845, 1739.4607671621711, 1757.66604345174, 1780.2078075256386, 1822.8359447649775, 68801.0, 84752.0, 87078.56460717719, 95453.0, 100048.9995100047, 9544.236461083097, 11331.490082946122, 11375.715607109723, 11751.529938802352, 11758.450889684966, 12554.309512976692, 13028.41372138256, 31497.377801552655, 31828.840855796036, 32792.67207327944, 10761.623343183108, 10778.13774898022, 10823.0, 10897.945510272399, 11449.427528623535, 8736.475811451333, 9085.727428177166, 9109.635614575476, 9131.77170570741, 9254.629814807333, 8852.674962827015, 9168.808054952948, 9428.481433521221, 9429.292803039662, 9446.0, 3059.1855492946097, 3086.36729470458, 3660.7419396736927, 3667.798271095062, 3749.606291339425, 896.2650626486349, 979.8628192053118, 981.40134517944, 991.6182269826024, 1055.7096798380508, 19288.888444562202, 19419.32032378888, 19827.40517784469, 19914.30299939524, 20119.798802011792, 939.2579861909152, 978.6281213138961, 1012.6708819633649, 1023.2070145637191, 1038.4911393417171, 6849.760258390932, 8798.47209167452, 10517.84223236652, 10727.40999245049, 10757.515911783988, 500314.9968500341, 516863.0, 517713.0, 593835.0, 593838.0, 116930.0, 119188.0, 121058.78941210476, 124228.0, 128045.0, 1055.6885718712997, 1065.2436769893307, 1096.5339730614457, 1147.1969621265148, 1147.7761836441814, 16969.0, 17329.30682772675, 17330.740038899174, 17494.825051749318, 17501.03661369511, 49243.50756492533, 49889.0, 49937.50187494381, 50530.49469505258, 51357.743211283705, 69292.26769330807, 69865.0, 70816.64591677008, 71930.0, 72361.6381918087, 5450.454954504517, 5767.826965191051, 7321.816954576178, 8044.718434854752, 8116.2695357418115, 10127.848082278919, 10306.484675766033, 12088.75822483563, 12162.270263784201, 12228.694282643006, 10132.848007279748, 10608.204384671335, 10719.785604287714, 10725.249232553646, 10840.186985975926, 10171.440570768678, 10202.693919182437, 10452.972114419057, 10585.465107559516, 10636.255462117577, 10639.787204256027, 10737.624183153865, 10752.13982881352, 10964.28732132409, 11054.336739795637, 7971.760847174594, 8138.389620778347, 8158.510489370657, 8186.754397368089, 8352.791180220544, 10238.180945524191, 10760.46197690128, 10845.0, 11096.667099987013, 11139.0], "value": 9675.919346641242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.3636000159936, 1633.1262774415686, 1633.640599068205, 1900.3253844885066, 2003.2087325506425, 7809.765707028784, 8509.957450212749, 8705.390622656401, 8727.0, 8741.606627701745, 8313.334933205344, 8556.101609331025, 8564.871526927102, 8570.142985701443, 8592.054873963874, 2418.093215044358, 2454.6686197363306, 2455.4597988442515, 2457.6436416719566, 2461.360046387943, 2388.9249837573075, 2446.4006318452, 2447.4248551590363, 2447.8041756659513, 2463.1502131764514, 2390.1634427950253, 2406.68713067301, 2423.7091549014144, 2424.3454267347806, 2429.441228517442, 2370.8577485350934, 2398.4723360860585, 2401.2436082634003, 2404.903803847853, 2418.238254949685, 2294.6328587425933, 2324.4072761445723, 2326.6161083421216, 2328.1851352026824, 2328.871912044837, 8501.95749021251, 8553.786155346104, 8658.523781192032, 8659.740207793777, 8683.739487815312, 5205.687658740488, 5442.346918369821, 5471.288732464794, 5482.095454250044, 5482.862928426782, 3397.779144355634, 3494.5457090578316, 3531.364354416204, 3554.733394995386, 3559.430491121434, 1024.2881197567694, 1037.1029059863165, 1037.5175543372293, 1037.7754249985014, 1041.671873359889, 11533.308001519936, 11692.006179474669, 11693.239939403911, 11693.415329233505, 11699.649010529698, 4584.472785629629, 4588.059447813191, 4725.503822098699, 4749.240121580599, 4761.142994261067, 9207.355485115977, 9220.53897305132, 9221.262299016063, 9227.492487913096, 9238.722838314861, 5194.77922688168, 5291.444398338196, 5301.284326615858, 5302.416734159239, 5316.6544174628525, 4391.912161756747, 4601.148787474328, 4751.904961900743, 4861.683990540603, 4928.654994150446, 3199.6640352762624, 3697.149655579232, 3724.4413337999517, 3769.6041915598466, 3810.790406527612, 1037.823569993103, 1207.5471698113208, 1211.418519110814, 1223.0, 1239.1883316427754, 651.8989556618732, 790.7390561114819, 847.6228078505006, 859.4070091636751, 862.5988915154484, 5466.72666366688, 5503.587230957694, 5547.667139971614, 5799.797007104731, 5817.854553636108, 500.36453703795974, 503.8009986055487, 508.72528834428994, 519.8154655097461, 641.7689631732572, 3727.3849814780256, 3927.9803600981813, 4008.2985477541315, 4020.0, 4063.7358571693335, 9969.80060398788, 10373.377597344184, 10408.47957602117, 10530.36817790935, 10537.84193237102, 10340.965903409598, 10387.220958427997, 10485.842712359321, 10495.10791582724, 10496.265261431627, 7883.842323153504, 8206.425550211547, 8235.670573177125, 8245.79385515355, 8251.504909705316, 5554.97222513901, 5767.365589785204, 5841.0, 5916.26046744157, 5957.940420595912, 9389.906100938902, 9588.904110958802, 9677.22582193437, 9843.064908833649, 9855.556499957662, 7813.921860781319, 9410.294227932796, 9935.20518358544, 9939.701808945743, 9950.950245248727, 7199.0, 7562.470627056054, 7614.238576142563, 7622.466427350032, 7628.8855667163925, 7815.648295826588, 8108.716194933149, 8163.591820409075, 8255.587220638823, 8264.752057438287, 7242.203357630551, 7260.237675044255, 7356.632168391666, 7403.000594919832, 7439.0, 7071.398931090709, 7232.566046037255, 7304.123505179413, 7311.122665280201, 7433.331000210007, 6905.516613836983, 6988.056612357267, 6989.26612705679, 6991.2659170788365, 7004.649767511706, 4150.858513908699, 4402.877266297074, 4690.648201384842, 4942.061008408391, 4961.677490963076, 4752.120857641347, 4989.750512474435, 5035.16919708244, 5055.317532133115, 5066.138756411493], "value": 4447.446609411237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.26399174184274, 306.7055626598465, 312.21166554450014, 318.4157071773296, 324.41605110800555, 4322.459692538433, 5246.108161612526, 5299.283637562572, 5301.390340110893, 5347.786088556453, 3850.3261929162422, 4031.0, 4161.583841615837, 5286.7885284588665, 5287.524122828944, 3609.151849315409, 3827.636374544428, 3888.844446222162, 3932.2725295820364, 4002.0, 4000.659943904772, 4053.6217685986758, 4057.695672824535, 4074.9388759168637, 4084.813066606737, 3109.9844500777463, 3580.4629305604108, 3803.790791506466, 4020.211006102286, 4033.7983100844986, 3334.4664853623303, 3772.830422568985, 3813.3326667833157, 3881.961180388202, 4091.9156423547784, 3322.9532697200307, 3534.1871369584883, 3563.4120370138894, 3570.553680789901, 3581.8925432237074, 3914.921701565953, 4675.649326300541, 4822.348982887301, 5129.333186685707, 5135.460776618439, 4304.80628371724, 4596.7931443085145, 4619.8152073917, 4638.7733887734075, 4656.253904785705, 5027.542012816315, 5094.133997220481, 5570.220169176318, 5587.469190426903, 5624.21261023457, 3195.5526226328334, 3765.7363984521094, 3785.2240290740333, 3823.636754508317, 3848.9992601923423, 5190.71451070191, 5554.527865131468, 5806.564507661942, 5855.824325270249, 5860.212635146278, 3836.290286297044, 3841.193349396602, 3850.6919446444217, 3860.3630400983525, 3863.265979463949, 3559.9320203938714, 3664.340418724655, 3922.686185105185, 3928.705347098979, 3951.1110000249714, 4394.890127746768, 4555.954440455553, 4563.977180114144, 4575.977120114445, 4589.5639914208095, 5195.454477279831, 5537.252470916455, 5590.301212348457, 5605.467480589337, 5624.268845050117, 1224.3510939202238, 1333.4999375234288, 1424.7720364741592, 1427.964300892486, 1429.9428022879176, 761.9657115429819, 882.1266945723816, 902.6299217320998, 935.2891802230354, 955.2358113509165, 4612.74629895359, 4749.3588365570895, 5113.411957624847, 5171.560417364566, 5498.835034948958, 5087.3974697970025, 5604.0, 5796.246487956623, 5799.0, 5814.900495150909, 5169.0, 5227.26818245446, 5245.6852588844795, 5265.289185959923, 5285.920711189258, 3016.5475178722927, 3059.831709255968, 3148.275896543808, 3299.373119107362, 3299.6205436374644, 5999.250093738283, 6070.939290607126, 6199.783007594712, 6225.782097626561, 6550.246721626979, 5640.351359593699, 6156.538259630545, 6447.677616119176, 6448.387403196689, 6489.415952564292, 6147.385261473817, 6474.4496717778575, 6514.446272066927, 6515.641639709862, 6540.869182616226, 4348.978255108705, 6260.7495700171485, 6280.811575652738, 6295.496360291258, 6300.369963003663, 4787.0798812723515, 5505.642133261325, 5633.0987042073075, 5703.714814259353, 5734.741936612779, 5309.415964243853, 5792.565557583114, 5978.176656119926, 6017.224918649096, 6031.819045428644, 3276.9016929492154, 3442.6729460701195, 3650.324689932371, 3889.669378102893, 3915.647591716759, 4665.5567721066445, 5629.746661400329, 5737.368889422244, 5742.626729262584, 5760.510356619734, 5093.159628661229, 5215.895682086261, 5324.440933702061, 5595.440455954372, 5641.407652196624, 4752.500987396274, 5552.167174923794, 5572.498475137257, 5604.607677462538, 5620.016497113071, 4607.6083532900075, 5261.369315342329, 5446.537044351275, 5463.438029245624, 5515.0, 5442.210879422382, 5568.415316391721, 5584.86037849057, 5606.215129881902, 5618.971905140448, 5119.590432765444, 5199.4020687621405, 5454.536364409069, 5454.990826697073, 5455.263539422286], "value": 4103.2956899090495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.2390074357426, 653.6796969484952, 683.2689022745664, 699.6466784273941, 751.6429695894451, 12169.695757606065, 15038.473653422132, 15288.541343759705, 15290.464833730794, 15303.770443443358, 13937.58187254384, 13972.301384930739, 13980.440782368718, 14086.225257610828, 14092.506762263323, 905.8641203819446, 916.7341470973442, 917.9082091790801, 918.1094338491653, 919.8068405634825, 723.7539236659535, 742.7400409856534, 744.6053591596462, 746.0674157303371, 898.9505577193285, 771.645043280089, 918.0, 969.9321047526676, 972.0959507657875, 974.3179774158082, 963.9710808675751, 965.5317171171976, 965.5654955270121, 966.5022513405602, 966.5505539923934, 562.3308263166819, 580.4659713063949, 714.2143641993817, 716.5628966330535, 716.6201912986073, 12196.878031219663, 12278.815817762741, 13301.0, 13681.110727802761, 13770.311484425738, 12134.271943683407, 12181.208221465577, 12310.13829031968, 12406.883380495708, 12613.117081804277, 9730.708078757649, 9820.950895245478, 9874.260722628143, 9940.602375904955, 10231.948840255825, 3462.7056700180515, 3537.4870643756512, 3545.503629491873, 3550.609432962372, 3652.853885844563, 71476.64261678711, 72035.63982180107, 72098.27901720969, 72116.0, 72134.63932680356, 7767.844643107106, 8777.963022868067, 9174.449533028039, 9219.539023048821, 9353.204977576983, 20883.060262288232, 20942.581148376947, 21185.0, 21193.36419907405, 21213.15147394087, 7356.190819010012, 7449.851002980018, 7469.178390377054, 7559.659815308324, 7641.044869391326, 3929.25344184604, 3961.960380396159, 3987.641112299907, 3990.8204130814183, 4016.6184212499766, 3414.231797845465, 3487.163080860626, 3488.337215928965, 3493.3886569850683, 3494.371013217645, 644.8162273751958, 651.6155468273741, 652.2694582068019, 654.8366133041006, 658.2397331082607, 547.9863003424946, 569.6610516742614, 577.6591810831545, 595.1727099331932, 597.6354423801478, 7907.288344049063, 7972.800679982931, 8003.399745019147, 8106.432549721463, 8226.341892648574, 552.3178874090495, 576.3372122059582, 588.188300145796, 610.7282259394527, 618.7865186510646, 3488.354654388946, 3725.1990821972863, 3731.850725970985, 3865.903352416212, 3937.468441760383, 84591.15408845956, 86947.13052869517, 87327.56336218279, 87440.0, 94039.0, 75835.62082189663, 76838.07904802312, 77391.61304193556, 79380.0, 82051.25641704834, 69011.30988690049, 69376.95934560985, 69661.0, 69761.0, 70891.2910870895, 6812.25065242813, 7817.257360550739, 7918.129005809472, 8074.959625201836, 8564.400491965502, 35143.71565848211, 36592.81703591465, 36768.81615591905, 37115.44326835046, 37386.878393648236, 53066.73466632642, 53358.0, 53434.732826337175, 53579.46420535745, 53663.0, 10483.0, 11061.83407248908, 11104.61133860311, 11262.605808796981, 11307.208495405243, 11635.961900211876, 11674.649760507198, 11789.882101178879, 11842.76314473723, 12402.81395779082, 11065.502052407823, 11228.0, 11396.601118960796, 11997.76004479888, 12224.083193760682, 11174.720631984266, 11240.437978101227, 11352.545898164311, 11368.602098926498, 11468.31190128595, 11114.22200445961, 11197.0, 11420.600278990196, 11468.910453506904, 11721.531138754355, 9286.257099431894, 9516.095970882756, 9764.707058788248, 9957.20342372594, 10001.2999090063, 9354.485503297385, 9553.379030363005, 9592.136707696342, 9639.614415423584, 9656.75858103553], "value": 6646.6630982898005, "unit": "score"}], "name": "dromaeo_css", "value": 7014.974825810231, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 107.0, 112.0, 112.0, 112.0, 112.0, 110.0, 106.0, 156.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 144.0, 183.0, 170.0, 121.0, 145.0, 140.0, 122.0, 198.0, 145.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 255.0, 218.0, 224.0, 262.0, 183.0, 183.0, 184.0, 179.0, 186.0], "value": 206.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 93.0, 108.0, 61.0, 58.0, 57.0, 85.0, 116.0, 60.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 100.0, 137.0, 78.0, 78.0, 79.0, 125.0, 80.0, 77.0, 130.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 86.0, 88.0, 85.0, 89.0, 86.0, 90.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 101.0, 93.0, 94.0, 95.0, 95.0, 93.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 100.0, 83.0, 84.0, 85.0, 82.0, 86.0, 70.0, 135.0], "value": 89.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 59.0, 59.0, 59.0, 59.0, 78.0, 61.0, 58.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 70.0, 74.0, 74.0, 70.0, 68.0, 68.0, 68.0, 68.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 104.0, 108.0, 107.0, 82.0, 82.0, 82.0, 82.0, 82.0, 84.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 152.0, 137.0, 137.0, 134.0, 138.0, 134.0, 133.0, 177.0, 169.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 266.0, 219.0, 198.0, 197.0, 196.0, 208.0, 197.0, 201.0, 202.0], "value": 209.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 68.0, 73.0, 70.0, 70.0, 71.0, 73.0, 58.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1567.3999999999999, "alertThreshold": 2.0}]} 05:12:00 INFO - Return code: 0 05:12:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:00 ERROR - # TBPL SUCCESS # 05:12:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:12:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:12:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:12:00 INFO - 2016-04-28 05:12:00.973 screenresolution[1947:18165] starting screenresolution argv=screenresolution get 05:12:00 INFO - 2016-04-28 05:12:00.975 screenresolution[1947:18165] Display 0: 1600x1200x32@60 05:12:00 INFO - 2016-04-28 05:12:00.982 screenresolution[1948:18168] starting screenresolution argv=screenresolution list 05:12:00 INFO - Available Modes on Display 0 05:12:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:12:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:12:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:12:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:12:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:12:01 INFO - Intel Iris: 05:12:01 INFO - Chipset Model: Intel Iris 05:12:01 INFO - Type: GPU 05:12:01 INFO - Bus: Built-In 05:12:01 INFO - VRAM (Dynamic, Max): 1536 MB 05:12:01 INFO - Vendor: Intel (0x8086) 05:12:01 INFO - Device ID: 0x0a2e 05:12:01 INFO - Revision ID: 0x0009 05:12:01 INFO - Displays: 05:12:01 INFO - Display: 05:12:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:12:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:12:01 INFO - Display Serial Number: 1600x1200 60 05:12:01 INFO - Main Display: Yes 05:12:01 INFO - Mirror: Off 05:12:01 INFO - Online: Yes 05:12:01 INFO - Rotation: Supported 05:12:01 INFO - Return code: 0 05:12:01 INFO - Running post-action listener: _resource_record_post_action 05:12:01 INFO - Running post-run listener: _resource_record_post_run 05:12:02 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 729088; Write bytes: 695291392; Read time: 9; Write time: 1951 05:12:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 380574208; Write bytes: 375010816; Read time: 28917; Write time: 772 05:12:02 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 729088; Write bytes: 297080832; Read time: 9; Write time: 1131 05:12:02 INFO - Running post-run listener: _upload_blobber_files 05:12:02 INFO - Blob upload gear active. 05:12:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:02 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 05:12:02 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:12:02 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:12:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:12:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:12:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:03 INFO - (blobuploader) - INFO - Done attempting. 05:12:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:12:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:05 INFO - (blobuploader) - INFO - Done attempting. 05:12:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:12:05 INFO - Return code: 0 05:12:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:12:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:12:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac94d9050649db95ce82d3f92672acf5792538f129630fa6dbcf0c7fb13ade87c03c3b9d559b86d63ab80cf42e18c012a13d8d0d6fc6bacdbf6236f0fb813c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4a1face4fd02ad572fdfd279bdd90a68697274eadc3091147d1a7d3c10e539953e3301df0ce0eb64f2f0714f66aa6dd7126d541086acdedf915a6a7ecf843c3"} 05:12:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:12:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:12:05 INFO - Contents: 05:12:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac94d9050649db95ce82d3f92672acf5792538f129630fa6dbcf0c7fb13ade87c03c3b9d559b86d63ab80cf42e18c012a13d8d0d6fc6bacdbf6236f0fb813c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4a1face4fd02ad572fdfd279bdd90a68697274eadc3091147d1a7d3c10e539953e3301df0ce0eb64f2f0714f66aa6dd7126d541086acdedf915a6a7ecf843c3"} 05:12:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:12:05 INFO - Copying logs to upload dir... 05:12:05 INFO - mkdir: /builds/slave/test/build/upload/logs 05:12:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.928296 ========= master_lag: 8.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-04-28 05:12:14.145900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-28 05:12:14.153064) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac94d9050649db95ce82d3f92672acf5792538f129630fa6dbcf0c7fb13ade87c03c3b9d559b86d63ab80cf42e18c012a13d8d0d6fc6bacdbf6236f0fb813c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4a1face4fd02ad572fdfd279bdd90a68697274eadc3091147d1a7d3c10e539953e3301df0ce0eb64f2f0714f66aa6dd7126d541086acdedf915a6a7ecf843c3"} build_url:https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/Sc_EnA_2RCSswqBtZ5hKxw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac94d9050649db95ce82d3f92672acf5792538f129630fa6dbcf0c7fb13ade87c03c3b9d559b86d63ab80cf42e18c012a13d8d0d6fc6bacdbf6236f0fb813c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4a1face4fd02ad572fdfd279bdd90a68697274eadc3091147d1a7d3c10e539953e3301df0ce0eb64f2f0714f66aa6dd7126d541086acdedf915a6a7ecf843c3"}' ========= master_lag: 8.49 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-28 05:12:22.656476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2016-04-28 05:12:22.656758) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z8LH4L5X9w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.LVwSWEwcXg/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005176 ========= master_lag: 19.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2016-04-28 05:12:42.257310) ========= ========= Started reboot skipped (results: 3, elapsed: 8 secs) (at 2016-04-28 05:12:42.257587) ========= ========= Finished reboot skipped (results: 3, elapsed: 8 secs) (at 2016-04-28 05:12:50.414910) ========= ========= Total master_lag: 37.13 =========