builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1448308344.23 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.227116) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.227589) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.227906) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005915 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.248851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.249149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.263367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.263739) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005271 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.312185) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.312539) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.312882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.313146) ========= 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.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 --2015-11-23 11:52:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.26M=0.001s 2015-11-23 11:52:24 (8.26 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.426357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.426681) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.019810 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:24.476759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 11:52:24.477338) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 2015-11-23 11:52:24,567 truncating revision to first 12 chars 2015-11-23 11:52:24,567 Setting DEBUG logging. 2015-11-23 11:52:24,567 attempt 1/10 2015-11-23 11:52:24,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:52:26,108 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.777409 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 11:52:26.269677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:26.269990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:26.281141) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:26.281506) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:52:26.281929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 11:52:26.282207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:52:26 INFO - MultiFileLogger online at 20151123 11:52:26 in /builds/slave/test 11:52:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:52:26 INFO - {'append_to_log': False, 11:52:26 INFO - 'base_work_dir': '/builds/slave/test', 11:52:26 INFO - 'blob_upload_branch': 'Fx-Team', 11:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:52:26 INFO - 'branch': 'Fx-Team', 11:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:52:26 INFO - 'config_files': ('talos/mac_config.py',), 11:52:26 INFO - 'default_actions': ('clobber', 11:52:26 INFO - 'read-buildbot-config', 11:52:26 INFO - 'download-and-extract', 11:52:26 INFO - 'populate-webroot', 11:52:26 INFO - 'create-virtualenv', 11:52:26 INFO - 'install', 11:52:26 INFO - 'run-tests'), 11:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:52:26 INFO - 'download_minidump_stackwalk': True, 11:52:26 INFO - 'download_symbols': 'ondemand', 11:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:52:26 INFO - 'installer_path': 'installer.exe', 11:52:26 INFO - 'log_level': 'info', 11:52:26 INFO - 'log_name': 'talos', 11:52:26 INFO - 'log_to_console': True, 11:52:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:52:26 INFO - 'opt_config_files': (), 11:52:26 INFO - 'pip_index': False, 11:52:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:52:26 INFO - 'cmd': ('bash', 11:52:26 INFO - '-c', 11:52:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:52:26 INFO - 'enabled': True, 11:52:26 INFO - 'halt_on_failure': False, 11:52:26 INFO - 'name': 'check_screen_resolution'},), 11:52:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:52:26 INFO - 'cmd': ('bash', 11:52:26 INFO - '-c', 11:52:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:52:26 INFO - 'enabled': True, 11:52:26 INFO - 'halt_on_failure': False, 11:52:26 INFO - 'name': 'check_screen_resolution'},), 11:52:26 INFO - 'run_cmd_checks_enabled': True, 11:52:26 INFO - 'sps_profile': False, 11:52:26 INFO - 'sps_profile_interval': 0, 11:52:26 INFO - 'suite': 'dromaeojs', 11:52:26 INFO - 'system_bits': '64', 11:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:52:26 INFO - 'title': 't-yosemite-r7-0013', 11:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:52:26 INFO - 'use_talos_json': True, 11:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:52:26 INFO - 'work_dir': 'build'} 11:52:26 INFO - ##### 11:52:26 INFO - ##### Running clobber step. 11:52:26 INFO - ##### 11:52:26 INFO - Running pre-action listener: _resource_record_pre_action 11:52:26 INFO - Running main action method: clobber 11:52:26 INFO - rmtree: /builds/slave/test/build 11:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:52:27 INFO - Running post-action listener: _resource_record_post_action 11:52:27 INFO - ##### 11:52:27 INFO - ##### Running read-buildbot-config step. 11:52:27 INFO - ##### 11:52:27 INFO - Running pre-action listener: _resource_record_pre_action 11:52:27 INFO - Running main action method: read_buildbot_config 11:52:27 INFO - Using buildbot properties: 11:52:27 INFO - { 11:52:27 INFO - "properties": { 11:52:27 INFO - "buildnumber": 7, 11:52:27 INFO - "product": "firefox", 11:52:27 INFO - "script_repo_revision": "production", 11:52:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:52:27 INFO - "repository": "", 11:52:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:52:27 INFO - "buildid": "20151123050554", 11:52:27 INFO - "slavename": "t-yosemite-r7-0013", 11:52:27 INFO - "pgo_build": "False", 11:52:27 INFO - "basedir": "/builds/slave/test", 11:52:27 INFO - "project": "", 11:52:27 INFO - "platform": "yosemite_r7", 11:52:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:52:27 INFO - "slavebuilddir": "test", 11:52:27 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:52:27 INFO - "branch": "fx-team", 11:52:27 INFO - "repo_path": "integration/fx-team", 11:52:27 INFO - "stage_platform": "macosx64", 11:52:27 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:52:27 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:52:27 INFO - }, 11:52:27 INFO - "sourcestamp": { 11:52:27 INFO - "repository": "", 11:52:27 INFO - "hasPatch": false, 11:52:27 INFO - "project": "", 11:52:27 INFO - "branch": "fx-team-macosx64-talos", 11:52:27 INFO - "changes": [ 11:52:27 INFO - { 11:52:27 INFO - "category": null, 11:52:27 INFO - "files": [ 11:52:27 INFO - { 11:52:27 INFO - "url": null, 11:52:27 INFO - "name": "https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:52:27 INFO - } 11:52:27 INFO - ], 11:52:27 INFO - "repository": "", 11:52:27 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:52:27 INFO - "who": "pbrosset@mozilla.com", 11:52:27 INFO - "when": 1448289287, 11:52:27 INFO - "number": 6695012, 11:52:27 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:52:27 INFO - "project": "", 11:52:27 INFO - "at": "Mon 23 Nov 2015 06:34:47", 11:52:27 INFO - "branch": "fx-team-macosx64-talos", 11:52:27 INFO - "revlink": "", 11:52:27 INFO - "properties": [ 11:52:27 INFO - [ 11:52:27 INFO - "buildid", 11:52:27 INFO - "20151123050554", 11:52:27 INFO - "Change" 11:52:27 INFO - ], 11:52:27 INFO - [ 11:52:27 INFO - "builduid", 11:52:27 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:52:27 INFO - "Change" 11:52:27 INFO - ], 11:52:27 INFO - [ 11:52:27 INFO - "pgo_build", 11:52:27 INFO - "False", 11:52:27 INFO - "Change" 11:52:27 INFO - ] 11:52:27 INFO - ], 11:52:27 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:52:27 INFO - } 11:52:27 INFO - ], 11:52:27 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:52:27 INFO - } 11:52:27 INFO - } 11:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:52:27 INFO - Running post-action listener: _resource_record_post_action 11:52:27 INFO - ##### 11:52:27 INFO - ##### Running download-and-extract step. 11:52:27 INFO - ##### 11:52:27 INFO - Running pre-action listener: _resource_record_pre_action 11:52:27 INFO - Running main action method: download_and_extract 11:52:27 INFO - mkdir: /builds/slave/test/build/tests 11:52:27 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')]} 11:52:27 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json 11:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json 11:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:52:28 INFO - Downloaded 1149 bytes. 11:52:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:52:28 INFO - Using the following test package requirements: 11:52:28 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:52:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:52:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'jsshell-mac.zip'], 11:52:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:52:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:52:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:52:28 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:52:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:52:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:52:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:52:28 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:52:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:28 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:52:29 INFO - Downloaded 17525254 bytes. 11:52:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:52:32 INFO - Return code: 0 11:52:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:32 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:52:33 INFO - Downloaded 17525254 bytes. 11:52:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:52:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:52:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:52:36 INFO - Return code: 0 11:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:36 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:52:37 INFO - Downloaded 11130997 bytes. 11:52:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 11:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:52:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:52:38 INFO - Return code: 0 11:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:38 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 11:52:41 INFO - Downloaded 109634929 bytes. 11:52:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:52:41 INFO - mkdir: /builds/slave/test/properties 11:52:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:52:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:52:41 INFO - Contents: 11:52:41 INFO - build_url:https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:52:41 INFO - Running post-action listener: _resource_record_post_action 11:52:41 INFO - Running post-action listener: set_extra_try_arguments 11:52:41 INFO - ##### 11:52:41 INFO - ##### Running populate-webroot step. 11:52:41 INFO - ##### 11:52:41 INFO - Running pre-action listener: _resource_record_pre_action 11:52:41 INFO - Running main action method: populate_webroot 11:52:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:52:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:52:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:52:41 INFO - '../fennec_ids.txt'], 11:52:41 INFO - 'tests': ['tcheck2']}, 11:52:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:52:41 INFO - '--tppagecycles', 11:52:41 INFO - '7'], 11:52:41 INFO - 'tests': ['tsvgm']}}, 11:52:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:52:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:52:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:52:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:52:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:52:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:52:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'tests': ['damp', 'tps']}, 11:52:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['damp', 'tps']}, 11:52:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:52:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:52:41 INFO - 'other': {'tests': ['a11yr', 11:52:41 INFO - 'ts_paint', 11:52:41 INFO - 'tpaint', 11:52:41 INFO - 'sessionrestore', 11:52:41 INFO - 'sessionrestore_no_auto_restore']}, 11:52:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['a11yr', 11:52:41 INFO - 'ts_paint', 11:52:41 INFO - 'tpaint', 11:52:41 INFO - 'sessionrestore', 11:52:41 INFO - 'sessionrestore_no_auto_restore']}, 11:52:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['a11yr', 11:52:41 INFO - 'ts_paint', 11:52:41 INFO - 'tpaint', 11:52:41 INFO - 'sessionrestore', 11:52:41 INFO - 'sessionrestore_no_auto_restore']}, 11:52:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['a11yr', 11:52:41 INFO - 'ts_paint', 11:52:41 INFO - 'tpaint', 11:52:41 INFO - 'sessionrestore', 11:52:41 INFO - 'sessionrestore_no_auto_restore']}, 11:52:41 INFO - 'other_l64': {'tests': ['a11yr', 11:52:41 INFO - 'ts_paint', 11:52:41 INFO - 'tpaint', 11:52:41 INFO - 'sessionrestore', 11:52:41 INFO - 'sessionrestore_no_auto_restore']}, 11:52:41 INFO - 'other_nol64': {'tests': ['a11yr', 11:52:41 INFO - 'ts_paint', 11:52:41 INFO - 'tpaint', 11:52:41 INFO - 'sessionrestore', 11:52:41 INFO - 'sessionrestore_no_auto_restore']}, 11:52:41 INFO - 'svgr': {'tests': ['tsvgx', 11:52:41 INFO - 'tsvgr_opacity', 11:52:41 INFO - 'tart', 11:52:41 INFO - 'tscrollx', 11:52:41 INFO - 'cart']}, 11:52:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['tsvgx', 11:52:41 INFO - 'tsvgr_opacity', 11:52:41 INFO - 'tart', 11:52:41 INFO - 'tscrollx', 11:52:41 INFO - 'cart']}, 11:52:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'tests': ['tp5o']}, 11:52:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'talos_options': ['--e10s'], 11:52:41 INFO - 'tests': ['tp5o']}, 11:52:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'talos_options': ['--xperf_path', 11:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:52:41 INFO - 'tests': ['tp5n']}, 11:52:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:52:41 INFO - 'talos_options': ['--e10s', 11:52:41 INFO - '--xperf_path', 11:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:52:41 INFO - 'tests': ['tp5n']}}, 11:52:41 INFO - 'talos.zip': {'path': '', 11:52:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:52:41 INFO - Running post-action listener: _resource_record_post_action 11:52:41 INFO - ##### 11:52:41 INFO - ##### Running create-virtualenv step. 11:52:41 INFO - ##### 11:52:41 INFO - Running pre-action listener: _resource_record_pre_action 11:52:41 INFO - Running main action method: create_virtualenv 11:52:41 INFO - Creating virtualenv /builds/slave/test/build/venv 11:52:41 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 11:52:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:52:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:52:41 INFO - Using real prefix '/tools/python27' 11:52:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:52:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:52:45 INFO - Installing pip.................done. 11:52:45 INFO - Return code: 0 11:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:52:45 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')]} 11:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:45 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')]} 11:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 11:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:45 INFO - 'HOME': '/Users/cltbld', 11:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:45 INFO - 'LOGNAME': 'cltbld', 11:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:45 INFO - 'MOZ_NO_REMOTE': '1', 11:52:45 INFO - 'NO_EM_RESTART': '1', 11:52:45 INFO - 'PAGER': '/bin/cat', 11:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:45 INFO - 'PWD': '/builds/slave/test', 11:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:45 INFO - 'SHELL': '/bin/bash', 11:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:52:45 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:45 INFO - 'USER': 'cltbld', 11:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:45 INFO - 'XPC_FLAGS': '0x0', 11:52:45 INFO - 'XPC_SERVICE_NAME': '0', 11:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:45 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 11:52:45 INFO - Cleaning up... 11:52:45 INFO - Return code: 0 11:52:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:52:45 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')]} 11:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:45 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')]} 11:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 11:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:45 INFO - 'HOME': '/Users/cltbld', 11:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:45 INFO - 'LOGNAME': 'cltbld', 11:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:45 INFO - 'MOZ_NO_REMOTE': '1', 11:52:45 INFO - 'NO_EM_RESTART': '1', 11:52:45 INFO - 'PAGER': '/bin/cat', 11:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:45 INFO - 'PWD': '/builds/slave/test', 11:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:45 INFO - 'SHELL': '/bin/bash', 11:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:52:45 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:45 INFO - 'USER': 'cltbld', 11:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:45 INFO - 'XPC_FLAGS': '0x0', 11:52:45 INFO - 'XPC_SERVICE_NAME': '0', 11:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:45 INFO - Downloading/unpacking psutil>=0.7.1 11:52: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 11:52: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 11:52: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 11:52: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 11:52: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 11:52: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 11:52:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:52:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:52:48 INFO - Installing collected packages: psutil 11:52:48 INFO - Running setup.py install for psutil 11:52:48 INFO - building 'psutil._psutil_osx' extension 11:52:48 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 11:52:48 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 11:52:48 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 11:52:48 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 11:52:48 INFO - building 'psutil._psutil_posix' extension 11:52:48 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 11:52:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:52:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:52:48 INFO - ^ 11:52:48 INFO - 1 warning generated. 11:52:48 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 11:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:52:48 INFO - Successfully installed psutil 11:52:48 INFO - Cleaning up... 11:52:48 INFO - Return code: 0 11:52:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 11:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:48 INFO - 'HOME': '/Users/cltbld', 11:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:48 INFO - 'LOGNAME': 'cltbld', 11:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:48 INFO - 'MOZ_NO_REMOTE': '1', 11:52:48 INFO - 'NO_EM_RESTART': '1', 11:52:48 INFO - 'PAGER': '/bin/cat', 11:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:48 INFO - 'PWD': '/builds/slave/test', 11:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:48 INFO - 'SHELL': '/bin/bash', 11:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:52:48 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:48 INFO - 'USER': 'cltbld', 11:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:48 INFO - 'XPC_FLAGS': '0x0', 11:52:48 INFO - 'XPC_SERVICE_NAME': '0', 11:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:52:51 INFO - Installing collected packages: mozsystemmonitor 11:52:51 INFO - Running setup.py install for mozsystemmonitor 11:52:51 INFO - Successfully installed mozsystemmonitor 11:52:51 INFO - Cleaning up... 11:52:51 INFO - Return code: 0 11:52:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:52:51 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')]} 11:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:51 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')]} 11:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 11:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:51 INFO - 'HOME': '/Users/cltbld', 11:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:51 INFO - 'LOGNAME': 'cltbld', 11:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:51 INFO - 'MOZ_NO_REMOTE': '1', 11:52:51 INFO - 'NO_EM_RESTART': '1', 11:52:51 INFO - 'PAGER': '/bin/cat', 11:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:51 INFO - 'PWD': '/builds/slave/test', 11:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:51 INFO - 'SHELL': '/bin/bash', 11:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:52:51 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:51 INFO - 'USER': 'cltbld', 11:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:51 INFO - 'XPC_FLAGS': '0x0', 11:52:51 INFO - 'XPC_SERVICE_NAME': '0', 11:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 11:52:51 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 11:52:51 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 11:52:51 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 11:52:51 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 11:52:51 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 11:52:51 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 11:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:52:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:55 INFO - Downloading docopt-0.6.1.tar.gz 11:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:52:55 INFO - Running setup.py install for blobuploader 11:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:52:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:52:55 INFO - Running setup.py install for requests 11:52:55 INFO - Running setup.py install for docopt 11:52:56 INFO - Successfully installed blobuploader requests docopt 11:52:56 INFO - Cleaning up... 11:52:56 INFO - Return code: 0 11:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:56 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')]} 11:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:56 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')]} 11:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 11:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:56 INFO - 'HOME': '/Users/cltbld', 11:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:56 INFO - 'LOGNAME': 'cltbld', 11:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:56 INFO - 'MOZ_NO_REMOTE': '1', 11:52:56 INFO - 'NO_EM_RESTART': '1', 11:52:56 INFO - 'PAGER': '/bin/cat', 11:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:56 INFO - 'PWD': '/builds/slave/test', 11:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:56 INFO - 'SHELL': '/bin/bash', 11:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:52:56 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:56 INFO - 'USER': 'cltbld', 11:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:56 INFO - 'XPC_FLAGS': '0x0', 11:52:56 INFO - 'XPC_SERVICE_NAME': '0', 11:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-JMbfVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nGrlLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AWfrgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XLC7N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-l65J50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hlLzec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-DhHIKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ggrz5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-HFeLrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Kq_KtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-m7yiAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6bD9gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-5hoRLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-JqnIbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-INBEIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Sou6Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-gtWbVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:52:58 INFO - Running setup.py install for manifestparser 11:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:52:58 INFO - Running setup.py install for mozcrash 11:52:58 INFO - Running setup.py install for mozdebug 11:52:58 INFO - Running setup.py install for mozdevice 11:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:52:58 INFO - Running setup.py install for mozfile 11:52:58 INFO - Running setup.py install for mozhttpd 11:52:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Running setup.py install for mozinfo 11:52:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Running setup.py install for mozInstall 11:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Running setup.py install for mozleak 11:52:59 INFO - Running setup.py install for mozlog 11:52:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Running setup.py install for moznetwork 11:52:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:52:59 INFO - Running setup.py install for mozprocess 11:52:59 INFO - Running setup.py install for mozprofile 11:53:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:53:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:53:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:53:00 INFO - Running setup.py install for mozrunner 11:53:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:53:00 INFO - Running setup.py install for mozscreenshot 11:53:00 INFO - Running setup.py install for moztest 11:53:00 INFO - Running setup.py install for mozversion 11:53:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:53:00 INFO - Cleaning up... 11:53:00 INFO - Return code: 0 11:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 11:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:00 INFO - 'HOME': '/Users/cltbld', 11:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:00 INFO - 'LOGNAME': 'cltbld', 11:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:00 INFO - 'MOZ_NO_REMOTE': '1', 11:53:00 INFO - 'NO_EM_RESTART': '1', 11:53:00 INFO - 'PAGER': '/bin/cat', 11:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:00 INFO - 'PWD': '/builds/slave/test', 11:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:00 INFO - 'SHELL': '/bin/bash', 11:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:53:00 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:00 INFO - 'USER': 'cltbld', 11:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:00 INFO - 'XPC_FLAGS': '0x0', 11:53:00 INFO - 'XPC_SERVICE_NAME': '0', 11:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:00 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-K_dHhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-01QaML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-PKNmI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-asGVGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Svos5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pUd92T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-E10MyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-_CmRIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-gyeZJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:01 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)) 11:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1htsN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-7JkgEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:02 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ElKNod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:02 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-QrlKUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-4mKZhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:02 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-kS1Hpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:02 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-q8FeJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:02 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)) 11:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-fX6c4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:02 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)) 11:53:02 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:53:02 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:53:02 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)) 11:53:02 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:53:02 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:53:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:53:02 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 11:53:02 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 11:53:02 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 11:53:02 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 11:53:02 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 11:53:02 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 11:53:04 INFO - Downloading blessings-1.5.1.tar.gz 11:53:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:53:04 INFO - Installing collected packages: blessings 11:53:04 INFO - Running setup.py install for blessings 11:53:05 INFO - Successfully installed blessings 11:53:05 INFO - Cleaning up... 11:53:05 INFO - Return code: 0 11:53:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:05 INFO - Reading from file tmpfile_stdout 11:53:05 INFO - Current package versions: 11:53:05 INFO - blessings == 1.5.1 11:53:05 INFO - blobuploader == 1.2.4 11:53:05 INFO - docopt == 0.6.1 11:53:05 INFO - manifestparser == 1.1 11:53:05 INFO - mozInstall == 1.12 11:53:05 INFO - mozcrash == 0.16 11:53:05 INFO - mozdebug == 0.1 11:53:05 INFO - mozdevice == 0.47 11:53:05 INFO - mozfile == 1.2 11:53:05 INFO - mozhttpd == 0.7 11:53:05 INFO - mozinfo == 0.9 11:53:05 INFO - mozleak == 0.1 11:53:05 INFO - mozlog == 3.0 11:53:05 INFO - moznetwork == 0.27 11:53:05 INFO - mozprocess == 0.22 11:53:05 INFO - mozprofile == 0.27 11:53:05 INFO - mozrunner == 6.11 11:53:05 INFO - mozscreenshot == 0.1 11:53:05 INFO - mozsystemmonitor == 0.0 11:53:05 INFO - moztest == 0.7 11:53:05 INFO - mozversion == 1.4 11:53:05 INFO - psutil == 3.1.1 11:53:05 INFO - requests == 1.2.3 11:53:05 INFO - wsgiref == 0.1.2 11:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b40a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe20482250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, '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.xERTFXUZDI/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.7bb92KRoD1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 11:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 11:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:05 INFO - 'HOME': '/Users/cltbld', 11:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:05 INFO - 'LOGNAME': 'cltbld', 11:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:05 INFO - 'MOZ_NO_REMOTE': '1', 11:53:05 INFO - 'NO_EM_RESTART': '1', 11:53:05 INFO - 'PAGER': '/bin/cat', 11:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:05 INFO - 'PWD': '/builds/slave/test', 11:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:05 INFO - 'SHELL': '/bin/bash', 11:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:53:05 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:05 INFO - 'USER': 'cltbld', 11:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:05 INFO - 'XPC_FLAGS': '0x0', 11:53:05 INFO - 'XPC_SERVICE_NAME': '0', 11:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:05 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 1)) 11:53:05 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 2)) 11:53:05 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 3)) 11:53:05 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 4)) 11:53:05 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 5)) 11:53:05 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 6)) 11:53:05 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 7)) 11:53:05 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 8)) 11:53:05 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:53:05 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 3)) 11:53:05 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:53:05 INFO - Cleaning up... 11:53:05 INFO - Return code: 0 11:53:05 INFO - Running post-action listener: _resource_record_post_action 11:53:05 INFO - Running post-action listener: _start_resource_monitoring 11:53:05 INFO - Starting resource monitoring. 11:53:05 INFO - ##### 11:53:05 INFO - ##### Running install step. 11:53:05 INFO - ##### 11:53:05 INFO - Running pre-action listener: _resource_record_pre_action 11:53:05 INFO - Running main action method: install 11:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:06 INFO - Reading from file tmpfile_stdout 11:53:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:53:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:53:06 INFO - Reading from file tmpfile_stdout 11:53:06 INFO - Output received: 11:53:06 INFO - Usage: mozinstall [options] installer 11:53:06 INFO - Options: 11:53:06 INFO - -h, --help show this help message and exit 11:53:06 INFO - -d DEST, --destination=DEST 11:53:06 INFO - Directory to install application into. [default: 11:53:06 INFO - "/builds/slave/test"] 11:53:06 INFO - --app=APP Application being installed. [default: firefox] 11:53:06 INFO - mkdir: /builds/slave/test/build/application 11:53:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:53:37 INFO - Reading from file tmpfile_stdout 11:53:37 INFO - Output received: 11:53:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:53:37 INFO - Running post-action listener: _resource_record_post_action 11:53:37 INFO - ##### 11:53:37 INFO - ##### Running run-tests step. 11:53:37 INFO - ##### 11:53:37 INFO - Running pre-action listener: _resource_record_pre_action 11:53:37 INFO - Running main action method: run_tests 11:53:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:53:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:53:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:53:37 INFO - 2015-11-23 11:53:37.401 screenresolution[2226:16939] starting screenresolution argv=screenresolution get 11:53:37 INFO - 2015-11-23 11:53:37.403 screenresolution[2226:16939] Display 0: 1600x1200x32@60 11:53:37 INFO - 2015-11-23 11:53:37.410 screenresolution[2227:16941] starting screenresolution argv=screenresolution list 11:53:37 INFO - Available Modes on Display 0 11:53:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:53:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:53:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:53:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:53:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:53:37 INFO - Intel Iris: 11:53:37 INFO - Chipset Model: Intel Iris 11:53:37 INFO - Type: GPU 11:53:37 INFO - Bus: Built-In 11:53:37 INFO - VRAM (Dynamic, Max): 1536 MB 11:53:37 INFO - Vendor: Intel (0x8086) 11:53:37 INFO - Device ID: 0x0a2e 11:53:37 INFO - Revision ID: 0x0009 11:53:37 INFO - Displays: 11:53:37 INFO - Display: 11:53:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:53:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:53:37 INFO - Display Serial Number: 1600x1200 60 11:53:37 INFO - Main Display: Yes 11:53:37 INFO - Mirror: Off 11:53:37 INFO - Online: Yes 11:53:37 INFO - Rotation: Supported 11:53:37 INFO - Return code: 0 11:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:53:37 INFO - Python 2.7.3 11:53:37 INFO - Return code: 0 11:53:37 INFO - grabbing minidump binary from tooltool 11:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:37 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 0x10b32e9f0>, '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 0x10b08ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3218c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:53:37 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 11:53:37 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 11:53:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:53:37 INFO - Return code: 0 11:53:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:53:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:53:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:53:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:53:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost'] in /builds/slave/test/build 11:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --webServer localhost 11:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xERTFXUZDI/Render', 11:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:37 INFO - 'HOME': '/Users/cltbld', 11:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:37 INFO - 'LOGNAME': 'cltbld', 11:53:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:53:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:37 INFO - 'MOZ_NO_REMOTE': '1', 11:53:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:53:37 INFO - 'NO_EM_RESTART': '1', 11:53:37 INFO - 'PAGER': '/bin/cat', 11:53:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:37 INFO - 'PWD': '/builds/slave/test', 11:53:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:37 INFO - 'SHELL': '/bin/bash', 11:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7bb92KRoD1/Listeners', 11:53:37 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:37 INFO - 'USER': 'cltbld', 11:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:37 INFO - 'XPC_FLAGS': '0x0', 11:53:37 INFO - 'XPC_SERVICE_NAME': '0', 11:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost'] with output_timeout 3600 11:53:37 INFO - mozversion INFO | application_buildid: 20151123050554 11:53:37 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:53:37 INFO - mozversion INFO | application_display_name: Nightly 11:53:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:53:37 INFO - mozversion INFO | application_name: Firefox 11:53:37 INFO - mozversion INFO | application_remotingname: firefox 11:53:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:53:37 INFO - mozversion INFO | application_vendor: Mozilla 11:53:37 INFO - mozversion INFO | application_version: 45.0a1 11:53:37 INFO - mozversion INFO | platform_buildid: 20151123050554 11:53:37 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:53:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:53:37 INFO - mozversion INFO | platform_version: 45.0a1 11:53:37 INFO - 2015-11-23 11:53:37,959 DEBUG : using testdate: 1448308417 11:53:37 INFO - 2015-11-23 11:53:37,959 DEBUG : actual date: 1448308417 11:53:38 INFO - 2015-11-23 11:53:38,342 INFO : starting webserver on 'localhost:49755' 11:53:38 INFO - 2015-11-23 11:53:38,343 INFO : Starting test suite t-yosemite-r7-0013 11:53:38 INFO - 2015-11-23 11:53:38,343 INFO : Starting test dromaeo_css 11:53:38 INFO - 2015-11-23 11:53:38,343 DEBUG : operating with platform_type : mac_ 11:53:38 INFO - 2015-11-23 11:53:38,344 INFO : Initialising browser for dromaeo_css test... 11:53:38 INFO - 2015-11-23 11:53:38,356 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpivFccX/profile http://localhost:49755/getInfo.html 11:53:40 INFO - 2015-11-23 11:53:40,509 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:53:40 INFO - 2015-11-23 11:53:40,509 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:53:40 INFO - 2015-11-23 11:53:40,509 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:53:40 INFO - 2015-11-23 11:53:40,509 DEBUG : BROWSER_OUTPUT: __metrics 11:53:40 INFO - 2015-11-23 11:53:40,524 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:53:41 INFO - 2015-11-23 11:53:41,183 INFO : Browser initialized. 11:53:41 INFO - 2015-11-23 11:53:41,183 INFO : Running cycle 1/1 for dromaeo_css test... 11:53:41 INFO - 2015-11-23 11:53:41,183 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpivFccX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:53:52 INFO - 2015-11-23 11:53:52,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 224280576 11:53:52 INFO - 2015-11-23 11:53:52,976 DEBUG : BROWSER_OUTPUT: 11:54:43 INFO - 2015-11-23 11:54:43,965 DEBUG : BROWSER_OUTPUT: 1448308483962 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] 11:56:56 INFO - 2015-11-23 11:56:56,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49755/tests/dromaeo/cssquery-ext.html) 11:56:57 INFO - 2015-11-23 11:56:57,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 380448768 11:56:57 INFO - 2015-11-23 11:56:57,623 DEBUG : BROWSER_OUTPUT: 12:00:00 INFO - 2015-11-23 12:00:00,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-ext.html (next: http://localhost:49755/tests/dromaeo/cssquery-jquery.html) 12:00:00 INFO - 2015-11-23 12:00:00,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 359510016 12:00:00 INFO - 2015-11-23 12:00:00,935 DEBUG : BROWSER_OUTPUT: 12:03:03 INFO - 2015-11-23 12:03:03,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49755/tests/dromaeo/cssquery-mootools.html) 12:03:03 INFO - 2015-11-23 12:03:03,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 334139392 12:03:03 INFO - 2015-11-23 12:03:03,661 DEBUG : BROWSER_OUTPUT: 12:06:05 INFO - 2015-11-23 12:06:05,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49755/tests/dromaeo/cssquery-prototype.html) 12:06:06 INFO - 2015-11-23 12:06:06,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 317349888 12:06:06 INFO - 2015-11-23 12:06:06,298 DEBUG : BROWSER_OUTPUT: 12:09:09 INFO - 2015-11-23 12:09:09,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49755/tests/dromaeo/cssquery-yui.html) 12:09:09 INFO - 2015-11-23 12:09:09,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 319438848 12:09:09 INFO - 2015-11-23 12:09:09,972 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-yui.html (next: http://localhost:49755/tests/dromaeo/cssquery-dojo.html) 12:12:12 INFO - 2015-11-23 12:12:12,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 397869056 12:12:12 INFO - 2015-11-23 12:12:12,702 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,702 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:12:12 INFO - 2015-11-23 12:12:12,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:12:12 INFO - 2015-11-23 12:12:12,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:12:12 INFO - 2015-11-23 12:12:12,702 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:12:12 INFO - 2015-11-23 12:12:12,706 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3440.415129427997;3500.8599656013753;3504.0889368764115;3529.5411596492454;3570.8750193743226;5826.4173582641715;5971.641701497902;6018.217631707877;6047.395260473951;6097.085437184419;5973.074173503103;6062.363451837559;6063.787767428141;6070.635761854281;6071.332153463116;5370.838874833751;5396.973015134919;5412.702301373423;5429.077056900317;5510.311211098613;4569.47451043131;4897.897972956092;5203.4536373680785;5474.014677358074;5487.341519017724;5472.151816468454;5473.808416705416;5475.589330800186;5482.753276102565;5482.780688772445;5449.83650490484;5471.06991811393;5473.534749546293;5476.863078423071;5478.863028424302;5285.418603953562;5342.652727572734;5343.759530821084;5383.730813459311;5442.537384322337;5948.315943666447;6060.30306514752;6065.150878876961;6073.1497590337385;6073.362296958844;6250.43746062852;6269.46709529686;6272.184615999937;6275.372462753734;6283.183186185766;6155.984262596666;6224.097505861625;6224.128621992924;6254.6872656366995;6285.120083188357;6114.816555503342;6137.9079313810325;6174.475169610633;6183.227096612968;6187.566870319034;6561.376669216417;6580.078788969548;6583.210014798159;6589.24223714279;6599.769008084694;6111.166351794699;6143.634700640197;6218.906716399258;6306.24325080984;6311.400416960473;5415.350157980989;6366.108744775735;6396.456301214449;6400.839979000562;6407.295197528269;6133.478654314434;6274.905876411857;6284.591501552384;6313.842153946188;6320.083587879823;6134.681512609229;6161.199044124325;6225.097360882647;6227.564070515111;6237.126802247689;5130.307408499804;5134.717590532557;5147.485251474897;5150.6137039721425;5155.278261043457;4620;4626.421697287839;4626.467956185082;4626.74552899587;4656.254999200111;5887.558433117533;5952.196453478725;5964.463198312173;5998.070299103646;6078.057901025348;5786.189933409326;6063.060225665029;6383.553151279366;6399.104125422445;6423.42189202974;6030.849228769228;6039.063945088518;6060.363661815534;6066.636001839904;6078.149059131725;5433;5510.779568817283;5531.944680553223;5549.805756798492;5677.432256774289;6359.841003974938;6372.458341041063;6385.96807015962;6393.392627700268;6409.102725618511;6323.462505687068;6396.744130234739;6397.6481293529305;6406.903896441464;6413.198350206224;6198.6280823150755;6200.441960223601;6273.968630157003;6276.780312689217;6397.104405383157;5688.890666320028;6063.6664983426335;6245.063240513778;6259.749610015549;6308.84227894288;6265.780697675559;6293.465055470337;6371.267304260069;6386.840328991812;6411.166548348685;6090.756369745161;6101.398774955092;6127.097902969389;6220.937790622036;6254.249490061222;6202.379762023762;6217.378262173746;6234.875302493834;6234.9688251558455;6279.058141278845;6227.408396202353;6230.470410015199;6236.064590311489;6239.937600624117;6245.781397651061;6084.8783024340155;6101.715114258233;6181.474574661204;6227.657478838707;6251.6874156292915;5990.251218597676;6182.845428864314;6261.812145635638;6261.906071409024;6263.123162757127 12:12:12 INFO - 2015-11-23 12:12:12,707 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.0070168784374;561.8398756354435;604.812508122482;637.4358692557083;650.869826034793;31649.52525712113;32392.83803580979;38399.42400863989;38495.61504384955;38779.41830872539;43953;44145.55854441455;44396.55603443964;44443;44461.55538444615;8689.217970382664;8821.117888211193;9662.903370966289;9868;9879.753006174831;8706.0858609846;11849.7630047399;11967.401629918513;11982;11994.940025299862;11689.883101169007;11811.940940295286;11835.526578936875;11854.525818967231;11892.345920974343;8806.86789698155;8939.463632182089;11684;11784.234024788362;11805.82291265636;8620.181082797124;11719.179657423983;11878.58424955131;11880.881191188151;11893.40532973348;41473;41894.371584426255;41992.95017624553;42031.15937681229;42041.73874783761;2907.592936988823;3200.9679903200904;3217.4369485340208;3255.0723043932603;3685.4471829225563;27373.863130684418;29231.633866002132;29456.410871782446;29638.851805740833;30499;2766.5158597245604;2774.667039955218;2795.4269374778123;2928.7071292870755;2970.762339012874;516184;519010;519867;520112;520321;58714.4128558709;59304.81390372255;59422.70288648616;65585.67207163933;65665.6716716423;64233.03650445247;64292;64617.67691161514;64680.35319646837;64726;16333.183340832911;16407.261673224733;16583.83416165847;16610.003399796053;16612;12511.874881251071;12576.434060467302;12580.308083055337;12638.304893230961;12640.55758048464;20125.09437075335;20381.796182038288;20393.694094588594;20421.59156816885;20438.59122817535;7899.368050555941;8681.609327580274;8767.123287671182;8813;8882.733517994471;933.2953620016843;1042.9322094063862;1047.6176195688672;1116.3971455413985;1140.9796893667763;29669.855961470927;29786.10641680753;29918.25204369908;30005.79976800947;30480.237994049883;1066.6373433032652;1103.1450625764935;1140.680609429361;1143.8512993310817;1173.8532683414574;14574.99962638422;14734.778978315333;14873.033252838532;15579.143147127017;15733;509185;509351;510576;511432;511511;58891;59222;59256.407435925954;59530.023498824885;59635.403645962986;1469.6840179361488;1475.9335829887466;1491.9850801491846;1492.030180382738;1493.5593999770094;25053.624195636716;27473.31316717098;29769.851150744107;29810;30001.98353664532;50971.235431467816;51335;51363.48636513587;51459;51559.2266116016;505038.9496104992;509123;509558;510409;522748;25139.24582262535;33094.66905331012;33906.66093339035;33998.49002265018;34699;41680.16639667129;42425;42442.57557424386;42827.5717242836;42853.57146428621;35581.46627800533;35610.10974725652;35912.64087359093;36395;36760.81619591885;31607.525887111253;32161.839190803898;36021;36110.819445902605;36661.450078248316;34825.65174348224;35026.9491915243;35058.64941350554;35153.82423087868;36994.63005369912;31790.04629861108;31951.520727189574;33007.59392485954;33192;33314.83342583368;24131.879340603184;24710.88801003923;24865.63239021871;24989.125380612317;25081.247562573153 12:12:12 INFO - 2015-11-23 12:12:12,708 DEBUG : BROWSER_OUTPUT: |2;jquery.html;317.22438637531246;354.90772399176205;357.5137812574898;363.0687287108567;366.2857428015369;15564.221788910565;16012.19939003048;19643;19943.30198443055;20492.770433773967;16288;19939.800601993975;20045.699314510293;21324;21367.35897923061;5729.856753581173;5841.2114364560775;5917.112433135021;5921.615095018831;5924.822255332347;3929.9214015719667;4038.8586399476026;4043.777592232426;5897.970510147465;5910.645361278337;5787;5911.054231322989;5941.584089113764;5943.554233432488;5945.554083443759;5938.940610593903;5994.97002514989;6184.783532576338;6432.742690292383;6447.3874981876415;5648.85877853057;5650.265465489501;5663.4336566343445;5663.631863928831;5666.036773748473;12747.553835615801;13222.66943326415;13239.735205295936;13272.336383180898;13555.322233888266;2024.3926821953355;2182.9630925310507;2189.770074142224;2211.369759618501;2263.818894488437;9670.129688328085;9779.608815647365;10101.141402980755;10143.492825358777;11647.475863586158;1717.37315879703;1729.0663041957328;1733.3933123406832;1737.965240695179;1762.1013283225518;101140;105392;105543;106066.46966765194;107634.38548421701;11184.888151118548;11192.04867586248;11206;11236.213465057532;11276.267042642203;13280.73438531224;13315.600531984055;13343.933280333536;13344.733105338033;13372.06395552302;8563;8580.2706769924;8587.355948303903;8636.913630863737;8639.395242332976;8806.691765788166;8811.867821982676;8820.382573219813;8897.955510222537;8905.975812781484;4263.317869140923;4338.067315527177;4358.5205627380965;4381.583749543788;4454.22051141049;1692.3822804676204;1750.851177649914;1757.8066412694593;1811.1759149586906;1815.1831675745966;395.06369903329295;403.7597629410496;443.7071532788344;977.6871401151564;990.5344488090586;11182.496787644413;11787.587434439753;18699.626007479776;20966.685499717212;21314;856.9673543380212;942.5004747483707;963.2919803944095;979.1285755677453;1006.054308949585;9014.368994170476;9466;10810.081143102767;11176;11210.27133236337;661191;770260.1486992529;774737;787615;804085;48348.5165148344;120696.79303207032;121879;122436;123863;1131.129030646414;1236.2891337480805;1240.2620440837686;1243.2354102227066;1249.038240554786;18293;18812.341568045053;19413.0293485328;19725.901370493055;19917.60164796725;40878.9780255496;49430.418026681495;54216.45783542272;54370;55050.724746376014;71722;73282.63358683173;74279;75875;76938;9386.859197111913;9788.755281118029;9843.2125429964;9893.455859927773;9906.25703072258;11836.467358968695;14675.48635797742;19916.800831991495;19984.700229496277;20389.79610203879;12349.876501234872;12433.568038803433;14608.561743147722;15975.600609984844;16307.755383669491;15608;15883.761743573625;16074.678506429573;16076.598085047968;16415.42546010884;16130;16402.26189821485;16596.419125330554;16890.83109168942;16905.577360565592;9750.804983900423;9862.55618497155;9868.259880508847;9872.308938374244;9872.605095796087;10264.846027309746;12509.874901251234;15895.125768082404;16234.188290585187;16270.593235169215 12:12:12 INFO - 2015-11-23 12:12:12,712 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1549.0104099088762;1550.8672481587193;1706.9743953840687;1891.650044741723;1902.0965041605236;7523.774286771399;7870.409719271049;7879.093904201004;7888.9211107888905;7898.328642065417;7781.533108013509;7928.801779955504;8119.188081191878;8135.796605084861;8139.064007639124;2285.451491642006;2368.171140100968;2369.052379048386;2373.1575290771784;2381.2499062795164;2168.5554461335387;2215.534737705084;2217.3347995601257;2345.8827058647;2402.8678422686744;2339.8245131615113;2367.3726462487452;2371.0515793682493;2372.7627237276306;2373.8100951923807;2318.6058370077126;2360.9645855312183;2373.4422410733464;2376.429656882353;2386.53462574798;2129.350548082834;2154.450615093141;2160.3734916874087;2387.3196139100273;2427.381017840439;6901.309869013109;8415.242628163494;8417.200365965286;8419.494830310201;8420.789480262982;5164.9741751291;5247.947520524784;5255.369355677305;5266.289050978107;5269.051570717269;3465.6707612776745;3538.062413460435;3562.1985053362787;3585.2829434113023;3592.6586974237407;1038.693585392311;1048.1876545677162;1054.8259537176357;1059.046857827961;1079.865016872891;11112.499937502751;11197.10423166153;11253.831192532036;11267.60563380286;11280.097592192606;3948.9605103948593;4689.554492323224;4696.2955556666775;4781.306710526954;4783.5933945614315;9754.122129008423;9765.267604929659;9765.97457266991;9770.706878793648;9798.314118011813;5238.5547228486;5272.051030814414;5273.367195936512;5280.498352656491;5281.762320695578;4758.643101767381;4759.643026773006;4799.760011999456;4810.927836082462;4825.9865428260455;3658;3718.3864662330952;3749.2876353492748;3773.094457330221;3786.981065094712;1244.3280628460711;1257.4530079415483;1262.50762202741;1264.690150913014;1269.3589737182663;1369.6370461827623;1371.6570857285678;1406.8522805105522;1411.068694661539;1412.1244828206372;7729.149793522708;7903.407244456574;7910;7922.524648521107;7936.722214722457;498.11335822236475;508.98727531812;509.94135674397177;511.2535697881061;511.55239165729984;5914.107485604565;5991.670458124758;6108.1143234230785;6218.160548325918;6228.128062071313;8953.910460895308;9895.109440150422;9902.752431189278;10061.949690251502;10078.294519383573;9671.661491847752;9876.160526355341;10180.032896874785;10262.589496420209;10264.743381415376;7798.454108212371;7877.133515313311;7895.763127106081;7955.801104972422;7964.402669799788;7562.659680314509;7835.098963619257;7849.921500785147;7857.8998940147285;7869.960650196713;8907.643694252158;8991.82016359656;9069.093090691142;9086.727398178065;9100.271978241592;9108.499032553273;9272.768180795534;9378.155965963097;9517.809643806946;9529.857052144085;6994.860102798018;7276.308750668678;7288.635568221462;7364.96317518409;7410.407167426701;7967.800804979922;7991.320737737357;8003.4797738146835;8015.639296231567;8038.517688938682;7374.926250737639;7438.665260063419;7468.402527797872;7590.354819840375;7607.087149542091;6413.743450261937;7367.484276100621;7368.216339129454;7384.96307518459;7446.032015837906;7481.326680598772;7542.547447153188;7547.28300811422;7549.6225188739245;7550.7734767957045;6883.552569082994;6918.273581273894;6931.410830079298;6942.409895158968;6949.65251737401;6791.286914873867;6998.370146686822;7003.6848341823725;7021.613811240431;7030.050943122817 12:12:12 INFO - 2015-11-23 12:12:12,712 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.99999999999994;327.91310302769773;332.09172912085427;332.95338652588634;336.7188397687932;6350.364963503647;6871.312868713132;6896.310368963102;6907.13660792401;6915.896261556074;5079.568236699885;6486.091947127394;6648.900266496006;6655.134832471784;6669.366410191036;5029.622778291625;5048.596112311025;5049.545540901318;5053.140966035783;5079.923801142986;4189.958100419002;5036.34527511423;5060.797568097271;5063.063333283336;5072.822451214208;4604.746738929374;4751.40607424072;4789.497102804207;4853.854384368475;4859.246816743411;4862;4869.659123861314;4883.8779030524165;4984.831598254771;5016.3980322361185;4236.428082208893;4244.045089854789;4263.91472170558;4275.657947364234;4296.871093867189;6582.17722784652;6582.308857569934;6587.769428069994;6591.637459939701;6597.208334999831;5791.739371728282;5936.821895343147;5936.881262374728;5943.64338139713;5974.97012514939;7339.853202935965;7347.338739513416;7348.63256837156;7350.52221605594;7357.816054598625;4795.928061079087;4799.784009719571;4806.206975848981;4807.975960120212;4808.374911261549;7577.659005344773;7747.147813740484;7786.416018798556;7787.29914307715;7800.570968596725;4706.694064885772;4751.83368582098;4752.95247047532;4755.358026666356;4756.500567440438;4834.081524510332;4837.129316722953;4838.975805120952;4840.564349208517;4845.200541910545;5860.179574859523;5865.6480611162615;5866.2960444746905;5873.676947767828;5876.44173803488;7190.029346038323;7369.263073692695;7396.297351751575;7399.7780066597015;7402.333789958821;1657.80935192452;1666.6833301672643;1671.7826682531193;1673.0212825496976;1674.8073971493434;844.3625063077337;941.1764705882352;1057.645688694296;1062.5324857062867;1082.3397727386446;6448.387403196689;6533.314002029719;6706.094677218611;6879.3120687931805;6889.207741109836;7736.61316934151;7746.380289576933;7756.961215193888;7759.7672069838;7788.922110778933;5622.746976386073;6656.7670131545165;6887.621180835102;6907.792766217021;6923.273056329113;3341.8830340937952;4024.3762216856435;4095.5494895561465;4097.528784189856;4109.609587089221;7773.222677732181;7789.415793815487;7793.532388056735;7793.610319484003;7799.259070388304;6256.217972753406;7963.084245311863;8002.719904803421;8021.639026243833;8023.518588884685;6600.339966003361;7741.8838717419285;7747.225277472207;7749.418793590503;7752.7674169775;7700.653470593725;7705.576193309422;7713;7717.2668596483245;7723.382129429745;7324.523905946096;7561.659725312485;7599.430042746705;7604.315611594983;7626.3898888089925;7381.966524686441;7479.7836930120575;7778.533288002738;7785.416093793101;7799.18108598589;4615.661458177091;4724.149653062482;4771.6898401603785;4778.259369797687;4780.378550788375;6766.57901840619;7077.681504332214;7602.429817763579;7633.969414129021;7645.732399365996;6626.27111017778;7287.781366559012;7306.890396644161;7308.707651693872;7325.157606875277;7123.430125589836;7258.274172582911;7288.744893928687;7289.307515785992;7293.671784769592;6880.174379074543;7147.749828755968;7218.386437152691;7228.385587225145;7237.986681864438;7149.53528020677;7163.068801056038;7175.497715159889;7328.377087947584;7399.852002959803;7186.353228209487;7200.783976480714;7228.96385518069;7230.42156627479;7234.782956511313 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: |5;yui.html;708.5783958544665;762.1806557950204;801.1267718187174;804.7384600005;834.8705950577663;14916.701665966688;15458.381664733412;15474.148921809296;15486.922565387158;15515.301811418485;14233.572992810232;14279.928600356983;14402;14402.207878566674;14430.567082987502;761.417515600566;761.8590560746279;764.9847003059936;946.0823001688368;949.4635530925005;936.5317341329335;938.0947385772728;951.3578334624135;951.9571619277149;952.1811242331589;947.4031360243038;1022.1771473963456;1027.4708525109575;1029.0943969307;1029.5006921642996;792.4769652029632;793.9682412703514;798.3254150243064;993.3741742702124;994.7413672445144;740.7000164933211;744.6165224909176;746.9878314883309;747.2714103748856;747.5701471653821;14984.850151498564;15189.924050379677;15196;15198;15199.696006079927;12702.650009748226;12936;13051.34743262833;13315.134516256509;13520.864791352058;11222.719432014183;11489.253198542068;11619.709507262301;11626.011788997945;11926;3508.386032444312;3560.4659301104784;3563.1092226943265;3564.7148228141687;3567.714582833367;73398;73675.63162184208;76030;76052;76280.61859690721;9509.70566383949;9621.422714637145;9636.46999415025;9671.76917160788;9688.605450650164;21234.150633974776;21250.89374553117;21260.681089783357;21270.680939785914;21277.36167914965;7218.530795498275;7352.5956072415465;7399.889001664979;7582.203868593829;7629.923700762922;3917.177392747498;4009.979950100289;4045.2516284487465;4046.575109613448;4054.594540545922;3565.732570057204;3579.49887015818;3581.7492775505984;3582.6059133495296;3587.7847329160336;623.607127509666;635.1806170040688;642.4057746584391;656.6749459017722;657.8190997475732;456.73281130539004;475.9119562880809;486.96591238613667;504.9015441988777;507.2594012741365;8440.831183376298;8449.619767110495;8576.44253123545;8611.569421529024;8782.341324400695;600.7777122464717;627.5042716254109;627.7269387816315;628.532401587667;628.7547856336032;3844.461775351453;3961.2869683457257;4051.858184963571;4084.448599439097;4151.356539736345;100864;103078.48460757648;103565.48217259016;103969;104057;82004.17995819966;82422.76365854517;87494.12505874987;87854;88746.55626721826;60307.79384412375;76489.61755191299;76826.61586692031;77491.45017099626;78316.21683783089;8881.644734210558;8901.55492225399;8908.821823563621;8973.327000475121;9061.501617411106;52256.17103401363;52459.73770131125;52499.73750131225;53453.732731336095;54060;68894.3110568908;69368.6531567339;72198.33619965638;74811.62594187212;74839;9725.416475011521;9758.804823903623;10974.615888443866;11116.16628752863;11611.245269057485;10697.411642359433;11686.415679216176;11907.583234587095;12024;12091.939540302243;11607.883921160681;11723.882761172621;11878.731334024982;11979.940100299442;12097.2136811107;11317.094632429222;11356.662368686704;11471.369074700971;11674.241174323643;12282.570110046105;11340.659780206606;11419.909547239005;11421.37182454973;11680.47437865281;12252.142350035769;9187.219086377465;9349.626014959325;9422.717318480456;9767.706968790948;9957.203423726229;7878.936343593541;8779.498856498009;8824.196075725888;9052;9322.720318390458 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1395 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309532701__endTimestamp 12:12:12 INFO - 2015-11-23 12:12:12,716 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5897.52 Median:6127.10 stddev:620.89 (10.1%) stddev-sans-first:592.12 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: Values: 3440.4 3500.9 3504.1 3529.5 3570.9 5826.4 5971.6 6018.2 6047.4 6097.1 5973.1 6062.4 6063.8 6070.6 6071.3 5370.8 5397.0 5412.7 5429.1 5510.3 4569.5 4897.9 5203.5 5474.0 5487.3 5472.2 5473.8 5475.6 5482.8 5482.8 5449.8 5471.1 5473.5 5476.9 5478.9 5285.4 5342.7 5343.8 5383.7 5442.5 5948.3 6060.3 6065.2 6073.1 6073.4 6250.4 6269.5 6272.2 6275.4 6283.2 6156.0 6224.1 6224.1 6254.7 6285.1 6114.8 6137.9 6174.5 6183.2 6187.6 6561.4 6580.1 6583.2 6589.2 6599.8 6111.2 6143.6 6218.9 6306.2 6311.4 5415.4 6366.1 6396.5 6400.8 6407.3 6133.5 6274.9 6284.6 6313.8 6320.1 6134.7 6161.2 6225.1 6227.6 6237.1 5130.3 5134.7 5147.5 5150.6 5155.3 4620.0 4626.4 4626.5 4626.7 4656.3 5887.6 5952.2 5964.5 5998.1 6078.1 5786.2 6063.1 6383.6 6399.1 6423.4 6030.8 6039.1 6060.4 6066.6 6078.1 5433.0 5510.8 5531.9 5549.8 5677.4 6359.8 6372.5 6386.0 6393.4 6409.1 6323.5 6396.7 6397.6 6406.9 6413.2 6198.6 6200.4 6274.0 6276.8 6397.1 5688.9 6063.7 6245.1 6259.7 6308.8 6265.8 6293.5 6371.3 6386.8 6411.2 6090.8 6101.4 6127.1 6220.9 6254.2 6202.4 6217.4 6234.9 6235.0 6279.1 6227.4 6230.5 6236.1 6239.9 6245.8 6084.9 6101.7 6181.5 6227.7 6251.7 5990.3 6182.8 6261.8 6261.9 6263.1 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,717 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65648.48 Median:33952.58 stddev:136613.67 (402.4%) stddev-sans-first:136909.42 12:12:12 INFO - 2015-11-23 12:12:12,719 DEBUG : BROWSER_OUTPUT: Values: 531.0 561.8 604.8 637.4 650.9 31649.5 32392.8 38399.4 38495.6 38779.4 43953.0 44145.6 44396.6 44443.0 44461.6 8689.2 8821.1 9662.9 9868.0 9879.8 8706.1 11849.8 11967.4 11982.0 11994.9 11689.9 11811.9 11835.5 11854.5 11892.3 8806.9 8939.5 11684.0 11784.2 11805.8 8620.2 11719.2 11878.6 11880.9 11893.4 41473.0 41894.4 41993.0 42031.2 42041.7 2907.6 3201.0 3217.4 3255.1 3685.4 27373.9 29231.6 29456.4 29638.9 30499.0 2766.5 2774.7 2795.4 2928.7 2970.8 516184.0 519010.0 519867.0 520112.0 520321.0 58714.4 59304.8 59422.7 65585.7 65665.7 64233.0 64292.0 64617.7 64680.4 64726.0 16333.2 16407.3 16583.8 16610.0 16612.0 12511.9 12576.4 12580.3 12638.3 12640.6 20125.1 20381.8 20393.7 20421.6 20438.6 7899.4 8681.6 8767.1 8813.0 8882.7 933.3 1042.9 1047.6 1116.4 1141.0 29669.9 29786.1 29918.3 30005.8 30480.2 1066.6 1103.1 1140.7 1143.9 1173.9 14575.0 14734.8 14873.0 15579.1 15733.0 509185.0 509351.0 510576.0 511432.0 511511.0 58891.0 59222.0 59256.4 59530.0 59635.4 1469.7 1475.9 1492.0 1492.0 1493.6 25053.6 27473.3 29769.9 29810.0 30002.0 50971.2 51335.0 51363.5 51459.0 51559.2 505038.9 509123.0 509558.0 510409.0 522748.0 25139.2 33094.7 33906.7 33998.5 34699.0 41680.2 42425.0 42442.6 42827.6 42853.6 35581.5 35610.1 35912.6 36395.0 36760.8 31607.5 32161.8 36021.0 36110.8 36661.5 34825.7 35026.9 35058.6 35153.8 36994.6 31790.0 31951.5 33007.6 33192.0 33314.8 24131.9 24710.9 24865.6 24989.1 25081.2 12:12:12 INFO - 2015-11-23 12:12:12,719 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,719 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38529.84 Median:21345.68 stddev:125248.91 (586.8%) stddev-sans-first:125567.40 12:12:12 INFO - 2015-11-23 12:12:12,719 DEBUG : BROWSER_OUTPUT: Values: 317.2 354.9 357.5 363.1 366.3 15564.2 16012.2 19643.0 19943.3 20492.8 16288.0 19939.8 20045.7 21324.0 21367.4 5729.9 5841.2 5917.1 5921.6 5924.8 3929.9 4038.9 4043.8 5898.0 5910.6 5787.0 5911.1 5941.6 5943.6 5945.6 5938.9 5995.0 6184.8 6432.7 6447.4 5648.9 5650.3 5663.4 5663.6 5666.0 12747.6 13222.7 13239.7 13272.3 13555.3 2024.4 2183.0 2189.8 2211.4 2263.8 9670.1 9779.6 10101.1 10143.5 11647.5 1717.4 1729.1 1733.4 1738.0 1762.1 101140.0 105392.0 105543.0 106066.5 107634.4 11184.9 11192.0 11206.0 11236.2 11276.3 13280.7 13315.6 13343.9 13344.7 13372.1 8563.0 8580.3 8587.4 8636.9 8639.4 8806.7 8811.9 8820.4 8898.0 8906.0 4263.3 4338.1 4358.5 4381.6 4454.2 1692.4 1750.9 1757.8 1811.2 1815.2 395.1 403.8 443.7 977.7 990.5 11182.5 11787.6 18699.6 20966.7 21314.0 857.0 942.5 963.3 979.1 1006.1 9014.4 9466.0 10810.1 11176.0 11210.3 661191.0 770260.1 774737.0 787615.0 804085.0 48348.5 120696.8 121879.0 122436.0 123863.0 1131.1 1236.3 1240.3 1243.2 1249.0 18293.0 18812.3 19413.0 19725.9 19917.6 40879.0 49430.4 54216.5 54370.0 55050.7 71722.0 73282.6 74279.0 75875.0 76938.0 9386.9 9788.8 9843.2 9893.5 9906.3 11836.5 14675.5 19916.8 19984.7 20389.8 12349.9 12433.6 14608.6 15975.6 16307.8 15608.0 15883.8 16074.7 16076.6 16415.4 16130.0 16402.3 16596.4 16890.8 16905.6 9750.8 9862.6 9868.3 9872.3 9872.6 10264.8 12509.9 15895.1 16234.2 16270.6 12:12:12 INFO - 2015-11-23 12:12:12,719 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,719 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5803.61 Median:5952.89 stddev:3026.86 (50.8%) stddev-sans-first:3018.46 12:12:12 INFO - 2015-11-23 12:12:12,721 DEBUG : BROWSER_OUTPUT: Values: 1549.0 1550.9 1707.0 1891.7 1902.1 7523.8 7870.4 7879.1 7888.9 7898.3 7781.5 7928.8 8119.2 8135.8 8139.1 2285.5 2368.2 2369.1 2373.2 2381.2 2168.6 2215.5 2217.3 2345.9 2402.9 2339.8 2367.4 2371.1 2372.8 2373.8 2318.6 2361.0 2373.4 2376.4 2386.5 2129.4 2154.5 2160.4 2387.3 2427.4 6901.3 8415.2 8417.2 8419.5 8420.8 5165.0 5247.9 5255.4 5266.3 5269.1 3465.7 3538.1 3562.2 3585.3 3592.7 1038.7 1048.2 1054.8 1059.0 1079.9 11112.5 11197.1 11253.8 11267.6 11280.1 3949.0 4689.6 4696.3 4781.3 4783.6 9754.1 9765.3 9766.0 9770.7 9798.3 5238.6 5272.1 5273.4 5280.5 5281.8 4758.6 4759.6 4799.8 4810.9 4826.0 3658.0 3718.4 3749.3 3773.1 3787.0 1244.3 1257.5 1262.5 1264.7 1269.4 1369.6 1371.7 1406.9 1411.1 1412.1 7729.1 7903.4 7910.0 7922.5 7936.7 498.1 509.0 509.9 511.3 511.6 5914.1 5991.7 6108.1 6218.2 6228.1 8953.9 9895.1 9902.8 10061.9 10078.3 9671.7 9876.2 10180.0 10262.6 10264.7 7798.5 7877.1 7895.8 7955.8 7964.4 7562.7 7835.1 7849.9 7857.9 7870.0 8907.6 8991.8 9069.1 9086.7 9100.3 9108.5 9272.8 9378.2 9517.8 9529.9 6994.9 7276.3 7288.6 7365.0 7410.4 7967.8 7991.3 8003.5 8015.6 8038.5 7374.9 7438.7 7468.4 7590.4 7607.1 6413.7 7367.5 7368.2 7385.0 7446.0 7481.3 7542.5 7547.3 7549.6 7550.8 6883.6 6918.3 6931.4 6942.4 6949.7 6791.3 6998.4 7003.7 7021.6 7030.1 12:12:12 INFO - 2015-11-23 12:12:12,721 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,721 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5948.24 Median:6687.73 stddev:1926.35 (28.8%) stddev-sans-first:1884.92 12:12:12 INFO - 2015-11-23 12:12:12,722 DEBUG : BROWSER_OUTPUT: Values: 323.0 327.9 332.1 333.0 336.7 6350.4 6871.3 6896.3 6907.1 6915.9 5079.6 6486.1 6648.9 6655.1 6669.4 5029.6 5048.6 5049.5 5053.1 5079.9 4190.0 5036.3 5060.8 5063.1 5072.8 4604.7 4751.4 4789.5 4853.9 4859.2 4862.0 4869.7 4883.9 4984.8 5016.4 4236.4 4244.0 4263.9 4275.7 4296.9 6582.2 6582.3 6587.8 6591.6 6597.2 5791.7 5936.8 5936.9 5943.6 5975.0 7339.9 7347.3 7348.6 7350.5 7357.8 4795.9 4799.8 4806.2 4808.0 4808.4 7577.7 7747.1 7786.4 7787.3 7800.6 4706.7 4751.8 4753.0 4755.4 4756.5 4834.1 4837.1 4839.0 4840.6 4845.2 5860.2 5865.6 5866.3 5873.7 5876.4 7190.0 7369.3 7396.3 7399.8 7402.3 1657.8 1666.7 1671.8 1673.0 1674.8 844.4 941.2 1057.6 1062.5 1082.3 6448.4 6533.3 6706.1 6879.3 6889.2 7736.6 7746.4 7757.0 7759.8 7788.9 5622.7 6656.8 6887.6 6907.8 6923.3 3341.9 4024.4 4095.5 4097.5 4109.6 7773.2 7789.4 7793.5 7793.6 7799.3 6256.2 7963.1 8002.7 8021.6 8023.5 6600.3 7741.9 7747.2 7749.4 7752.8 7700.7 7705.6 7713.0 7717.3 7723.4 7324.5 7561.7 7599.4 7604.3 7626.4 7382.0 7479.8 7778.5 7785.4 7799.2 4615.7 4724.1 4771.7 4778.3 4780.4 6766.6 7077.7 7602.4 7634.0 7645.7 6626.3 7287.8 7306.9 7308.7 7325.2 7123.4 7258.3 7288.7 7289.3 7293.7 6880.2 7147.7 7218.4 7228.4 7238.0 7149.5 7163.1 7175.5 7328.4 7399.9 7186.4 7200.8 7229.0 7230.4 7234.8 12:12:12 INFO - 2015-11-23 12:12:12,722 DEBUG : BROWSER_OUTPUT: 12:12:12 INFO - 2015-11-23 12:12:12,722 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19055.25 Median:53756.87 stddev:27299.95 (50.8%) stddev-sans-first:27341.77 12:12:12 INFO - 2015-11-23 12:12:12,723 DEBUG : BROWSER_OUTPUT: Values: 708.6 762.2 801.1 804.7 834.9 14916.7 15458.4 15474.1 15486.9 15515.3 14233.6 14279.9 14402.0 14402.2 14430.6 761.4 761.9 765.0 946.1 949.5 936.5 938.1 951.4 952.0 952.2 947.4 1022.2 1027.5 1029.1 1029.5 792.5 794.0 798.3 993.4 994.7 740.7 744.6 747.0 747.3 747.6 14984.9 15189.9 15196.0 15198.0 15199.7 12702.7 12936.0 13051.3 13315.1 13520.9 11222.7 11489.3 11619.7 11626.0 11926.0 3508.4 3560.5 3563.1 3564.7 3567.7 73398.0 73675.6 76030.0 76052.0 76280.6 9509.7 9621.4 9636.5 9671.8 9688.6 21234.2 21250.9 21260.7 21270.7 21277.4 7218.5 7352.6 7399.9 7582.2 7629.9 3917.2 4010.0 4045.3 4046.6 4054.6 3565.7 3579.5 3581.7 3582.6 3587.8 623.6 635.2 642.4 656.7 657.8 456.7 475.9 487.0 504.9 507.3 8440.8 8449.6 8576.4 8611.6 8782.3 600.8 627.5 627.7 628.5 628.8 3844.5 3961.3 4051.9 4084.4 4151.4 100864.0 103078.5 103565.5 103969.0 104057.0 82004.2 82422.8 87494.1 87854.0 88746.6 60307.8 76489.6 76826.6 77491.5 78316.2 8881.6 8901.6 8908.8 8973.3 9061.5 52256.2 52459.7 52499.7 53453.7 54060.0 68894.3 69368.7 72198.3 74811.6 74839.0 9725.4 9758.8 10974.6 11116.2 11611.2 10697.4 11686.4 11907.6 12024.0 12091.9 11607.9 11723.9 11878.7 11979.9 12097.2 11317.1 11356.7 11471.4 11674.2 12282.6 11340.7 11419.9 11421.4 11680.5 12252.1 9187.2 9349.6 9422.7 9767.7 9957.2 7878.9 8779.5 8824.2 9052.0 9322.7 12:12:12 INFO - 2015-11-23 12:12:12,723 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:12:12 INFO - 2015-11-23 12:12:12,723 DEBUG : BROWSER_OUTPUT: 12:12:13 INFO - 2015-11-23 12:12:13,169 INFO : Browser exited with error code: 0 12:12:13 INFO - 2015-11-23 12:12:13,193 INFO : Completed test dromaeo_css (00:18:34) 12:12:13 INFO - 2015-11-23 12:12:13,193 INFO : Starting test kraken 12:12:13 INFO - 2015-11-23 12:12:13,193 DEBUG : operating with platform_type : mac_ 12:12:13 INFO - 2015-11-23 12:12:13,194 INFO : Initialising browser for kraken test... 12:12:13 INFO - 2015-11-23 12:12:13,206 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpTTMRNH/profile http://localhost:49755/getInfo.html 12:12:15 INFO - 2015-11-23 12:12:15,215 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:12:15 INFO - 2015-11-23 12:12:15,215 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:12:15 INFO - 2015-11-23 12:12:15,215 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:12:15 INFO - 2015-11-23 12:12:15,215 DEBUG : BROWSER_OUTPUT: __metrics 12:12:15 INFO - 2015-11-23 12:12:15,231 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:12:15 INFO - 2015-11-23 12:12:15,597 DEBUG : BROWSER_OUTPUT: console.error: 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: Stack: 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:12:15 INFO - 2015-11-23 12:12:15,601 DEBUG : BROWSER_OUTPUT: 12:12:16 INFO - 2015-11-23 12:12:16,056 INFO : Browser initialized. 12:12:16 INFO - 2015-11-23 12:12:16,057 INFO : Running cycle 1/1 for kraken test... 12:12:16 INFO - 2015-11-23 12:12:16,057 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpTTMRNH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:12:27 INFO - 2015-11-23 12:12:27,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 226390016 12:12:27 INFO - 2015-11-23 12:12:27,843 DEBUG : BROWSER_OUTPUT: 12:12:30 INFO - 2015-11-23 12:12:30,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-beat-detection) 12:12:30 INFO - 2015-11-23 12:12:30,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 276316160 12:12:30 INFO - 2015-11-23 12:12:30,965 DEBUG : BROWSER_OUTPUT: 12:12:33 INFO - 2015-11-23 12:12:33,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-dft) 12:12:34 INFO - 2015-11-23 12:12:34,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 287920128 12:12:34 INFO - 2015-11-23 12:12:34,197 DEBUG : BROWSER_OUTPUT: 12:12:37 INFO - 2015-11-23 12:12:37,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-fft) 12:12:37 INFO - 2015-11-23 12:12:37,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 274264064 12:12:37 INFO - 2015-11-23 12:12:37,995 DEBUG : BROWSER_OUTPUT: 12:12:39 INFO - 2015-11-23 12:12:39,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-oscillator) 12:12:40 INFO - 2015-11-23 12:12:40,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 277245952 12:12:40 INFO - 2015-11-23 12:12:40,570 DEBUG : BROWSER_OUTPUT: 12:12:42 INFO - 2015-11-23 12:12:42,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:12:43 INFO - 2015-11-23 12:12:43,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 278020096 12:12:43 INFO - 2015-11-23 12:12:43,168 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-23 12:12:45,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49755/tests/kraken/driver.html?testName=imaging-darkroom) 12:12:46 INFO - 2015-11-23 12:12:46,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 279642112 12:12:46 INFO - 2015-11-23 12:12:46,409 DEBUG : BROWSER_OUTPUT: 12:12:49 INFO - 2015-11-23 12:12:49,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49755/tests/kraken/driver.html?testName=imaging-desaturate) 12:12:49 INFO - 2015-11-23 12:12:49,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 279859200 12:12:49 INFO - 2015-11-23 12:12:49,873 DEBUG : BROWSER_OUTPUT: 12:12:52 INFO - 2015-11-23 12:12:52,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49755/tests/kraken/driver.html?testName=json-parse-financial) 12:12:53 INFO - 2015-11-23 12:12:53,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 278999040 12:12:53 INFO - 2015-11-23 12:12:53,136 DEBUG : BROWSER_OUTPUT: 12:12:54 INFO - 2015-11-23 12:12:54,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:12:55 INFO - 2015-11-23 12:12:55,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 311480320 12:12:55 INFO - 2015-11-23 12:12:55,223 DEBUG : BROWSER_OUTPUT: 12:12:57 INFO - 2015-11-23 12:12:56,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:12:57 INFO - 2015-11-23 12:12:57,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 312893440 12:12:57 INFO - 2015-11-23 12:12:57,623 DEBUG : BROWSER_OUTPUT: 12:12:59 INFO - 2015-11-23 12:12:59,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:00 INFO - 2015-11-23 12:13:00,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 321355776 12:13:00 INFO - 2015-11-23 12:13:00,313 DEBUG : BROWSER_OUTPUT: 12:13:02 INFO - 2015-11-23 12:13:02,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:13:03 INFO - 2015-11-23 12:13:03,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 323637248 12:13:03 INFO - 2015-11-23 12:13:03,451 DEBUG : BROWSER_OUTPUT: 12:13:05 INFO - 2015-11-23 12:13:05,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:13:06 INFO - 2015-11-23 12:13:06,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 321802240 12:13:06 INFO - 2015-11-23 12:13:06,459 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49755/tests/kraken/driver.html?testName=ai-astar) 12:13:08 INFO - 2015-11-23 12:13:08,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 381652992 12:13:08 INFO - 2015-11-23 12:13:08,374 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;106;109;109;109;107;109;103;110 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;119;163;176;144;139;139;117;156;119 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |2;audio-dft;185;186;183;185;183;184;184;185;188;180 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;70;73;74;55;72;83;102;83;55 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;84;122;76;75;75;113;73;75;114 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;84;84;83;86;86;84;85;84;84;85 12:13:08 INFO - 2015-11-23 12:13:08,375 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;93;99;148;92;93;93;93;94;93 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;86;84;86;85;85;84;84;85;84 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;55;54;53;55;53;64;52;54 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;66;63;67;67;67;68;69;68 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;82;82;81;81;80;81;96;105 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;121;121;126;127;126;133;121;128;125 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;126;136;134;159;125;136;135;136;123 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;68;65;65;65;63;67;66;64 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1054 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309588369__endTimestamp 12:13:08 INFO - 2015-11-23 12:13:08,376 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:2.18 (2.0%) stddev-sans-first:2.20 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 106.0 109.0 109.0 109.0 107.0 109.0 103.0 110.0 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.00 stddev:19.99 (13.5%) stddev-sans-first:20.90 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: Values: 152.0 119.0 163.0 176.0 144.0 139.0 139.0 117.0 156.0 119.0 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.11 (1.1%) stddev-sans-first:2.22 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: Values: 185.0 186.0 183.0 185.0 183.0 184.0 184.0 185.0 188.0 180.0 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,377 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.30 Median:72.50 stddev:13.94 (19.2%) stddev-sans-first:14.53 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: Values: 66.0 70.0 73.0 74.0 55.0 72.0 83.0 102.0 83.0 55.0 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:89.10 Median:75.00 stddev:19.30 (25.7%) stddev-sans-first:20.38 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 122.0 76.0 75.0 75.0 113.0 73.0 75.0 114.0 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:84.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 86.0 86.0 84.0 85.0 84.0 84.0 85.0 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:99.10 Median:93.00 stddev:17.29 (18.6%) stddev-sans-first:18.20 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 99.0 148.0 92.0 93.0 93.0 93.0 94.0 93.0 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 12:13:08 INFO - 2015-11-23 12:13:08,378 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 84.0 86.0 85.0 85.0 84.0 84.0 85.0 84.0 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.40 (6.2%) stddev-sans-first:3.55 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 55.0 54.0 53.0 55.0 53.0 64.0 52.0 54.0 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:67.00 stddev:2.15 (3.2%) stddev-sans-first:1.94 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 66.0 63.0 67.0 67.0 67.0 68.0 69.0 68.0 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:81.50 stddev:8.47 (10.4%) stddev-sans-first:8.79 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 82.0 82.0 81.0 81.0 80.0 81.0 96.0 105.0 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.00 stddev:3.89 (3.1%) stddev-sans-first:3.97 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: Values: 122.0 121.0 121.0 126.0 127.0 126.0 133.0 121.0 128.0 125.0 12:13:08 INFO - 2015-11-23 12:13:08,379 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.70 Median:136.00 stddev:10.04 (7.4%) stddev-sans-first:10.62 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: Values: 137.0 126.0 136.0 134.0 159.0 125.0 136.0 135.0 136.0 123.0 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 68.0 65.0 65.0 65.0 63.0 67.0 66.0 64.0 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:13:08 INFO - 2015-11-23 12:13:08,380 DEBUG : BROWSER_OUTPUT: 12:13:09 INFO - 2015-11-23 12:13:09,022 INFO : Browser exited with error code: 0 12:13:09 INFO - 2015-11-23 12:13:09,069 INFO : Completed test kraken (00:00:55) 12:13:09 INFO - 2015-11-23 12:13:09,069 INFO : Starting test v8_7 12:13:09 INFO - 2015-11-23 12:13:09,069 DEBUG : operating with platform_type : mac_ 12:13:09 INFO - 2015-11-23 12:13:09,070 INFO : Initialising browser for v8_7 test... 12:13:09 INFO - 2015-11-23 12:13:09,082 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpBpnnKl/profile http://localhost:49755/getInfo.html 12:13:11 INFO - 2015-11-23 12:13:11,240 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:13:11 INFO - 2015-11-23 12:13:11,240 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:13:11 INFO - 2015-11-23 12:13:11,240 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:13:11 INFO - 2015-11-23 12:13:11,241 DEBUG : BROWSER_OUTPUT: __metrics 12:13:11 INFO - 2015-11-23 12:13:11,257 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:11 INFO - 2015-11-23 12:13:11,902 INFO : Browser initialized. 12:13:11 INFO - 2015-11-23 12:13:11,902 INFO : Running cycle 1/1 for v8_7 test... 12:13:11 INFO - 2015-11-23 12:13:11,902 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpBpnnKl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:13:23 INFO - 2015-11-23 12:13:23,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 225677312 12:13:23 INFO - 2015-11-23 12:13:23,703 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/v8_7/run.html (next: http://localhost:49755/tests/v8_7/run.html) 12:13:45 INFO - 2015-11-23 12:13:45,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 599781376 12:13:45 INFO - 2015-11-23 12:13:45,409 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |0;Richards;148.12620352540364 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.73378618793467 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4721.698113207547 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1712.3287671232877 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |6;Boyer;12822.784810126583 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |7;RegExp;27944.444444444445 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |8;Splay;680.7351940095303 12:13:45 INFO - 2015-11-23 12:13:45,410 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309625403__endTimestamp 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.13 Median:148.13 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: Values: 148.1 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.73 Median:161.73 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: Values: 161.7 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,411 DEBUG : BROWSER_OUTPUT: Values: 282.1 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4721.70 Median:4721.70 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: Values: 4721.7 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1712.33 Median:1712.33 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: Values: 1712.3 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: Values: 784.3 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12822.78 Median:12822.78 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: Values: 12822.8 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,412 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27944.44 Median:27944.44 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: Values: 27944.4 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:680.74 Median:680.74 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: Values: 680.7 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: Values: 4513.5 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:13:45 INFO - 2015-11-23 12:13:45,413 DEBUG : BROWSER_OUTPUT: 12:13:46 INFO - 2015-11-23 12:13:46,037 INFO : Browser exited with error code: 0 12:13:46 INFO - 2015-11-23 12:13:46,056 INFO : Completed test v8_7 (00:00:36) 12:13:46 INFO - 2015-11-23 12:13:46,473 INFO : Completed test suite (00:20:08) 12:13:46 INFO - 2015-11-23 12:13:46,473 DEBUG : Working with test: dromaeo_css 12:13:46 INFO - 2015-11-23 12:13:46,473 DEBUG : Generating results file: dromaeo_css 12:13:46 INFO - 2015-11-23 12:13:46,474 DEBUG : Working with test: kraken 12:13:46 INFO - 2015-11-23 12:13:46,474 DEBUG : Generating results file: kraken 12:13:46 INFO - 2015-11-23 12:13:46,475 INFO : javascript benchmark 12:13:46 INFO - 2015-11-23 12:13:46,475 DEBUG : Working with test: v8_7 12:13:46 INFO - 2015-11-23 12:13:46,475 DEBUG : Generating results file: v8_7 12:13:46 INFO - 2015-11-23 12:13:46,475 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:13:46 INFO - 2015-11-23 12:13:46,865 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:13:46 INFO - 2015-11-23 12:13:46,865 DEBUG : process_Request line: dromaeo_css 7638.20 graph.html#tests=[[72,64,59]] 12:13:46 INFO - 2015-11-23 12:13:46,865 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:13:46 INFO - 2015-11-23 12:13:46,896 DEBUG : process_Request line: kraken 1397.00 graph.html#tests=[[232,64,59]] 12:13:46 INFO - 2015-11-23 12:13:46,896 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:13:46 INFO - 2015-11-23 12:13:46,927 DEBUG : process_Request line: v8_7 20517.51 graph.html#tests=[[230,64,59]] 12:13:46 INFO - 2015-11-23 12:13:46,928 INFO : javascript benchmark 12:13:46 INFO - 2015-11-23 12:13:46,930 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3440.415129427997, 3500.8599656013753, 3504.0889368764115, 3529.5411596492454, 3570.8750193743226, 5826.4173582641715, 5971.641701497902, 6018.217631707877, 6047.395260473951, 6097.085437184419, 5973.074173503103, 6062.363451837559, 6063.787767428141, 6070.635761854281, 6071.332153463116, 5370.838874833751, 5396.973015134919, 5412.702301373423, 5429.077056900317, 5510.311211098613, 4569.47451043131, 4897.897972956092, 5203.4536373680785, 5474.014677358074, 5487.341519017724, 5472.151816468454, 5473.808416705416, 5475.589330800186, 5482.753276102565, 5482.780688772445, 5449.83650490484, 5471.06991811393, 5473.534749546293, 5476.863078423071, 5478.863028424302, 5285.418603953562, 5342.652727572734, 5343.759530821084, 5383.730813459311, 5442.537384322337, 5948.315943666447, 6060.30306514752, 6065.150878876961, 6073.1497590337385, 6073.362296958844, 6250.43746062852, 6269.46709529686, 6272.184615999937, 6275.372462753734, 6283.183186185766, 6155.984262596666, 6224.097505861625, 6224.128621992924, 6254.6872656366995, 6285.120083188357, 6114.816555503342, 6137.9079313810325, 6174.475169610633, 6183.227096612968, 6187.566870319034, 6561.376669216417, 6580.078788969548, 6583.210014798159, 6589.24223714279, 6599.769008084694, 6111.166351794699, 6143.634700640197, 6218.906716399258, 6306.24325080984, 6311.400416960473, 5415.350157980989, 6366.108744775735, 6396.456301214449, 6400.839979000562, 6407.295197528269, 6133.478654314434, 6274.905876411857, 6284.591501552384, 6313.842153946188, 6320.083587879823, 6134.681512609229, 6161.199044124325, 6225.097360882647, 6227.564070515111, 6237.126802247689, 5130.307408499804, 5134.717590532557, 5147.485251474897, 5150.6137039721425, 5155.278261043457, 4620.0, 4626.421697287839, 4626.467956185082, 4626.74552899587, 4656.254999200111, 5887.558433117533, 5952.196453478725, 5964.463198312173, 5998.070299103646, 6078.057901025348, 5786.189933409326, 6063.060225665029, 6383.553151279366, 6399.104125422445, 6423.42189202974, 6030.849228769228, 6039.063945088518, 6060.363661815534, 6066.636001839904, 6078.149059131725, 5433.0, 5510.779568817283, 5531.944680553223, 5549.805756798492, 5677.432256774289, 6359.841003974938, 6372.458341041063, 6385.96807015962, 6393.392627700268, 6409.102725618511, 6323.462505687068, 6396.744130234739, 6397.6481293529305, 6406.903896441464, 6413.198350206224, 6198.6280823150755, 6200.441960223601, 6273.968630157003, 6276.780312689217, 6397.104405383157, 5688.890666320028, 6063.6664983426335, 6245.063240513778, 6259.749610015549, 6308.84227894288, 6265.780697675559, 6293.465055470337, 6371.267304260069, 6386.840328991812, 6411.166548348685, 6090.756369745161, 6101.398774955092, 6127.097902969389, 6220.937790622036, 6254.249490061222, 6202.379762023762, 6217.378262173746, 6234.875302493834, 6234.9688251558455, 6279.058141278845, 6227.408396202353, 6230.470410015199, 6236.064590311489, 6239.937600624117, 6245.781397651061, 6084.8783024340155, 6101.715114258233, 6181.474574661204, 6227.657478838707, 6251.6874156292915, 5990.251218597676, 6182.845428864314, 6261.812145635638, 6261.906071409024, 6263.123162757127], "unit": "ms", "name": "dojo.html", "value": 5859.789165598529}, {"lowerIsBetter": false, "replicates": [531.0070168784374, 561.8398756354435, 604.812508122482, 637.4358692557083, 650.869826034793, 31649.52525712113, 32392.83803580979, 38399.42400863989, 38495.61504384955, 38779.41830872539, 43953.0, 44145.55854441455, 44396.55603443964, 44443.0, 44461.55538444615, 8689.217970382664, 8821.117888211193, 9662.903370966289, 9868.0, 9879.753006174831, 8706.0858609846, 11849.7630047399, 11967.401629918513, 11982.0, 11994.940025299862, 11689.883101169007, 11811.940940295286, 11835.526578936875, 11854.525818967231, 11892.345920974343, 8806.86789698155, 8939.463632182089, 11684.0, 11784.234024788362, 11805.82291265636, 8620.181082797124, 11719.179657423983, 11878.58424955131, 11880.881191188151, 11893.40532973348, 41473.0, 41894.371584426255, 41992.95017624553, 42031.15937681229, 42041.73874783761, 2907.592936988823, 3200.9679903200904, 3217.4369485340208, 3255.0723043932603, 3685.4471829225563, 27373.863130684418, 29231.633866002132, 29456.410871782446, 29638.851805740833, 30499.0, 2766.5158597245604, 2774.667039955218, 2795.4269374778123, 2928.7071292870755, 2970.762339012874, 516184.0, 519010.0, 519867.0, 520112.0, 520321.0, 58714.4128558709, 59304.81390372255, 59422.70288648616, 65585.67207163933, 65665.6716716423, 64233.03650445247, 64292.0, 64617.67691161514, 64680.35319646837, 64726.0, 16333.183340832911, 16407.261673224733, 16583.83416165847, 16610.003399796053, 16612.0, 12511.874881251071, 12576.434060467302, 12580.308083055337, 12638.304893230961, 12640.55758048464, 20125.09437075335, 20381.796182038288, 20393.694094588594, 20421.59156816885, 20438.59122817535, 7899.368050555941, 8681.609327580274, 8767.123287671182, 8813.0, 8882.733517994471, 933.2953620016843, 1042.9322094063862, 1047.6176195688672, 1116.3971455413985, 1140.9796893667763, 29669.855961470927, 29786.10641680753, 29918.25204369908, 30005.79976800947, 30480.237994049883, 1066.6373433032652, 1103.1450625764935, 1140.680609429361, 1143.8512993310817, 1173.8532683414574, 14574.99962638422, 14734.778978315333, 14873.033252838532, 15579.143147127017, 15733.0, 509185.0, 509351.0, 510576.0, 511432.0, 511511.0, 58891.0, 59222.0, 59256.407435925954, 59530.023498824885, 59635.403645962986, 1469.6840179361488, 1475.9335829887466, 1491.9850801491846, 1492.030180382738, 1493.5593999770094, 25053.624195636716, 27473.31316717098, 29769.851150744107, 29810.0, 30001.98353664532, 50971.235431467816, 51335.0, 51363.48636513587, 51459.0, 51559.2266116016, 505038.9496104992, 509123.0, 509558.0, 510409.0, 522748.0, 25139.24582262535, 33094.66905331012, 33906.66093339035, 33998.49002265018, 34699.0, 41680.16639667129, 42425.0, 42442.57557424386, 42827.5717242836, 42853.57146428621, 35581.46627800533, 35610.10974725652, 35912.64087359093, 36395.0, 36760.81619591885, 31607.525887111253, 32161.839190803898, 36021.0, 36110.819445902605, 36661.450078248316, 34825.65174348224, 35026.9491915243, 35058.64941350554, 35153.82423087868, 36994.63005369912, 31790.04629861108, 31951.520727189574, 33007.59392485954, 33192.0, 33314.83342583368, 24131.879340603184, 24710.88801003923, 24865.63239021871, 24989.125380612317, 25081.247562573153], "unit": "ms", "name": "ext.html", "value": 20244.614472922873}, {"lowerIsBetter": false, "replicates": [317.22438637531246, 354.90772399176205, 357.5137812574898, 363.0687287108567, 366.2857428015369, 15564.221788910565, 16012.19939003048, 19643.0, 19943.30198443055, 20492.770433773967, 16288.0, 19939.800601993975, 20045.699314510293, 21324.0, 21367.35897923061, 5729.856753581173, 5841.2114364560775, 5917.112433135021, 5921.615095018831, 5924.822255332347, 3929.9214015719667, 4038.8586399476026, 4043.777592232426, 5897.970510147465, 5910.645361278337, 5787.0, 5911.054231322989, 5941.584089113764, 5943.554233432488, 5945.554083443759, 5938.940610593903, 5994.97002514989, 6184.783532576338, 6432.742690292383, 6447.3874981876415, 5648.85877853057, 5650.265465489501, 5663.4336566343445, 5663.631863928831, 5666.036773748473, 12747.553835615801, 13222.66943326415, 13239.735205295936, 13272.336383180898, 13555.322233888266, 2024.3926821953355, 2182.9630925310507, 2189.770074142224, 2211.369759618501, 2263.818894488437, 9670.129688328085, 9779.608815647365, 10101.141402980755, 10143.492825358777, 11647.475863586158, 1717.37315879703, 1729.0663041957328, 1733.3933123406832, 1737.965240695179, 1762.1013283225518, 101140.0, 105392.0, 105543.0, 106066.46966765194, 107634.38548421701, 11184.888151118548, 11192.04867586248, 11206.0, 11236.213465057532, 11276.267042642203, 13280.73438531224, 13315.600531984055, 13343.933280333536, 13344.733105338033, 13372.06395552302, 8563.0, 8580.2706769924, 8587.355948303903, 8636.913630863737, 8639.395242332976, 8806.691765788166, 8811.867821982676, 8820.382573219813, 8897.955510222537, 8905.975812781484, 4263.317869140923, 4338.067315527177, 4358.5205627380965, 4381.583749543788, 4454.22051141049, 1692.3822804676204, 1750.851177649914, 1757.8066412694593, 1811.1759149586906, 1815.1831675745966, 395.06369903329295, 403.7597629410496, 443.7071532788344, 977.6871401151564, 990.5344488090586, 11182.496787644413, 11787.587434439753, 18699.626007479776, 20966.685499717212, 21314.0, 856.9673543380212, 942.5004747483707, 963.2919803944095, 979.1285755677453, 1006.054308949585, 9014.368994170476, 9466.0, 10810.081143102767, 11176.0, 11210.27133236337, 661191.0, 770260.1486992529, 774737.0, 787615.0, 804085.0, 48348.5165148344, 120696.79303207032, 121879.0, 122436.0, 123863.0, 1131.129030646414, 1236.2891337480805, 1240.2620440837686, 1243.2354102227066, 1249.038240554786, 18293.0, 18812.341568045053, 19413.0293485328, 19725.901370493055, 19917.60164796725, 40878.9780255496, 49430.418026681495, 54216.45783542272, 54370.0, 55050.724746376014, 71722.0, 73282.63358683173, 74279.0, 75875.0, 76938.0, 9386.859197111913, 9788.755281118029, 9843.2125429964, 9893.455859927773, 9906.25703072258, 11836.467358968695, 14675.48635797742, 19916.800831991495, 19984.700229496277, 20389.79610203879, 12349.876501234872, 12433.568038803433, 14608.561743147722, 15975.600609984844, 16307.755383669491, 15608.0, 15883.761743573625, 16074.678506429573, 16076.598085047968, 16415.42546010884, 16130.0, 16402.26189821485, 16596.419125330554, 16890.83109168942, 16905.577360565592, 9750.804983900423, 9862.55618497155, 9868.259880508847, 9872.308938374244, 9872.605095796087, 10264.846027309746, 12509.874901251234, 15895.125768082404, 16234.188290585187, 16270.593235169215], "unit": "ms", "name": "jquery.html", "value": 9614.719189830934}, {"lowerIsBetter": false, "replicates": [1549.0104099088762, 1550.8672481587193, 1706.9743953840687, 1891.650044741723, 1902.0965041605236, 7523.774286771399, 7870.409719271049, 7879.093904201004, 7888.9211107888905, 7898.328642065417, 7781.533108013509, 7928.801779955504, 8119.188081191878, 8135.796605084861, 8139.064007639124, 2285.451491642006, 2368.171140100968, 2369.052379048386, 2373.1575290771784, 2381.2499062795164, 2168.5554461335387, 2215.534737705084, 2217.3347995601257, 2345.8827058647, 2402.8678422686744, 2339.8245131615113, 2367.3726462487452, 2371.0515793682493, 2372.7627237276306, 2373.8100951923807, 2318.6058370077126, 2360.9645855312183, 2373.4422410733464, 2376.429656882353, 2386.53462574798, 2129.350548082834, 2154.450615093141, 2160.3734916874087, 2387.3196139100273, 2427.381017840439, 6901.309869013109, 8415.242628163494, 8417.200365965286, 8419.494830310201, 8420.789480262982, 5164.9741751291, 5247.947520524784, 5255.369355677305, 5266.289050978107, 5269.051570717269, 3465.6707612776745, 3538.062413460435, 3562.1985053362787, 3585.2829434113023, 3592.6586974237407, 1038.693585392311, 1048.1876545677162, 1054.8259537176357, 1059.046857827961, 1079.865016872891, 11112.499937502751, 11197.10423166153, 11253.831192532036, 11267.60563380286, 11280.097592192606, 3948.9605103948593, 4689.554492323224, 4696.2955556666775, 4781.306710526954, 4783.5933945614315, 9754.122129008423, 9765.267604929659, 9765.97457266991, 9770.706878793648, 9798.314118011813, 5238.5547228486, 5272.051030814414, 5273.367195936512, 5280.498352656491, 5281.762320695578, 4758.643101767381, 4759.643026773006, 4799.760011999456, 4810.927836082462, 4825.9865428260455, 3658.0, 3718.3864662330952, 3749.2876353492748, 3773.094457330221, 3786.981065094712, 1244.3280628460711, 1257.4530079415483, 1262.50762202741, 1264.690150913014, 1269.3589737182663, 1369.6370461827623, 1371.6570857285678, 1406.8522805105522, 1411.068694661539, 1412.1244828206372, 7729.149793522708, 7903.407244456574, 7910.0, 7922.524648521107, 7936.722214722457, 498.11335822236475, 508.98727531812, 509.94135674397177, 511.2535697881061, 511.55239165729984, 5914.107485604565, 5991.670458124758, 6108.1143234230785, 6218.160548325918, 6228.128062071313, 8953.910460895308, 9895.109440150422, 9902.752431189278, 10061.949690251502, 10078.294519383573, 9671.661491847752, 9876.160526355341, 10180.032896874785, 10262.589496420209, 10264.743381415376, 7798.454108212371, 7877.133515313311, 7895.763127106081, 7955.801104972422, 7964.402669799788, 7562.659680314509, 7835.098963619257, 7849.921500785147, 7857.8998940147285, 7869.960650196713, 8907.643694252158, 8991.82016359656, 9069.093090691142, 9086.727398178065, 9100.271978241592, 9108.499032553273, 9272.768180795534, 9378.155965963097, 9517.809643806946, 9529.857052144085, 6994.860102798018, 7276.308750668678, 7288.635568221462, 7364.96317518409, 7410.407167426701, 7967.800804979922, 7991.320737737357, 8003.4797738146835, 8015.639296231567, 8038.517688938682, 7374.926250737639, 7438.665260063419, 7468.402527797872, 7590.354819840375, 7607.087149542091, 6413.743450261937, 7367.484276100621, 7368.216339129454, 7384.96307518459, 7446.032015837906, 7481.326680598772, 7542.547447153188, 7547.28300811422, 7549.6225188739245, 7550.7734767957045, 6883.552569082994, 6918.273581273894, 6931.410830079298, 6942.409895158968, 6949.65251737401, 6791.286914873867, 6998.370146686822, 7003.6848341823725, 7021.613811240431, 7030.050943122817], "unit": "ms", "name": "mootools.html", "value": 4682.692090272231}, {"lowerIsBetter": false, "replicates": [322.99999999999994, 327.91310302769773, 332.09172912085427, 332.95338652588634, 336.7188397687932, 6350.364963503647, 6871.312868713132, 6896.310368963102, 6907.13660792401, 6915.896261556074, 5079.568236699885, 6486.091947127394, 6648.900266496006, 6655.134832471784, 6669.366410191036, 5029.622778291625, 5048.596112311025, 5049.545540901318, 5053.140966035783, 5079.923801142986, 4189.958100419002, 5036.34527511423, 5060.797568097271, 5063.063333283336, 5072.822451214208, 4604.746738929374, 4751.40607424072, 4789.497102804207, 4853.854384368475, 4859.246816743411, 4862.0, 4869.659123861314, 4883.8779030524165, 4984.831598254771, 5016.3980322361185, 4236.428082208893, 4244.045089854789, 4263.91472170558, 4275.657947364234, 4296.871093867189, 6582.17722784652, 6582.308857569934, 6587.769428069994, 6591.637459939701, 6597.208334999831, 5791.739371728282, 5936.821895343147, 5936.881262374728, 5943.64338139713, 5974.97012514939, 7339.853202935965, 7347.338739513416, 7348.63256837156, 7350.52221605594, 7357.816054598625, 4795.928061079087, 4799.784009719571, 4806.206975848981, 4807.975960120212, 4808.374911261549, 7577.659005344773, 7747.147813740484, 7786.416018798556, 7787.29914307715, 7800.570968596725, 4706.694064885772, 4751.83368582098, 4752.95247047532, 4755.358026666356, 4756.500567440438, 4834.081524510332, 4837.129316722953, 4838.975805120952, 4840.564349208517, 4845.200541910545, 5860.179574859523, 5865.6480611162615, 5866.2960444746905, 5873.676947767828, 5876.44173803488, 7190.029346038323, 7369.263073692695, 7396.297351751575, 7399.7780066597015, 7402.333789958821, 1657.80935192452, 1666.6833301672643, 1671.7826682531193, 1673.0212825496976, 1674.8073971493434, 844.3625063077337, 941.1764705882352, 1057.645688694296, 1062.5324857062867, 1082.3397727386446, 6448.387403196689, 6533.314002029719, 6706.094677218611, 6879.3120687931805, 6889.207741109836, 7736.61316934151, 7746.380289576933, 7756.961215193888, 7759.7672069838, 7788.922110778933, 5622.746976386073, 6656.7670131545165, 6887.621180835102, 6907.792766217021, 6923.273056329113, 3341.8830340937952, 4024.3762216856435, 4095.5494895561465, 4097.528784189856, 4109.609587089221, 7773.222677732181, 7789.415793815487, 7793.532388056735, 7793.610319484003, 7799.259070388304, 6256.217972753406, 7963.084245311863, 8002.719904803421, 8021.639026243833, 8023.518588884685, 6600.339966003361, 7741.8838717419285, 7747.225277472207, 7749.418793590503, 7752.7674169775, 7700.653470593725, 7705.576193309422, 7713.0, 7717.2668596483245, 7723.382129429745, 7324.523905946096, 7561.659725312485, 7599.430042746705, 7604.315611594983, 7626.3898888089925, 7381.966524686441, 7479.7836930120575, 7778.533288002738, 7785.416093793101, 7799.18108598589, 4615.661458177091, 4724.149653062482, 4771.6898401603785, 4778.259369797687, 4780.378550788375, 6766.57901840619, 7077.681504332214, 7602.429817763579, 7633.969414129021, 7645.732399365996, 6626.27111017778, 7287.781366559012, 7306.890396644161, 7308.707651693872, 7325.157606875277, 7123.430125589836, 7258.274172582911, 7288.744893928687, 7289.307515785992, 7293.671784769592, 6880.174379074543, 7147.749828755968, 7218.386437152691, 7228.385587225145, 7237.986681864438, 7149.53528020677, 7163.068801056038, 7175.497715159889, 7328.377087947584, 7399.852002959803, 7186.353228209487, 7200.783976480714, 7228.96385518069, 7230.42156627479, 7234.782956511313], "unit": "ms", "name": "prototype.html", "value": 5291.333299362013}, {"lowerIsBetter": false, "replicates": [708.5783958544665, 762.1806557950204, 801.1267718187174, 804.7384600005, 834.8705950577663, 14916.701665966688, 15458.381664733412, 15474.148921809296, 15486.922565387158, 15515.301811418485, 14233.572992810232, 14279.928600356983, 14402.0, 14402.207878566674, 14430.567082987502, 761.417515600566, 761.8590560746279, 764.9847003059936, 946.0823001688368, 949.4635530925005, 936.5317341329335, 938.0947385772728, 951.3578334624135, 951.9571619277149, 952.1811242331589, 947.4031360243038, 1022.1771473963456, 1027.4708525109575, 1029.0943969307, 1029.5006921642996, 792.4769652029632, 793.9682412703514, 798.3254150243064, 993.3741742702124, 994.7413672445144, 740.7000164933211, 744.6165224909176, 746.9878314883309, 747.2714103748856, 747.5701471653821, 14984.850151498564, 15189.924050379677, 15196.0, 15198.0, 15199.696006079927, 12702.650009748226, 12936.0, 13051.34743262833, 13315.134516256509, 13520.864791352058, 11222.719432014183, 11489.253198542068, 11619.709507262301, 11626.011788997945, 11926.0, 3508.386032444312, 3560.4659301104784, 3563.1092226943265, 3564.7148228141687, 3567.714582833367, 73398.0, 73675.63162184208, 76030.0, 76052.0, 76280.61859690721, 9509.70566383949, 9621.422714637145, 9636.46999415025, 9671.76917160788, 9688.605450650164, 21234.150633974776, 21250.89374553117, 21260.681089783357, 21270.680939785914, 21277.36167914965, 7218.530795498275, 7352.5956072415465, 7399.889001664979, 7582.203868593829, 7629.923700762922, 3917.177392747498, 4009.979950100289, 4045.2516284487465, 4046.575109613448, 4054.594540545922, 3565.732570057204, 3579.49887015818, 3581.7492775505984, 3582.6059133495296, 3587.7847329160336, 623.607127509666, 635.1806170040688, 642.4057746584391, 656.6749459017722, 657.8190997475732, 456.73281130539004, 475.9119562880809, 486.96591238613667, 504.9015441988777, 507.2594012741365, 8440.831183376298, 8449.619767110495, 8576.44253123545, 8611.569421529024, 8782.341324400695, 600.7777122464717, 627.5042716254109, 627.7269387816315, 628.532401587667, 628.7547856336032, 3844.461775351453, 3961.2869683457257, 4051.858184963571, 4084.448599439097, 4151.356539736345, 100864.0, 103078.48460757648, 103565.48217259016, 103969.0, 104057.0, 82004.17995819966, 82422.76365854517, 87494.12505874987, 87854.0, 88746.55626721826, 60307.79384412375, 76489.61755191299, 76826.61586692031, 77491.45017099626, 78316.21683783089, 8881.644734210558, 8901.55492225399, 8908.821823563621, 8973.327000475121, 9061.501617411106, 52256.17103401363, 52459.73770131125, 52499.73750131225, 53453.732731336095, 54060.0, 68894.3110568908, 69368.6531567339, 72198.33619965638, 74811.62594187212, 74839.0, 9725.416475011521, 9758.804823903623, 10974.615888443866, 11116.16628752863, 11611.245269057485, 10697.411642359433, 11686.415679216176, 11907.583234587095, 12024.0, 12091.939540302243, 11607.883921160681, 11723.882761172621, 11878.731334024982, 11979.940100299442, 12097.2136811107, 11317.094632429222, 11356.662368686704, 11471.369074700971, 11674.241174323643, 12282.570110046105, 11340.659780206606, 11419.909547239005, 11421.37182454973, 11680.47437865281, 12252.142350035769, 9187.219086377465, 9349.626014959325, 9422.717318480456, 9767.706968790948, 9957.203423726229, 7878.936343593541, 8779.498856498009, 8824.196075725888, 9052.0, 9322.720318390458], "unit": "ms", "name": "yui.html", "value": 7026.196423750715}], "name": "dromaeo_css", "value": 7638.197560501109}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 106.0, 109.0, 109.0, 109.0, 107.0, 109.0, 103.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 119.0, 163.0, 176.0, 144.0, 139.0, 139.0, 117.0, 156.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 183.0, 185.0, 183.0, 184.0, 184.0, 185.0, 188.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 73.0, 74.0, 55.0, 72.0, 83.0, 102.0, 83.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 73.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 122.0, 76.0, 75.0, 75.0, 113.0, 73.0, 75.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 89.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 86.0, 86.0, 84.0, 85.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 84.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 99.0, 148.0, 92.0, 93.0, 93.0, 93.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 99.1}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 86.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 54.0, 53.0, 55.0, 53.0, 64.0, 52.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 66.0, 63.0, 67.0, 67.0, 67.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 82.0, 81.0, 81.0, 80.0, 81.0, 96.0, 105.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 121.0, 126.0, 127.0, 126.0, 133.0, 121.0, 128.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 136.0, 134.0, 159.0, 125.0, 136.0, 135.0, 136.0, 123.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 134.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 68.0, 65.0, 65.0, 65.0, 63.0, 67.0, 66.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1397.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.12620352540364], "unit": "score", "name": "Richards", "value": 238.32380200000006}, {"lowerIsBetter": false, "replicates": [161.73378618793467], "unit": "score", "name": "DeltaBlue", "value": 408.807594}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [4721.698113207547], "unit": "score", "name": "Decrypt", "value": 56.37399800199804}, {"lowerIsBetter": false, "replicates": [1712.3287671232877], "unit": "score", "name": "RayTrace", "value": 432.1535759999999}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12822.784810126583], "unit": "score", "name": "Boyer", "value": 51.974903257650524}, {"lowerIsBetter": false, "replicates": [27944.444444444445], "unit": "score", "name": "RegExp", "value": 32.59986083499008}, {"lowerIsBetter": false, "replicates": [680.7351940095303], "unit": "score", "name": "Splay", "value": 119.71027900000001}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 20517.51488082714}]} 12:13:46 INFO - RETURN: dromaeo_css: 7638.20 12:13:46 INFO - RETURN: kraken: 1397.00 12:13:46 INFO - RETURN: v8_7: 20517.51 12:13:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20517.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1397.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7638.20"}}} 12:13:47 INFO - Return code: 0 12:13:47 INFO - # TBPL SUCCESS # 12:13:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:13:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:13:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:13:47 INFO - 2015-11-23 12:13:47.045 screenresolution[2251:19248] starting screenresolution argv=screenresolution get 12:13:47 INFO - 2015-11-23 12:13:47.048 screenresolution[2251:19248] Display 0: 1600x1200x32@60 12:13:47 INFO - 2015-11-23 12:13:47.054 screenresolution[2252:19251] starting screenresolution argv=screenresolution list 12:13:47 INFO - Available Modes on Display 0 12:13:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:13:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:13:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:13:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:13:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:13:47 INFO - Intel Iris: 12:13:47 INFO - Chipset Model: Intel Iris 12:13:47 INFO - Type: GPU 12:13:47 INFO - Bus: Built-In 12:13:47 INFO - VRAM (Dynamic, Max): 1536 MB 12:13:47 INFO - Vendor: Intel (0x8086) 12:13:47 INFO - Device ID: 0x0a2e 12:13:47 INFO - Revision ID: 0x0009 12:13:47 INFO - Displays: 12:13:47 INFO - Display: 12:13:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:13:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:13:47 INFO - Display Serial Number: 1600x1200 60 12:13:47 INFO - Main Display: Yes 12:13:47 INFO - Mirror: Off 12:13:47 INFO - Online: Yes 12:13:47 INFO - Rotation: Supported 12:13:47 INFO - Return code: 0 12:13:47 INFO - Running post-action listener: _resource_record_post_action 12:13:47 INFO - Running post-run listener: _resource_record_post_run 12:13:48 INFO - Total resource usage - Wall time: 1241s; CPU: 53.0%; Read bytes: 2428928; Write bytes: 691145216; Read time: 35; Write time: 2416 12:13:48 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 338035200; Write bytes: 338606080; Read time: 27506; Write time: 663 12:13:48 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 2428928; Write bytes: 341266944; Read time: 35; Write time: 1716 12:13:48 INFO - Running post-run listener: _upload_blobber_files 12:13:48 INFO - Blob upload gear active. 12:13:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:13:48 INFO - Copying logs to upload dir... 12:13:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.090439 ========= master_lag: 1.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 12:13:50.299358) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:50.305886) ========= 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.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 build_url:https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009723 build_url: 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:50.337288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:50.337888) ========= 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.xERTFXUZDI/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.7bb92KRoD1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005467 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:50.390257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:13:50.394720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:13:50.395153) ========= ========= Total master_lag: 2.11 =========