builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1448013267.31 results: success (0) buildid: 20151120000936 builduid: 5a7cdf1acda44d55b6fe6d9a9244538c revision: 09cda89a211b76cce421e34a81346407df36c0f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.314426) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.315006) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.315337) ========= 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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005626 basedir: '/builds/slave/test' ========= master_lag: 0.20 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.518791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.519067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.574276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.574580) ========= 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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005980 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.629765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.630032) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.630379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:27.630679) ========= 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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-20 01:54:27-- 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.32M=0.001s 2015-11-20 01:54:28 (8.32 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.701098 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:28.462979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:28.463260) ========= 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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.026155 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:28.507797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:28.508157) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 09cda89a211b76cce421e34a81346407df36c0f3 --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 09cda89a211b76cce421e34a81346407df36c0f3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-20 01:54:28,591 truncating revision to first 12 chars 2015-11-20 01:54:28,591 Setting DEBUG logging. 2015-11-20 01:54:28,591 attempt 1/10 2015-11-20 01:54:28,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/09cda89a211b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 01:54:29,295 unpacking tar archive at: fx-team-09cda89a211b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:29.468482) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:29.468798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:29.485859) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:29.486241) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 01:54:29.486718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 43 secs) (at 2015-11-20 01:54:29.487046) ========= /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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:54:29 INFO - MultiFileLogger online at 20151120 01:54:29 in /builds/slave/test 01:54:29 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 01:54:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:29 INFO - {'append_to_log': False, 01:54:29 INFO - 'base_work_dir': '/builds/slave/test', 01:54:29 INFO - 'blob_upload_branch': 'Fx-Team', 01:54:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:29 INFO - 'branch': 'Fx-Team', 01:54:29 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:29 INFO - 'config_files': ('talos/mac_config.py',), 01:54:29 INFO - 'default_actions': ('clobber', 01:54:29 INFO - 'read-buildbot-config', 01:54:29 INFO - 'download-and-extract', 01:54:29 INFO - 'populate-webroot', 01:54:29 INFO - 'create-virtualenv', 01:54:29 INFO - 'install', 01:54:29 INFO - 'run-tests'), 01:54:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:29 INFO - 'download_minidump_stackwalk': True, 01:54:29 INFO - 'download_symbols': 'ondemand', 01:54:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:29 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:29 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:29 INFO - 'installer_path': 'installer.exe', 01:54:29 INFO - 'log_level': 'info', 01:54:29 INFO - 'log_name': 'talos', 01:54:29 INFO - 'log_to_console': True, 01:54:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:54:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:54:29 INFO - 'opt_config_files': (), 01:54:29 INFO - 'pip_index': False, 01:54:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:54:29 INFO - 'cmd': ('bash', 01:54:29 INFO - '-c', 01:54:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:54:29 INFO - 'enabled': True, 01:54:29 INFO - 'halt_on_failure': False, 01:54:29 INFO - 'name': 'check_screen_resolution'},), 01:54:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:54:29 INFO - 'cmd': ('bash', 01:54:29 INFO - '-c', 01:54:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:54:29 INFO - 'enabled': True, 01:54:29 INFO - 'halt_on_failure': False, 01:54:29 INFO - 'name': 'check_screen_resolution'},), 01:54:29 INFO - 'run_cmd_checks_enabled': True, 01:54:29 INFO - 'sps_profile': False, 01:54:29 INFO - 'sps_profile_interval': 0, 01:54:29 INFO - 'suite': 'dromaeojs', 01:54:29 INFO - 'system_bits': '64', 01:54:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:29 INFO - 'title': 't-yosemite-r7-0036', 01:54:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:29 INFO - 'use_talos_json': True, 01:54:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:29 INFO - 'work_dir': 'build'} 01:54:29 INFO - ##### 01:54:29 INFO - ##### Running clobber step. 01:54:29 INFO - ##### 01:54:29 INFO - Running pre-action listener: _resource_record_pre_action 01:54:29 INFO - Running main action method: clobber 01:54:29 INFO - rmtree: /builds/slave/test/build 01:54:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:31 INFO - Running post-action listener: _resource_record_post_action 01:54:31 INFO - ##### 01:54:31 INFO - ##### Running read-buildbot-config step. 01:54:31 INFO - ##### 01:54:31 INFO - Running pre-action listener: _resource_record_pre_action 01:54:31 INFO - Running main action method: read_buildbot_config 01:54:31 INFO - Using buildbot properties: 01:54:31 INFO - { 01:54:31 INFO - "properties": { 01:54:31 INFO - "buildnumber": 4, 01:54:31 INFO - "product": "firefox", 01:54:31 INFO - "script_repo_revision": "production", 01:54:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:54:31 INFO - "repository": "", 01:54:31 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:54:31 INFO - "buildid": "20151120000936", 01:54:31 INFO - "slavename": "t-yosemite-r7-0036", 01:54:31 INFO - "pgo_build": "False", 01:54:31 INFO - "basedir": "/builds/slave/test", 01:54:31 INFO - "project": "", 01:54:31 INFO - "platform": "yosemite_r7", 01:54:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:54:31 INFO - "slavebuilddir": "test", 01:54:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:54:31 INFO - "branch": "fx-team", 01:54:31 INFO - "repo_path": "integration/fx-team", 01:54:31 INFO - "stage_platform": "macosx64", 01:54:31 INFO - "builduid": "5a7cdf1acda44d55b6fe6d9a9244538c", 01:54:31 INFO - "revision": "09cda89a211b76cce421e34a81346407df36c0f3" 01:54:31 INFO - }, 01:54:31 INFO - "sourcestamp": { 01:54:31 INFO - "repository": "", 01:54:31 INFO - "hasPatch": false, 01:54:31 INFO - "project": "", 01:54:31 INFO - "branch": "fx-team-macosx64-talos", 01:54:31 INFO - "changes": [ 01:54:31 INFO - { 01:54:31 INFO - "category": null, 01:54:31 INFO - "files": [ 01:54:31 INFO - { 01:54:31 INFO - "url": null, 01:54:31 INFO - "name": "https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 01:54:31 INFO - } 01:54:31 INFO - ], 01:54:31 INFO - "repository": "", 01:54:31 INFO - "rev": "09cda89a211b76cce421e34a81346407df36c0f3", 01:54:31 INFO - "who": "cbook@mozilla.com", 01:54:31 INFO - "when": 1448013205, 01:54:31 INFO - "number": 6687724, 01:54:31 INFO - "comments": "Bug 1221040 - Add SHA-256 support to NativeCrypto and relevant tests to robocop. r=snorp", 01:54:31 INFO - "project": "", 01:54:31 INFO - "at": "Fri 20 Nov 2015 01:53:25", 01:54:31 INFO - "branch": "fx-team-macosx64-talos", 01:54:31 INFO - "revlink": "", 01:54:31 INFO - "properties": [ 01:54:31 INFO - [ 01:54:31 INFO - "buildid", 01:54:31 INFO - "20151120000936", 01:54:31 INFO - "Change" 01:54:31 INFO - ], 01:54:31 INFO - [ 01:54:31 INFO - "builduid", 01:54:31 INFO - "5a7cdf1acda44d55b6fe6d9a9244538c", 01:54:31 INFO - "Change" 01:54:31 INFO - ], 01:54:31 INFO - [ 01:54:31 INFO - "pgo_build", 01:54:31 INFO - "False", 01:54:31 INFO - "Change" 01:54:31 INFO - ] 01:54:31 INFO - ], 01:54:31 INFO - "revision": "09cda89a211b76cce421e34a81346407df36c0f3" 01:54:31 INFO - } 01:54:31 INFO - ], 01:54:31 INFO - "revision": "09cda89a211b76cce421e34a81346407df36c0f3" 01:54:31 INFO - } 01:54:31 INFO - } 01:54:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 01:54:31 INFO - Running post-action listener: _resource_record_post_action 01:54:31 INFO - ##### 01:54:31 INFO - ##### Running download-and-extract step. 01:54:31 INFO - ##### 01:54:31 INFO - Running pre-action listener: _resource_record_pre_action 01:54:31 INFO - Running main action method: download_and_extract 01:54:31 INFO - mkdir: /builds/slave/test/build/tests 01:54:31 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')]} 01:54:31 INFO - https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:54:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/test_packages.json 01:54:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/test_packages.json 01:54:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:54:35 INFO - Downloaded 1149 bytes. 01:54:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:54:35 INFO - Using the following test package requirements: 01:54:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:54:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 01:54:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'jsshell-mac.zip'], 01:54:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 01:54:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:54:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 01:54:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 01:54:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 01:54:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:54:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:54:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 01:54:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:35 INFO - https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:54:40 INFO - Downloaded 17525152 bytes. 01:54:40 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 01:54:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:54:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:54:43 INFO - Return code: 0 01:54:43 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 01:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:43 INFO - https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:54:54 INFO - Downloaded 17525152 bytes. 01:54:54 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 01:54:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:54:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:54:58 INFO - Return code: 0 01:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:58 INFO - https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:54:58 INFO - Downloaded 11130997 bytes. 01:54:58 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 01:54:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:54:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 01:54:59 INFO - Return code: 0 01:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:59 INFO - https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 01:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/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 01:55:06 INFO - Downloaded 109416534 bytes. 01:55:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:55:06 INFO - mkdir: /builds/slave/test/properties 01:55:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:06 INFO - Contents: 01:55:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:55:06 INFO - Running post-action listener: _resource_record_post_action 01:55:06 INFO - Running post-action listener: set_extra_try_arguments 01:55:06 INFO - ##### 01:55:06 INFO - ##### Running populate-webroot step. 01:55:06 INFO - ##### 01:55:06 INFO - Running pre-action listener: _resource_record_pre_action 01:55:06 INFO - Running main action method: populate_webroot 01:55:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:55:06 INFO - '../fennec_ids.txt'], 01:55:06 INFO - 'tests': ['tcheck2']}, 01:55:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:06 INFO - '--tppagecycles', 01:55:06 INFO - '7'], 01:55:06 INFO - 'tests': ['tsvgm']}}, 01:55:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:55:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:55:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:55:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'tests': ['damp', 'tps']}, 01:55:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['damp', 'tps']}, 01:55:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:55:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:06 INFO - 'other': {'tests': ['a11yr', 01:55:06 INFO - 'ts_paint', 01:55:06 INFO - 'tpaint', 01:55:06 INFO - 'sessionrestore', 01:55:06 INFO - 'sessionrestore_no_auto_restore']}, 01:55:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['a11yr', 01:55:06 INFO - 'ts_paint', 01:55:06 INFO - 'tpaint', 01:55:06 INFO - 'sessionrestore', 01:55:06 INFO - 'sessionrestore_no_auto_restore']}, 01:55:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['a11yr', 01:55:06 INFO - 'ts_paint', 01:55:06 INFO - 'tpaint', 01:55:06 INFO - 'sessionrestore', 01:55:06 INFO - 'sessionrestore_no_auto_restore']}, 01:55:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['a11yr', 01:55:06 INFO - 'ts_paint', 01:55:06 INFO - 'tpaint', 01:55:06 INFO - 'sessionrestore', 01:55:06 INFO - 'sessionrestore_no_auto_restore']}, 01:55:06 INFO - 'other_l64': {'tests': ['a11yr', 01:55:06 INFO - 'ts_paint', 01:55:06 INFO - 'tpaint', 01:55:06 INFO - 'sessionrestore', 01:55:06 INFO - 'sessionrestore_no_auto_restore']}, 01:55:06 INFO - 'other_nol64': {'tests': ['a11yr', 01:55:06 INFO - 'ts_paint', 01:55:06 INFO - 'tpaint', 01:55:06 INFO - 'sessionrestore', 01:55:06 INFO - 'sessionrestore_no_auto_restore']}, 01:55:06 INFO - 'svgr': {'tests': ['tsvgx', 01:55:06 INFO - 'tsvgr_opacity', 01:55:06 INFO - 'tart', 01:55:06 INFO - 'tscrollx', 01:55:06 INFO - 'cart']}, 01:55:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['tsvgx', 01:55:06 INFO - 'tsvgr_opacity', 01:55:06 INFO - 'tart', 01:55:06 INFO - 'tscrollx', 01:55:06 INFO - 'cart']}, 01:55:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'tests': ['tp5o']}, 01:55:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'talos_options': ['--e10s'], 01:55:06 INFO - 'tests': ['tp5o']}, 01:55:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'talos_options': ['--xperf_path', 01:55:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:06 INFO - 'tests': ['tp5n']}, 01:55:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:06 INFO - 'talos_options': ['--e10s', 01:55:06 INFO - '--xperf_path', 01:55:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:06 INFO - 'tests': ['tp5n']}}, 01:55:06 INFO - 'talos.zip': {'path': '', 01:55:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:06 INFO - Running post-action listener: _resource_record_post_action 01:55:06 INFO - ##### 01:55:06 INFO - ##### Running create-virtualenv step. 01:55:06 INFO - ##### 01:55:06 INFO - Running pre-action listener: _resource_record_pre_action 01:55:06 INFO - Running main action method: create_virtualenv 01:55:06 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55:06 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 01:55:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:06 INFO - Using real prefix '/tools/python27' 01:55:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:55:10 INFO - Installing pip.................done. 01:55:10 INFO - Return code: 0 01:55:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:10 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:10 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 01:55:10 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 01:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:10 INFO - 'HOME': '/Users/cltbld', 01:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:10 INFO - 'LOGNAME': 'cltbld', 01:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:10 INFO - 'MOZ_NO_REMOTE': '1', 01:55:10 INFO - 'NO_EM_RESTART': '1', 01:55:10 INFO - 'PAGER': '/bin/cat', 01:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:10 INFO - 'PWD': '/builds/slave/test', 01:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:10 INFO - 'SHELL': '/bin/bash', 01:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:10 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:10 INFO - 'USER': 'cltbld', 01:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:10 INFO - 'XPC_FLAGS': '0x0', 01:55:10 INFO - 'XPC_SERVICE_NAME': '0', 01:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:10 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 01:55:10 INFO - Cleaning up... 01:55:10 INFO - Return code: 0 01:55:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:10 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:10 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 01:55:10 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 01:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:10 INFO - 'HOME': '/Users/cltbld', 01:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:10 INFO - 'LOGNAME': 'cltbld', 01:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:10 INFO - 'MOZ_NO_REMOTE': '1', 01:55:10 INFO - 'NO_EM_RESTART': '1', 01:55:10 INFO - 'PAGER': '/bin/cat', 01:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:10 INFO - 'PWD': '/builds/slave/test', 01:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:10 INFO - 'SHELL': '/bin/bash', 01:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:10 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:10 INFO - 'USER': 'cltbld', 01:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:10 INFO - 'XPC_FLAGS': '0x0', 01:55:10 INFO - 'XPC_SERVICE_NAME': '0', 01:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:10 INFO - Downloading/unpacking psutil>=0.7.1 01:55:10 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 01:55:10 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 01:55:10 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 01:55:10 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 01:55:10 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 01:55:10 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 01:55:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:55:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:14 INFO - Installing collected packages: psutil 01:55:14 INFO - Running setup.py install for psutil 01:55:14 INFO - building 'psutil._psutil_osx' extension 01:55:14 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 01:55:14 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 01:55:14 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 01:55:14 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 01:55:14 INFO - building 'psutil._psutil_posix' extension 01:55:14 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 01:55:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:55:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:55:15 INFO - ^ 01:55:15 INFO - 1 warning generated. 01:55:15 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 01:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:15 INFO - Successfully installed psutil 01:55:15 INFO - Cleaning up... 01:55:15 INFO - Return code: 0 01:55:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:55:15 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')]} 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 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')]} 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:15 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 01:55:15 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 01:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:15 INFO - 'HOME': '/Users/cltbld', 01:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:15 INFO - 'LOGNAME': 'cltbld', 01:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:15 INFO - 'MOZ_NO_REMOTE': '1', 01:55:15 INFO - 'NO_EM_RESTART': '1', 01:55:15 INFO - 'PAGER': '/bin/cat', 01:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:15 INFO - 'PWD': '/builds/slave/test', 01:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:15 INFO - 'SHELL': '/bin/bash', 01:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:15 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:15 INFO - 'USER': 'cltbld', 01:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:15 INFO - 'XPC_FLAGS': '0x0', 01:55:15 INFO - 'XPC_SERVICE_NAME': '0', 01:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:55:15 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 01:55:15 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 01:55:15 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 01:55:15 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 01:55:15 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 01:55:15 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 01:55:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:55:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:55:17 INFO - Installing collected packages: mozsystemmonitor 01:55:17 INFO - Running setup.py install for mozsystemmonitor 01:55:17 INFO - Successfully installed mozsystemmonitor 01:55:17 INFO - Cleaning up... 01:55:17 INFO - Return code: 0 01:55:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:17 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')]} 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 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')]} 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:17 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 01:55:17 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 01:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:17 INFO - 'HOME': '/Users/cltbld', 01:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:17 INFO - 'LOGNAME': 'cltbld', 01:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:17 INFO - 'MOZ_NO_REMOTE': '1', 01:55:17 INFO - 'NO_EM_RESTART': '1', 01:55:17 INFO - 'PAGER': '/bin/cat', 01:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:17 INFO - 'PWD': '/builds/slave/test', 01:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:17 INFO - 'SHELL': '/bin/bash', 01:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:17 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:17 INFO - 'USER': 'cltbld', 01:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:17 INFO - 'XPC_FLAGS': '0x0', 01:55:17 INFO - 'XPC_SERVICE_NAME': '0', 01:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:18 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:20 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:20 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 01:55:20 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 01:55:20 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 01:55:20 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 01:55:20 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 01:55:20 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 01:55:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55:21 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 01:55:21 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 01:55:21 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 01:55:21 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 01:55:21 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 01:55:21 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 01:55:21 INFO - Downloading docopt-0.6.1.tar.gz 01:55:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:21 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:21 INFO - Running setup.py install for blobuploader 01:55:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:21 INFO - Running setup.py install for requests 01:55:22 INFO - Running setup.py install for docopt 01:55:22 INFO - Successfully installed blobuploader requests docopt 01:55:22 INFO - Cleaning up... 01:55:22 INFO - Return code: 0 01:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:22 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:22 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 01:55:22 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 01:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:22 INFO - 'HOME': '/Users/cltbld', 01:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:22 INFO - 'LOGNAME': 'cltbld', 01:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:22 INFO - 'MOZ_NO_REMOTE': '1', 01:55:22 INFO - 'NO_EM_RESTART': '1', 01:55:22 INFO - 'PAGER': '/bin/cat', 01:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:22 INFO - 'PWD': '/builds/slave/test', 01:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:22 INFO - 'SHELL': '/bin/bash', 01:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:22 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:22 INFO - 'USER': 'cltbld', 01:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:22 INFO - 'XPC_FLAGS': '0x0', 01:55:22 INFO - 'XPC_SERVICE_NAME': '0', 01:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-h6BkdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-H9BG_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-4clgTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-muu2Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-GWk_HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-XW0Q2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-zCzX3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-erpZeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-noprlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-iAYhTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-_c3XZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-xfApOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-R_4fdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:24 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-PYgUTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:24 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nolubh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:24 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CclfAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:24 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ZhFvjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:24 INFO - Running setup.py install for manifestparser 01:55:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:55:24 INFO - Running setup.py install for mozcrash 01:55:24 INFO - Running setup.py install for mozdebug 01:55:24 INFO - Running setup.py install for mozdevice 01:55:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozfile 01:55:25 INFO - Running setup.py install for mozhttpd 01:55:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozinfo 01:55:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozInstall 01:55:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozleak 01:55:25 INFO - Running setup.py install for mozlog 01:55:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for moznetwork 01:55:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Running setup.py install for mozprocess 01:55:26 INFO - Running setup.py install for mozprofile 01:55:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Running setup.py install for mozrunner 01:55:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Running setup.py install for mozscreenshot 01:55:26 INFO - Running setup.py install for moztest 01:55:26 INFO - Running setup.py install for mozversion 01:55:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:27 INFO - Cleaning up... 01:55:27 INFO - Return code: 0 01:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55: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')]} 01:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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')]} 01:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:27 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:27 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 01:55:27 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 01:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:27 INFO - 'HOME': '/Users/cltbld', 01:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:27 INFO - 'LOGNAME': 'cltbld', 01:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:27 INFO - 'MOZ_NO_REMOTE': '1', 01:55:27 INFO - 'NO_EM_RESTART': '1', 01:55:27 INFO - 'PAGER': '/bin/cat', 01:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:27 INFO - 'PWD': '/builds/slave/test', 01:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:27 INFO - 'SHELL': '/bin/bash', 01:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:27 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:27 INFO - 'USER': 'cltbld', 01:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:27 INFO - 'XPC_FLAGS': '0x0', 01:55:27 INFO - 'XPC_SERVICE_NAME': '0', 01:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-sTdVNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:27 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)) 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-rIVLvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:27 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)) 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-0SiKyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:27 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)) 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-coNxEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:27 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)) 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-iRGX7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:27 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)) 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-NGh8l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:27 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)) 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:27 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Efk6kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-NiSo5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-c6kliN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-mRoxSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-b1DfBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Iaw5yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-5fN9RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-kvz6d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CVRohm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-99vYuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:28 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)) 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:28 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-avJ5mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:29 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)) 01:55:29 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)) 01:55:29 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)) 01:55:29 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)) 01:55:29 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)) 01:55:29 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)) 01:55:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:31 INFO - Downloading blessings-1.5.1.tar.gz 01:55:31 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 01:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:31 INFO - Installing collected packages: blessings 01:55:31 INFO - Running setup.py install for blessings 01:55:31 INFO - Successfully installed blessings 01:55:31 INFO - Cleaning up... 01:55:31 INFO - Return code: 0 01:55:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:31 INFO - Reading from file tmpfile_stdout 01:55:31 INFO - Current package versions: 01:55:31 INFO - blessings == 1.5.1 01:55:31 INFO - blobuploader == 1.2.4 01:55:31 INFO - docopt == 0.6.1 01:55:31 INFO - manifestparser == 1.1 01:55:31 INFO - mozInstall == 1.12 01:55:31 INFO - mozcrash == 0.16 01:55:31 INFO - mozdebug == 0.1 01:55:31 INFO - mozdevice == 0.47 01:55:31 INFO - mozfile == 1.2 01:55:31 INFO - mozhttpd == 0.7 01:55:31 INFO - mozinfo == 0.9 01:55:31 INFO - mozleak == 0.1 01:55:31 INFO - mozlog == 3.0 01:55:31 INFO - moznetwork == 0.27 01:55:31 INFO - mozprocess == 0.22 01:55:31 INFO - mozprofile == 0.27 01:55:31 INFO - mozrunner == 6.11 01:55:31 INFO - mozscreenshot == 0.1 01:55:31 INFO - mozsystemmonitor == 0.0 01:55:31 INFO - moztest == 0.7 01:55:31 INFO - mozversion == 1.4 01:55:31 INFO - psutil == 3.1.1 01:55:31 INFO - requests == 1.2.3 01:55:31 INFO - wsgiref == 0.1.2 01:55:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:31 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')]} 01:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:31 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')]} 01:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:31 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 0x100a44490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a21228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63358a870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, '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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 01:55:31 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 01:55:31 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 01:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:31 INFO - 'HOME': '/Users/cltbld', 01:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:31 INFO - 'LOGNAME': 'cltbld', 01:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:31 INFO - 'MOZ_NO_REMOTE': '1', 01:55:31 INFO - 'NO_EM_RESTART': '1', 01:55:31 INFO - 'PAGER': '/bin/cat', 01:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:31 INFO - 'PWD': '/builds/slave/test', 01:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:31 INFO - 'SHELL': '/bin/bash', 01:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:55:31 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:31 INFO - 'USER': 'cltbld', 01:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:31 INFO - 'XPC_FLAGS': '0x0', 01:55:31 INFO - 'XPC_SERVICE_NAME': '0', 01:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 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)) 01:55:32 INFO - Cleaning up... 01:55:32 INFO - Return code: 0 01:55:32 INFO - Running post-action listener: _resource_record_post_action 01:55:32 INFO - Running post-action listener: _start_resource_monitoring 01:55:32 INFO - Starting resource monitoring. 01:55:32 INFO - ##### 01:55:32 INFO - ##### Running install step. 01:55:32 INFO - ##### 01:55:32 INFO - Running pre-action listener: _resource_record_pre_action 01:55:32 INFO - Running main action method: install 01:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:32 INFO - Reading from file tmpfile_stdout 01:55:32 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:55:32 INFO - Reading from file tmpfile_stdout 01:55:32 INFO - Output received: 01:55:32 INFO - Usage: mozinstall [options] installer 01:55:32 INFO - Options: 01:55:32 INFO - -h, --help show this help message and exit 01:55:32 INFO - -d DEST, --destination=DEST 01:55:32 INFO - Directory to install application into. [default: 01:55:32 INFO - "/builds/slave/test"] 01:55:32 INFO - --app=APP Application being installed. [default: firefox] 01:55:32 INFO - mkdir: /builds/slave/test/build/application 01:55:32 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'] 01:55:32 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 01:56:02 INFO - Reading from file tmpfile_stdout 01:56:02 INFO - Output received: 01:56:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:56:02 INFO - Running post-action listener: _resource_record_post_action 01:56:02 INFO - ##### 01:56:02 INFO - ##### Running run-tests step. 01:56:02 INFO - ##### 01:56:02 INFO - Running pre-action listener: _resource_record_pre_action 01:56:02 INFO - Running main action method: run_tests 01:56:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:56:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:56:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:56:02 INFO - 2015-11-20 01:56:02.912 screenresolution[1643:8359] starting screenresolution argv=screenresolution get 01:56:02 INFO - 2015-11-20 01:56:02.914 screenresolution[1643:8359] Display 0: 1600x1200x32@60 01:56:02 INFO - 2015-11-20 01:56:02.920 screenresolution[1644:8362] starting screenresolution argv=screenresolution list 01:56:02 INFO - Available Modes on Display 0 01:56:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:56:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:56:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:56:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:56:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:56:03 INFO - Intel Iris: 01:56:03 INFO - Chipset Model: Intel Iris 01:56:03 INFO - Type: GPU 01:56:03 INFO - Bus: Built-In 01:56:03 INFO - VRAM (Dynamic, Max): 1536 MB 01:56:03 INFO - Vendor: Intel (0x8086) 01:56:03 INFO - Device ID: 0x0a2e 01:56:03 INFO - Revision ID: 0x0009 01:56:03 INFO - Displays: 01:56:03 INFO - Display: 01:56:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:56:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:56:03 INFO - Display Serial Number: 1600x1200 60 01:56:03 INFO - Main Display: Yes 01:56:03 INFO - Mirror: Off 01:56:03 INFO - Online: Yes 01:56:03 INFO - Rotation: Supported 01:56:03 INFO - Return code: 0 01:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:03 INFO - Python 2.7.3 01:56:03 INFO - Return code: 0 01:56:03 INFO - grabbing minidump binary from tooltool 01:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:03 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 0x1009689f0>, '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 0x1006c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095b8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56:03 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 01:56:03 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 01:56:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:03 INFO - Return code: 0 01:56:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:56:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:56:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56:03 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/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost'] in /builds/slave/test/build 01:56:03 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/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --webServer localhost 01:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJoZZqCbzt/Render', 01:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:03 INFO - 'HOME': '/Users/cltbld', 01:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:03 INFO - 'LOGNAME': 'cltbld', 01:56:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:03 INFO - 'MOZ_NO_REMOTE': '1', 01:56:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:03 INFO - 'NO_EM_RESTART': '1', 01:56:03 INFO - 'PAGER': '/bin/cat', 01:56:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:03 INFO - 'PWD': '/builds/slave/test', 01:56:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:03 INFO - 'SHELL': '/bin/bash', 01:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwqI8qLjaW/Listeners', 01:56:03 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 01:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:03 INFO - 'USER': 'cltbld', 01:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:03 INFO - 'XPC_FLAGS': '0x0', 01:56:03 INFO - 'XPC_SERVICE_NAME': '0', 01:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:03 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/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost'] with output_timeout 3600 01:56:03 INFO - mozversion INFO | application_buildid: 20151120000936 01:56:03 INFO - mozversion INFO | application_changeset: 09cda89a211b76cce421e34a81346407df36c0f3 01:56:03 INFO - mozversion INFO | application_display_name: Nightly 01:56:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:03 INFO - mozversion INFO | application_name: Firefox 01:56:03 INFO - mozversion INFO | application_remotingname: firefox 01:56:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:56:03 INFO - mozversion INFO | application_vendor: Mozilla 01:56:03 INFO - mozversion INFO | application_version: 45.0a1 01:56:03 INFO - mozversion INFO | platform_buildid: 20151120000936 01:56:03 INFO - mozversion INFO | platform_changeset: 09cda89a211b76cce421e34a81346407df36c0f3 01:56:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:03 INFO - mozversion INFO | platform_version: 45.0a1 01:56:03 INFO - 2015-11-20 01:56:03,470 DEBUG : using testdate: 1448013363 01:56:03 INFO - 2015-11-20 01:56:03,470 DEBUG : actual date: 1448013363 01:56:03 INFO - 2015-11-20 01:56:03,852 INFO : starting webserver on 'localhost:49264' 01:56:03 INFO - 2015-11-20 01:56:03,853 INFO : Starting test suite t-yosemite-r7-0036 01:56:03 INFO - 2015-11-20 01:56:03,853 INFO : Starting test dromaeo_css 01:56:03 INFO - 2015-11-20 01:56:03,853 DEBUG : operating with platform_type : mac_ 01:56:03 INFO - 2015-11-20 01:56:03,854 INFO : Initialising browser for dromaeo_css test... 01:56:03 INFO - 2015-11-20 01:56:03,866 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp5gbiLj/profile http://localhost:49264/getInfo.html 01:56:06 INFO - 2015-11-20 01:56:06,113 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:56:06 INFO - 2015-11-20 01:56:06,113 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:56:06 INFO - 2015-11-20 01:56:06,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:56:06 INFO - 2015-11-20 01:56:06,113 DEBUG : BROWSER_OUTPUT: __metrics 01:56:06 INFO - 2015-11-20 01:56:06,131 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:56:06 INFO - 2015-11-20 01:56:06,794 INFO : Browser initialized. 01:56:06 INFO - 2015-11-20 01:56:06,794 INFO : Running cycle 1/1 for dromaeo_css test... 01:56:06 INFO - 2015-11-20 01:56:06,795 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp5gbiLj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:56:18 INFO - 2015-11-20 01:56:18,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 225198080 01:56:18 INFO - 2015-11-20 01:56:18,581 DEBUG : BROWSER_OUTPUT: 01:57:10 INFO - 2015-11-20 01:57:10,050 DEBUG : BROWSER_OUTPUT: 1448013430042 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] 01:59:21 INFO - 2015-11-20 01:59:21,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 01:59:22 INFO - 2015-11-20 01:59:22,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 423239680 01:59:22 INFO - 2015-11-20 01:59:22,833 DEBUG : BROWSER_OUTPUT: 02:02:25 INFO - 2015-11-20 02:02:25,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 02:02:26 INFO - 2015-11-20 02:02:26,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 361746432 02:02:26 INFO - 2015-11-20 02:02:26,278 DEBUG : BROWSER_OUTPUT: 02:05:28 INFO - 2015-11-20 02:05:28,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 02:05:28 INFO - 2015-11-20 02:05:28,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 332656640 02:05:28 INFO - 2015-11-20 02:05:28,921 DEBUG : BROWSER_OUTPUT: 02:08:31 INFO - 2015-11-20 02:08:31,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 02:08:31 INFO - 2015-11-20 02:08:31,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 322355200 02:08:31 INFO - 2015-11-20 02:08:31,647 DEBUG : BROWSER_OUTPUT: 02:11:34 INFO - 2015-11-20 02:11:34,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 02:11:35 INFO - 2015-11-20 02:11:35,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 323575808 02:11:35 INFO - 2015-11-20 02:11:35,254 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 02:14:38 INFO - 2015-11-20 02:14:38,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 402145280 02:14:38 INFO - 2015-11-20 02:14:38,385 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,385 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:14:38 INFO - 2015-11-20 02:14:38,385 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:14:38 INFO - 2015-11-20 02:14:38,385 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:14:38 INFO - 2015-11-20 02:14:38,385 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:14:38 INFO - 2015-11-20 02:14:38,386 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3442.3459542686887;3508.158042069904;3535.664111909368;3540.2211513467028;3591.784492930424;5701.144828275761;5841.269841269841;5924.792632257871;5978.461938425541;6006.699665016748;5878.265216847894;5967.104934259853;5968.134620480038;6007;6011.128386383972;4508.61676757476;5375.516203541681;5461.15352120422;5472.753726082336;5511.22842802008;5512.255845460852;5518.503334699876;5519.917201241985;5526.171074338861;5526.723663816813;5493;5500.724963751816;5506.614536982393;5512.834614961537;5528.170774383834;5320.122179840341;5412.025835349636;5472.890542189154;5473.425290344497;5530.5299049580835;5353.892922141575;5432.13085906257;5443.646162999393;5453.727313634303;5482.725863706799;5633.352164501094;5783.074708046693;5847.093700476433;5885.61743486672;6027.819165425044;5818.5636077294375;6215.720292586844;6285.025820997753;6309.621422714652;6315.715792789336;6245.313015568284;6350.904736428911;6352.047192921053;6362.268339141012;6371.490280777573;6060.272767267912;6090.847728806815;6106.786262480792;6120.96939515304;6122.602030867979;5152.690838549699;6255.843603909939;6299.748010079546;6303.149074874925;6469.741210351627;6195.752169913243;6292.653904035322;6310.495160387158;6313.021481670348;6320.747170113144;6341.175647165931;6385.648789316632;6387.393197646216;6390.137331460286;6399.520035997319;6134.110553969649;6294.0558916162945;6295.559310848288;6309.08518264849;6319.368063193736;6131.308192042429;6215.844603884849;6248.562600617913;6271.122042913996;6273.309935907047;5104.821331253388;5109.8722531936255;5125.384953805567;5129.846104616868;5136.640435169502;4490.932636010462;4605.953940460552;4613.754286342669;4624.098300831306;4666.696664716783;4637.582617564368;5808.419158084158;5821.79623713168;5830.067189249699;5870.178175055496;6334.271558770708;6348;6364.077208804697;6385.138006369174;6391.360863913572;5724.971375143097;5851.093080572518;5872.559558033079;5915.352365741648;6034;5485.4788795064405;5517.834464966058;5518.751656175482;5521.641093328921;5573.442655734394;6485.254195767453;6508.576942498722;6568.835779105656;6581.934180658323;6605.405513503808;6201.472874805692;6291.937080629135;6313.147725057059;6365.039427910671;6411.647359395091;6424.164858568356;6465.2564955030775;6468.935310646833;6478.319776423407;6484.870302594016;6251.124842521959;6275.592086514362;6286.308506064238;6301.684915754102;6333.809985700436;5349.839504814861;6100.412552313782;6252.687365631609;6268.404501572343;6348.650824204528;5251.658642188246;6056.697165141637;6097.857415702912;6212;6261.68691565429;6238.594491358047;6263.060540918898;6279;6310.810675679737;6313.621182729051;5067.822626208065;5922.318933322551;6022.376216936925;6135.049067394561;6175.752969881334;6136.631802091889;6150.907736384047;6152.784652537319;6163.7842675506145;6168.660723660242;6062.848428789315;6118.541109416722;6129.478994285536;6135.416406698409;6143.938560614337 02:14:38 INFO - 2015-11-20 02:14:38,389 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.3166799445553;568.56504773848;594.6105301027823;614.1555361378105;647.9956068094452;31531.369372612535;40973;41000.58999410005;41025;41111.17777644449;42766.78616606921;43120.490782822606;43124;43141.56858431415;43158.705238842886;8873.866891996626;8969.013408525057;9735.756606084851;9940.15508681763;9961.35251208669;8879;8922.10778922109;8944.329175311845;8954;12095.879041209608;11896.7620647587;11976.221545599552;11998.220115692495;12025.51897924082;12072.577459788909;11921.986631136364;12046.638600841989;12064.517419303218;12073.758524829454;12143.271403715806;8900.42147260426;9044;9045.4572725636;9053.230475409599;11784.587539436165;32134.678653213403;42891.78554107241;43035.35446968298;43179.920501987384;43186.568134318884;3255.5604993326074;3267.901962941092;3540.929181416383;3646.562412510489;3848.5574158971795;28351.858240708872;28633.71366286352;29102.41795164106;29325.627552831484;30074.398512029857;2717.959230611523;2760.489309477753;2834.3339315260896;2864.455753406846;2941.485240082977;514132;519517;520427;520523;521624;68081.3191868075;68538.65730671315;68562;68602;68691.65654171698;72385;72425;72526;72741;72840;16169.757453638205;16606.83393166077;16611.252493637814;16630.002199868046;16667.91666041662;12667;12728.1726687765;12734.29961352116;12737.617871463872;12760.234385936874;16527.669446611002;19639.705404418946;20385.694214586794;21470.677939830915;21654.458638534164;9284.62861485533;9460.8580871287;9483.383580067273;9502.239820814457;9546.236301095896;974.6247694637474;975.7170420577953;1018.1091544898214;1047.418682631147;1049.95004995005;25604.743952560235;26135.477290454466;29904.700952990628;32112.518312225337;32578.660625319262;807.3944541593804;995.8854731705802;1066.9833964318443;1076.219740687995;1086.9456527173609;14987.925060374628;15078.698426031418;15117;16572.917135414245;16745.748813767805;666911;674744;675666;676255;761072;51593.48406515962;54348.72825635847;64661.67669161624;64788.67605661941;64984.67507662431;1335.7528857161456;1446.6528033271939;1463.1075044222803;1465.3479201755329;1465.7801329800616;28798.71201288044;29784.21507546685;30480.933167339037;31886.84056579795;32044.83977580097;56064.43935560592;56738;56746;56762.432375675715;56783.43216567781;494275.528622369;498877;498926;499865;500847;43195.78402107969;43764.717646176025;44408.777956111306;44531;44564.33153502635;45826.08347832958;45888;46151.76924115358;46966.53033469622;47224.2916356248;37376.252474950896;38926.02684932786;39110.72954518224;39495.605043949196;39557.60442395539;37311.2537749238;37427.87716368513;38688;38751.22497549977;38776.41835372528;38253.80873095617;38527.0368240785;39098.21803563856;40050.1989960205;40198.1960360797;28831;33614.71299274775;33848.83075584705;33900.3219935595;34041.82979085089;25314.87342563349;25598.616020760077;26093.347666308495;26556.8672156638;26881.596776047983 02:14:38 INFO - 2015-11-20 02:14:38,389 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.54625944439726;362.47622185941316;368.47308349060864;370.4646785395104;375.4874596176219;15965.361385544593;17006.40477583285;19493.12280947357;20043.799562004395;20192.394228173143;19730.605387892232;19778.70331945022;19811.306604268855;21216.89391553044;21294.787052129475;4753.691010084351;6522.184726909137;6700.564463309869;6714.160729908762;6715.891877840175;4854.17479028566;4902.926456103161;7433.851322973537;7630.4658673892845;7635.541867487968;7444.7390809001145;7590.3927685785;7608.239176082403;7642.465027448081;7646.579438130901;7456.5898875561825;7549.471536992412;7605.809854753647;7606.250562370658;7619.238076192337;7284.344409003215;7294.3799777018485;7303.01409309747;7305.196428392873;7305.598192099433;27397.863010685018;27826.443471130668;27878.72121278802;28443.573346399822;28450.146495604957;1864.8414884734677;2192.3422973108163;2222.577071627466;2235.7205349331334;2254.5490901819703;15281.770773438408;15514.301856416489;15586.532404027785;15801.60495987598;16280;1674;1760.5246583422404;1781.234069350179;1788.8211178882138;2002.6495363311362;75356.24643753601;88553;100170.49914750452;100458;102323.48838255835;10721.463926803628;11012.119030477543;11078.723031924266;11092.500837462334;11129.332240065622;13370.665733356549;13443;13487.190768553919;13542.932285338511;13551.186928784304;7774.494657847335;8177.304929080976;8544.273736732448;8545.914540854636;8576.614052367659;7009.193942696553;8654.826903461895;8678.218960293603;8721.563921803885;8759.824803503894;3967.6429121379215;4024.9195016099516;4120.031792528754;4247.362895565628;4333.869983900425;1512.311898086368;1532.99233503834;1637.656092220647;1702.9148542572823;1809.6742586334585;863.6372723456163;889.5241046040467;931.2224292715523;956.6125719083782;1094.8631421072366;14107.083039602392;19585.922774247552;19737.60524789496;19835.603287934162;19854.1065652046;933.4772527384687;968.6028728221395;987.1905037869022;1037.4397825174472;1056.6196169379018;10171.796564068678;10312.175025997902;11052.418932467428;11552.884471155348;11554.59558915434;695095;703969;745306;748135.2593236999;759163;94121;117978;119199.40400298116;120604.19093713601;122397;1180.0913296761446;1218.3908045977012;1232.796588562895;1233.3709807997986;1234.9135560510679;14305.57083287503;17542.824571754118;18287;18324.26702931921;18730.71903921415;48966.41727851403;51352.74323628358;53470.93058138738;53870;54082.45917540774;70226;71165;72135;75510.62244688741;76074.23925760893;9597.040295970348;9664.565094570902;9936.304458687822;9949.403035817873;9956.601735930482;11952;16885.831141688916;19830.801691982895;20173;20410.77535347884;15028;15097.245137743288;15367.61580960485;15645;16139.596510087342;11746.76506469883;15214.163221022507;15256;15473.226338682796;15597.532074037797;15986.840131598536;16246.756298655766;16411.93322434038;16439.91780041092;16448.506544803677;9341.532923353941;9695.078967498077;9746.9025309746;9815.2147828175;9829.361091529028;10412.895871041193;11739.413029348327;14486.85513144855;15172.165530895465;16191.433299834449 02:14:38 INFO - 2015-11-20 02:14:38,392 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1564.7809306697065;1569.8273189949111;1692.5768557860536;1893.5171531259532;1902.362708492655;7513;7948;8063;8129.39029572783;8136.633851476698;6345.7144428500715;8208.343332533397;8327.875081873777;8354.958225208866;8791.296696264299;2136.700861879338;2186.1255497800926;2369.8578085314934;2398.2805158452484;2399.8320117591775;2176.662617294322;2371.3715865295712;2402.5555272274687;2406.95186096278;2409.3494756415844;2320.640300753386;2358.151065616377;2364;2370.8577485350934;2376.2039716694926;2128.6062078515524;2174.923877664274;2178.8256939444805;2361.787439130478;2406.133791834947;2105.3052492677534;2365.27859003004;2401.2076014915037;2411.638254261857;2414.6015907375436;8252.257296843252;8348.958255208745;8354.456960297623;8354.624041918129;8359.205875441823;5083.872903177413;5170.302009228782;5178.482151784829;5196.480351964811;5198.090334191501;3485.7385696072897;3496.3798371172184;3524.312759011994;3561.4301711726257;3582.140286331288;1068.8610480637467;1079.1366906474789;1420.3324437514352;1653.94147745443;1675.2377668160957;10996.450177491173;11109.388983605979;11119;11132.554697812078;11147.66557003283;4471.150481408587;4509.188346097734;4588.128255631419;4595.195840727859;4620.584147426748;9116.81766364669;9128.22410095136;9135.314851386172;9139.90860091404;9148.588313525906;4426.933595996063;5105.183170692671;5130.179171332569;5154.974225128851;5170.379554453414;4717.22165842639;4720.0559888022535;4732.574068333866;4762.119007983465;4771.856844294677;3402.3365443738235;3448.706859916935;3473.774204676688;3506.316268327703;3506.403911335079;966.4974213408988;1045.482486169351;1113.2429947635685;1154.168998321224;1159.9478023488964;1083.864516935383;1099.5217080569978;1099.8955099265556;1292.095533126815;1424.7150569885857;7696.345810606049;7892.28969392746;7948.523088614702;7952.960235198787;7963.283304502506;1196.0371900620084;1199.3763243113706;1206.5294535131306;1207.209277922962;1223.7797196504537;6009.519238461;6113.358097399798;6123.387661233841;6166.907496387557;6356.618602883842;9523.19052880513;9596.472194029257;9654.517274136266;9697.321187516805;9841.704748857546;9494.810103798023;9613.951930240304;9626.566804493674;9629.988851170667;9726.319157658896;7496.7001319947685;7615.314621684075;7650.8087297818;7717.498362606412;7760.961195194101;7812.414068944739;7845.490043147177;7850.018747656543;7867.645955931882;7876.921230787619;8849.823003540021;9008.391677838914;9097.363184577016;9122.407043542149;9144.63421463134;9198.2181514572;9341.159295663423;9512.667056652985;9515.000924902786;9525.237980961369;6840.042394064934;6917.446604271747;6919.37725604698;6928.896066559107;6936.167659880846;8008.199180082178;8020.558869262247;8097.757067287991;8115.959420202861;8130.796730081559;7398.889016664647;7520.9094681272;7536.171021187774;7665.080190377191;7673.731419400518;7372.631368431665;7449.664765085476;7472.813179670552;7545.094588649397;7601.467897247361;7528.962355188189;7584.620768961419;7585.165631780389;7588.734394296173;7599.734009309647;6776;6911.308869113049;6914.204866440424;6922.10012698346;6936.132983377078;6492.513061520311;6982.266861979419;7031.156261248683;7046.612436315847;7049.471289653194 02:14:38 INFO - 2015-11-20 02:14:38,394 DEBUG : BROWSER_OUTPUT: |4;prototype.html;274.28138277712395;319.39315300928234;330.18115074614957;332.5311311051417;336.2400973799213;5398.325209348832;5477.342718873736;6621.735130594782;6732.73069077237;6896.931030689691;5321.3348331458565;6637.0708100865795;6771.984202369647;6779.72881084756;6786.083878676377;5040.873978150539;5062.873428164288;5100.9489905100845;5104.821331253407;5115.667481613702;4835.298881662157;4980.128477516439;5080.491950804909;5093.083245015896;5107.872303192431;4991.575716064139;5078.7968481260705;5085.982803439309;5097.980403919212;5116;5086.364204474441;5087.9824035193105;5088.084144853925;5098.949010509885;5108.08054550179;4310.43964284641;4334.241507736134;4334.4798624165305;4341.500727416356;4349.934750978738;5103.8213662522;6596.80209593713;6616.338366163393;6642.335766423367;6646;5972.313183983854;5975.731092100866;5980.940190598082;5984.97007514964;6004.759809607611;7063.609467455599;7389.8522029559645;7407.962960185218;7407.999840043158;7413.88879166813;4554.499005109468;4719.858404247878;4753.548412900769;4783.569478746895;4788.904221915543;6254.562180647356;7423.146338171072;7752.689892404297;7760.340371068466;7790.337821285198;4236.957630423718;4872.074305881871;4895.485973972753;4898.142825005681;4901.289313049588;4824.782884770194;4952.975235123801;5013.147764879979;5016.44819069902;5017.096922553976;5881.2942446906645;5883.7058147092475;5883.794067207627;5887.646741195542;5889.882202355929;7396.704131834774;7398.704051837974;7406.14829294638;7408.333250007525;7423.85152296951;1634.1420754103954;1691.2473949092537;1693.7798086248956;1729.740538919147;1750.0374793863325;1052.4053909541085;1068.5031460370965;1072.3726619927274;1076.445630500293;1080.0549519170725;6237.937620623827;6801.897971530431;6827.590344579341;6839.726410943606;6846.726130954806;7567.167611562723;7582.62086895653;7582.962085189539;7583.544987300779;7583.734569290048;6572.07990881277;6762.797116086525;6801.2178599461695;6819.7272109116075;6845.486588505882;3979.5423526294267;4006.338954072545;4011.719179657396;4012.057166565855;4013.097053163015;7778.183290754502;7809.726659567002;7816.6091695416135;7824.256695613907;7826.2173782621285;6552.868942621121;7829.3736501079775;7844.607769611496;8032.196780322038;8045;6949.409300209438;7512.797952327602;8038.919610803817;8044.195580442026;8049.678012879419;7469.7012119516785;7556.773296801105;7600.657970391456;7614.771556853303;7747.457677962489;7618.200088990798;7623.618819059136;7643.235676432312;7644.961775191088;7645.426593005435;7804.9609751950875;8004.279614834692;8008.399370047153;8023.037235531773;8042.3968202383885;4306.806193721352;4472.306792447046;4760.97639007615;4798.616110711065;4820.373351464287;6149.385061493994;7664.961675191588;7670.616469176407;7685.308322251024;7695.730649427243;7217.855642887008;7362.484626076338;7404.777856664308;7409;7428.405727541675;7354.742584009534;7354.742584009534;7355;7360;7362;5838.357780644211;7202;7204.89192662121;7214.350708436056;7235.529690570096;5735.4551317624755;7377.5204611700065;7402.1117465904435;7402.629868506446;7404.111506619241;6181.660008699565;7214.783556493314;7222.855542889218;7244.782656520313;7259.7494776619415 02:14:38 INFO - 2015-11-20 02:14:38,395 DEBUG : BROWSER_OUTPUT: |5;yui.html;696.7700658782602;712.398023669999;747.1407880936922;748.2255865179541;826.3802148388709;14556.272186390677;14943.925280373584;14959.700805983874;14963;14965.925170374132;13753.65615859604;13845.238511881842;13895.652608684788;13901.930490347559;13962.860371396308;760.52467207995;771.0901136658769;771.907371115467;947.2232769129316;955.3074021334512;947.1286416496839;949.7957939043105;962.9855552166723;964.7298756348234;966.1690945786653;1002.1932344462705;1019.6991887393236;1020.4999550220375;1021.0096206679547;1021.0963297481708;797.0753925446484;807.648672827322;808.6078252047752;969.3263182088451;1014.4217795856365;747.7009196321515;749.6776386153952;754.1440465072128;754.7924320811766;754.8075240813612;14408.423663053465;14833.70332593342;14851.2574371281;14854.2572871356;14856.777148342784;12251.632451026484;12319.322437265946;12519.56181533642;12609.558665446757;12753.043521735906;9842.409455432626;9900.900990990142;10033.799324013551;10643.946780266126;10725.30285531438;3511.17487390463;3539.1682954505673;3573.3925232710503;3577.421436727394;3639.0720366306423;76612.61693691551;76870;76908.61545692291;76919.84620230645;76982.61508692421;9637.325387222967;9646.42121472714;9767.16979056774;9849.803003940024;9872.901270987342;21744.347669569623;21759.564808703737;21768.782312176674;21796.019179136976;21813.454663633536;7325.816854578572;7417.258274172539;7537.283958023979;7672.347850432776;7702.268284512962;3940.566537680853;4030.9182973051106;4061.5329237137516;4083.530394004668;4093.0790572121036;3386.0180547640907;3434.4161492545827;3436;3436.6906978372067;3437.020449171974;606.4178388746765;617.9691015449209;620.0853740732383;628.1237673445518;635.3455940381415;483.1134867518144;526.6734624532737;553.3608681972329;567.0190570313381;581.2269681323913;8919.509426981449;9199.310051746146;9385.57764900581;9401.388909720847;9542;377.71482530689156;584.6667399582283;598.8233471126028;599.4185639929261;607.5777334752305;3965.762054276695;4267.274563324242;4374.21264172452;4386.8903277417685;4448.532904045093;101042;101423;101483;101604.49197753964;105331;80689;81407.592962036;82504;83327.16672833315;83621;70648.2935170652;72132;72197.54611002702;72344;72666.63666681632;8642.43824151428;8712.607932643174;8768.298536117223;8806;8973.50645714492;48798.292059777734;50689.49310506995;51035.48964510307;51666.74166629293;51681.224781627556;71247.28752712614;77044;77284.61357693176;77713.44573108619;79404;10475.94762026185;10794.028537431355;11074;11241.213115081866;11414.258073225214;12149.453274602842;12462.626121216377;12522.311272880079;12935.223886566837;12935.482580696667;11389.487473063566;11519.98887437483;11980.940095299467;12055.095867810125;12379.442925068213;11507.42462876836;11570.363630000431;11717.88282117168;11895.286282823059;12350.81473777876;11589.362585057903;11726.648200553997;11804;11810.645680629596;11817.586384476503;9538.95230523843;9854.704358869245;9943.552540135855;10183.643572474928;10758.354498730101;8003.6798528058225;9239.538023098952;9368.197122894428;9540.618375264912;9623.831007798193 02:14:38 INFO - 2015-11-20 02:14:38,396 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:14:38 INFO - 2015-11-20 02:14:38,397 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:14:38 INFO - 2015-11-20 02:14:38,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1482 02:14:38 INFO - 2015-11-20 02:14:38,397 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:14:38 INFO - 2015-11-20 02:14:38,397 DEBUG : BROWSER_OUTPUT: __startTimestamp1448014478382__endTimestamp 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5861.67 Median:6100.41 stddev:628.85 (10.3%) stddev-sans-first:601.46 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: Values: 3442.3 3508.2 3535.7 3540.2 3591.8 5701.1 5841.3 5924.8 5978.5 6006.7 5878.3 5967.1 5968.1 6007.0 6011.1 4508.6 5375.5 5461.2 5472.8 5511.2 5512.3 5518.5 5519.9 5526.2 5526.7 5493.0 5500.7 5506.6 5512.8 5528.2 5320.1 5412.0 5472.9 5473.4 5530.5 5353.9 5432.1 5443.6 5453.7 5482.7 5633.4 5783.1 5847.1 5885.6 6027.8 5818.6 6215.7 6285.0 6309.6 6315.7 6245.3 6350.9 6352.0 6362.3 6371.5 6060.3 6090.8 6106.8 6121.0 6122.6 5152.7 6255.8 6299.7 6303.1 6469.7 6195.8 6292.7 6310.5 6313.0 6320.7 6341.2 6385.6 6387.4 6390.1 6399.5 6134.1 6294.1 6295.6 6309.1 6319.4 6131.3 6215.8 6248.6 6271.1 6273.3 5104.8 5109.9 5125.4 5129.8 5136.6 4490.9 4606.0 4613.8 4624.1 4666.7 4637.6 5808.4 5821.8 5830.1 5870.2 6334.3 6348.0 6364.1 6385.1 6391.4 5725.0 5851.1 5872.6 5915.4 6034.0 5485.5 5517.8 5518.8 5521.6 5573.4 6485.3 6508.6 6568.8 6581.9 6605.4 6201.5 6291.9 6313.1 6365.0 6411.6 6424.2 6465.3 6468.9 6478.3 6484.9 6251.1 6275.6 6286.3 6301.7 6333.8 5349.8 6100.4 6252.7 6268.4 6348.7 5251.7 6056.7 6097.9 6212.0 6261.7 6238.6 6263.1 6279.0 6310.8 6313.6 5067.8 5922.3 6022.4 6135.0 6175.8 6136.6 6150.9 6152.8 6163.8 6168.7 6062.8 6118.5 6129.5 6135.4 6143.9 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,398 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:71713.86 Median:39303.17 stddev:153938.59 (391.7%) stddev-sans-first:154277.69 02:14:38 INFO - 2015-11-20 02:14:38,400 DEBUG : BROWSER_OUTPUT: Values: 544.3 568.6 594.6 614.2 648.0 31531.4 40973.0 41000.6 41025.0 41111.2 42766.8 43120.5 43124.0 43141.6 43158.7 8873.9 8969.0 9735.8 9940.2 9961.4 8879.0 8922.1 8944.3 8954.0 12095.9 11896.8 11976.2 11998.2 12025.5 12072.6 11922.0 12046.6 12064.5 12073.8 12143.3 8900.4 9044.0 9045.5 9053.2 11784.6 32134.7 42891.8 43035.4 43179.9 43186.6 3255.6 3267.9 3540.9 3646.6 3848.6 28351.9 28633.7 29102.4 29325.6 30074.4 2718.0 2760.5 2834.3 2864.5 2941.5 514132.0 519517.0 520427.0 520523.0 521624.0 68081.3 68538.7 68562.0 68602.0 68691.7 72385.0 72425.0 72526.0 72741.0 72840.0 16169.8 16606.8 16611.3 16630.0 16667.9 12667.0 12728.2 12734.3 12737.6 12760.2 16527.7 19639.7 20385.7 21470.7 21654.5 9284.6 9460.9 9483.4 9502.2 9546.2 974.6 975.7 1018.1 1047.4 1050.0 25604.7 26135.5 29904.7 32112.5 32578.7 807.4 995.9 1067.0 1076.2 1086.9 14987.9 15078.7 15117.0 16572.9 16745.7 666911.0 674744.0 675666.0 676255.0 761072.0 51593.5 54348.7 64661.7 64788.7 64984.7 1335.8 1446.7 1463.1 1465.3 1465.8 28798.7 29784.2 30480.9 31886.8 32044.8 56064.4 56738.0 56746.0 56762.4 56783.4 494275.5 498877.0 498926.0 499865.0 500847.0 43195.8 43764.7 44408.8 44531.0 44564.3 45826.1 45888.0 46151.8 46966.5 47224.3 37376.3 38926.0 39110.7 39495.6 39557.6 37311.3 37427.9 38688.0 38751.2 38776.4 38253.8 38527.0 39098.2 40050.2 40198.2 28831.0 33614.7 33848.8 33900.3 34041.8 25314.9 25598.6 26093.3 26556.9 26881.6 02:14:38 INFO - 2015-11-20 02:14:38,400 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,400 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38349.10 Median:11743.56 stddev:120060.63 (1022.4%) stddev-sans-first:120363.55 02:14:38 INFO - 2015-11-20 02:14:38,401 DEBUG : BROWSER_OUTPUT: Values: 361.5 362.5 368.5 370.5 375.5 15965.4 17006.4 19493.1 20043.8 20192.4 19730.6 19778.7 19811.3 21216.9 21294.8 4753.7 6522.2 6700.6 6714.2 6715.9 4854.2 4902.9 7433.9 7630.5 7635.5 7444.7 7590.4 7608.2 7642.5 7646.6 7456.6 7549.5 7605.8 7606.3 7619.2 7284.3 7294.4 7303.0 7305.2 7305.6 27397.9 27826.4 27878.7 28443.6 28450.1 1864.8 2192.3 2222.6 2235.7 2254.5 15281.8 15514.3 15586.5 15801.6 16280.0 1674.0 1760.5 1781.2 1788.8 2002.6 75356.2 88553.0 100170.5 100458.0 102323.5 10721.5 11012.1 11078.7 11092.5 11129.3 13370.7 13443.0 13487.2 13542.9 13551.2 7774.5 8177.3 8544.3 8545.9 8576.6 7009.2 8654.8 8678.2 8721.6 8759.8 3967.6 4024.9 4120.0 4247.4 4333.9 1512.3 1533.0 1637.7 1702.9 1809.7 863.6 889.5 931.2 956.6 1094.9 14107.1 19585.9 19737.6 19835.6 19854.1 933.5 968.6 987.2 1037.4 1056.6 10171.8 10312.2 11052.4 11552.9 11554.6 695095.0 703969.0 745306.0 748135.3 759163.0 94121.0 117978.0 119199.4 120604.2 122397.0 1180.1 1218.4 1232.8 1233.4 1234.9 14305.6 17542.8 18287.0 18324.3 18730.7 48966.4 51352.7 53470.9 53870.0 54082.5 70226.0 71165.0 72135.0 75510.6 76074.2 9597.0 9664.6 9936.3 9949.4 9956.6 11952.0 16885.8 19830.8 20173.0 20410.8 15028.0 15097.2 15367.6 15645.0 16139.6 11746.8 15214.2 15256.0 15473.2 15597.5 15986.8 16246.8 16411.9 16439.9 16448.5 9341.5 9695.1 9746.9 9815.2 9829.4 10412.9 11739.4 14486.9 15172.2 16191.4 02:14:38 INFO - 2015-11-20 02:14:38,401 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,401 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5774.88 Median:6634.26 stddev:2966.29 (44.7%) stddev-sans-first:2957.73 02:14:38 INFO - 2015-11-20 02:14:38,402 DEBUG : BROWSER_OUTPUT: Values: 1564.8 1569.8 1692.6 1893.5 1902.4 7513.0 7948.0 8063.0 8129.4 8136.6 6345.7 8208.3 8327.9 8355.0 8791.3 2136.7 2186.1 2369.9 2398.3 2399.8 2176.7 2371.4 2402.6 2407.0 2409.3 2320.6 2358.2 2364.0 2370.9 2376.2 2128.6 2174.9 2178.8 2361.8 2406.1 2105.3 2365.3 2401.2 2411.6 2414.6 8252.3 8349.0 8354.5 8354.6 8359.2 5083.9 5170.3 5178.5 5196.5 5198.1 3485.7 3496.4 3524.3 3561.4 3582.1 1068.9 1079.1 1420.3 1653.9 1675.2 10996.5 11109.4 11119.0 11132.6 11147.7 4471.2 4509.2 4588.1 4595.2 4620.6 9116.8 9128.2 9135.3 9139.9 9148.6 4426.9 5105.2 5130.2 5155.0 5170.4 4717.2 4720.1 4732.6 4762.1 4771.9 3402.3 3448.7 3473.8 3506.3 3506.4 966.5 1045.5 1113.2 1154.2 1159.9 1083.9 1099.5 1099.9 1292.1 1424.7 7696.3 7892.3 7948.5 7953.0 7963.3 1196.0 1199.4 1206.5 1207.2 1223.8 6009.5 6113.4 6123.4 6166.9 6356.6 9523.2 9596.5 9654.5 9697.3 9841.7 9494.8 9614.0 9626.6 9630.0 9726.3 7496.7 7615.3 7650.8 7717.5 7761.0 7812.4 7845.5 7850.0 7867.6 7876.9 8849.8 9008.4 9097.4 9122.4 9144.6 9198.2 9341.2 9512.7 9515.0 9525.2 6840.0 6917.4 6919.4 6928.9 6936.2 8008.2 8020.6 8097.8 8116.0 8130.8 7398.9 7520.9 7536.2 7665.1 7673.7 7372.6 7449.7 7472.8 7545.1 7601.5 7529.0 7584.6 7585.2 7588.7 7599.7 6776.0 6911.3 6914.2 6922.1 6936.1 6492.5 6982.3 7031.2 7046.6 7049.5 02:14:38 INFO - 2015-11-20 02:14:38,402 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,402 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5954.61 Median:6639.70 stddev:1915.24 (28.8%) stddev-sans-first:1872.56 02:14:38 INFO - 2015-11-20 02:14:38,403 DEBUG : BROWSER_OUTPUT: Values: 274.3 319.4 330.2 332.5 336.2 5398.3 5477.3 6621.7 6732.7 6896.9 5321.3 6637.1 6772.0 6779.7 6786.1 5040.9 5062.9 5100.9 5104.8 5115.7 4835.3 4980.1 5080.5 5093.1 5107.9 4991.6 5078.8 5086.0 5098.0 5116.0 5086.4 5088.0 5088.1 5098.9 5108.1 4310.4 4334.2 4334.5 4341.5 4349.9 5103.8 6596.8 6616.3 6642.3 6646.0 5972.3 5975.7 5980.9 5985.0 6004.8 7063.6 7389.9 7408.0 7408.0 7413.9 4554.5 4719.9 4753.5 4783.6 4788.9 6254.6 7423.1 7752.7 7760.3 7790.3 4237.0 4872.1 4895.5 4898.1 4901.3 4824.8 4953.0 5013.1 5016.4 5017.1 5881.3 5883.7 5883.8 5887.6 5889.9 7396.7 7398.7 7406.1 7408.3 7423.9 1634.1 1691.2 1693.8 1729.7 1750.0 1052.4 1068.5 1072.4 1076.4 1080.1 6237.9 6801.9 6827.6 6839.7 6846.7 7567.2 7582.6 7583.0 7583.5 7583.7 6572.1 6762.8 6801.2 6819.7 6845.5 3979.5 4006.3 4011.7 4012.1 4013.1 7778.2 7809.7 7816.6 7824.3 7826.2 6552.9 7829.4 7844.6 8032.2 8045.0 6949.4 7512.8 8038.9 8044.2 8049.7 7469.7 7556.8 7600.7 7614.8 7747.5 7618.2 7623.6 7643.2 7645.0 7645.4 7805.0 8004.3 8008.4 8023.0 8042.4 4306.8 4472.3 4761.0 4798.6 4820.4 6149.4 7665.0 7670.6 7685.3 7695.7 7217.9 7362.5 7404.8 7409.0 7428.4 7354.7 7354.7 7355.0 7360.0 7362.0 5838.4 7202.0 7204.9 7214.4 7235.5 5735.5 7377.5 7402.1 7402.6 7404.1 6181.7 7214.8 7222.9 7244.8 7259.7 02:14:38 INFO - 2015-11-20 02:14:38,403 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,403 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19013.60 Median:51351.12 stddev:27140.96 (52.9%) stddev-sans-first:27182.25 02:14:38 INFO - 2015-11-20 02:14:38,405 DEBUG : BROWSER_OUTPUT: Values: 696.8 712.4 747.1 748.2 826.4 14556.3 14943.9 14959.7 14963.0 14965.9 13753.7 13845.2 13895.7 13901.9 13962.9 760.5 771.1 771.9 947.2 955.3 947.1 949.8 963.0 964.7 966.2 1002.2 1019.7 1020.5 1021.0 1021.1 797.1 807.6 808.6 969.3 1014.4 747.7 749.7 754.1 754.8 754.8 14408.4 14833.7 14851.3 14854.3 14856.8 12251.6 12319.3 12519.6 12609.6 12753.0 9842.4 9900.9 10033.8 10643.9 10725.3 3511.2 3539.2 3573.4 3577.4 3639.1 76612.6 76870.0 76908.6 76919.8 76982.6 9637.3 9646.4 9767.2 9849.8 9872.9 21744.3 21759.6 21768.8 21796.0 21813.5 7325.8 7417.3 7537.3 7672.3 7702.3 3940.6 4030.9 4061.5 4083.5 4093.1 3386.0 3434.4 3436.0 3436.7 3437.0 606.4 618.0 620.1 628.1 635.3 483.1 526.7 553.4 567.0 581.2 8919.5 9199.3 9385.6 9401.4 9542.0 377.7 584.7 598.8 599.4 607.6 3965.8 4267.3 4374.2 4386.9 4448.5 101042.0 101423.0 101483.0 101604.5 105331.0 80689.0 81407.6 82504.0 83327.2 83621.0 70648.3 72132.0 72197.5 72344.0 72666.6 8642.4 8712.6 8768.3 8806.0 8973.5 48798.3 50689.5 51035.5 51666.7 51681.2 71247.3 77044.0 77284.6 77713.4 79404.0 10475.9 10794.0 11074.0 11241.2 11414.3 12149.5 12462.6 12522.3 12935.2 12935.5 11389.5 11520.0 11980.9 12055.1 12379.4 11507.4 11570.4 11717.9 11895.3 12350.8 11589.4 11726.6 11804.0 11810.6 11817.6 9539.0 9854.7 9943.6 10183.6 10758.4 8003.7 9239.5 9368.2 9540.6 9623.8 02:14:38 INFO - 2015-11-20 02:14:38,405 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:14:38 INFO - 2015-11-20 02:14:38,405 DEBUG : BROWSER_OUTPUT: 02:14:38 INFO - 2015-11-20 02:14:38,846 INFO : Browser exited with error code: 0 02:14:38 INFO - 2015-11-20 02:14:38,870 INFO : Completed test dromaeo_css (00:18:35) 02:14:38 INFO - 2015-11-20 02:14:38,870 INFO : Starting test kraken 02:14:38 INFO - 2015-11-20 02:14:38,870 DEBUG : operating with platform_type : mac_ 02:14:38 INFO - 2015-11-20 02:14:38,871 INFO : Initialising browser for kraken test... 02:14:38 INFO - 2015-11-20 02:14:38,883 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpwl0zgx/profile http://localhost:49264/getInfo.html 02:14:40 INFO - 2015-11-20 02:14:40,948 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:14:40 INFO - 2015-11-20 02:14:40,948 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:14:40 INFO - 2015-11-20 02:14:40,949 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:14:40 INFO - 2015-11-20 02:14:40,949 DEBUG : BROWSER_OUTPUT: __metrics 02:14:40 INFO - 2015-11-20 02:14:40,966 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:41 INFO - 2015-11-20 02:14:41,223 DEBUG : BROWSER_OUTPUT: console.error: 02:14:41 INFO - 2015-11-20 02:14:41,223 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 02:14:41 INFO - 2015-11-20 02:14:41,223 DEBUG : BROWSER_OUTPUT: Stack: 02:14:41 INFO - 2015-11-20 02:14:41,223 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:14:41 INFO - 2015-11-20 02:14:41,224 DEBUG : BROWSER_OUTPUT: 02:14:41 INFO - 2015-11-20 02:14:41,736 INFO : Browser initialized. 02:14:41 INFO - 2015-11-20 02:14:41,737 INFO : Running cycle 1/1 for kraken test... 02:14:41 INFO - 2015-11-20 02:14:41,737 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpwl0zgx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:14:53 INFO - 2015-11-20 02:14:53,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 226230272 02:14:53 INFO - 2015-11-20 02:14:53,486 DEBUG : BROWSER_OUTPUT: 02:14:55 INFO - 2015-11-20 02:14:55,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 02:14:56 INFO - 2015-11-20 02:14:56,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 276029440 02:14:56 INFO - 2015-11-20 02:14:56,555 DEBUG : BROWSER_OUTPUT: 02:14:59 INFO - 2015-11-20 02:14:59,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 02:14:59 INFO - 2015-11-20 02:14:59,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 290242560 02:14:59 INFO - 2015-11-20 02:14:59,675 DEBUG : BROWSER_OUTPUT: 02:15:02 INFO - 2015-11-20 02:15:02,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 02:15:03 INFO - 2015-11-20 02:15:03,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 278904832 02:15:03 INFO - 2015-11-20 02:15:03,429 DEBUG : BROWSER_OUTPUT: 02:15:05 INFO - 2015-11-20 02:15:05,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 02:15:05 INFO - 2015-11-20 02:15:05,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 280498176 02:15:05 INFO - 2015-11-20 02:15:05,856 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-20 02:15:07,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:08 INFO - 2015-11-20 02:15:08,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 281862144 02:15:08 INFO - 2015-11-20 02:15:08,437 DEBUG : BROWSER_OUTPUT: 02:15:11 INFO - 2015-11-20 02:15:11,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:11 INFO - 2015-11-20 02:15:11,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 283426816 02:15:11 INFO - 2015-11-20 02:15:11,787 DEBUG : BROWSER_OUTPUT: 02:15:14 INFO - 2015-11-20 02:15:14,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:15 INFO - 2015-11-20 02:15:15,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 283013120 02:15:15 INFO - 2015-11-20 02:15:15,281 DEBUG : BROWSER_OUTPUT: 02:15:17 INFO - 2015-11-20 02:15:17,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 02:15:18 INFO - 2015-11-20 02:15:18,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 283942912 02:15:18 INFO - 2015-11-20 02:15:18,512 DEBUG : BROWSER_OUTPUT: 02:15:20 INFO - 2015-11-20 02:15:20,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:20 INFO - 2015-11-20 02:15:20,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 314343424 02:15:20 INFO - 2015-11-20 02:15:20,617 DEBUG : BROWSER_OUTPUT: 02:15:22 INFO - 2015-11-20 02:15:22,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:23 INFO - 2015-11-20 02:15:23,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 317394944 02:15:23 INFO - 2015-11-20 02:15:23,012 DEBUG : BROWSER_OUTPUT: 02:15:25 INFO - 2015-11-20 02:15:25,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:25 INFO - 2015-11-20 02:15:25,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 322519040 02:15:25 INFO - 2015-11-20 02:15:25,630 DEBUG : BROWSER_OUTPUT: 02:15:28 INFO - 2015-11-20 02:15:28,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:28 INFO - 2015-11-20 02:15:28,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 323268608 02:15:28 INFO - 2015-11-20 02:15:28,757 DEBUG : BROWSER_OUTPUT: 02:15:31 INFO - 2015-11-20 02:15:31,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:31 INFO - 2015-11-20 02:15:31,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 322453504 02:15:31 INFO - 2015-11-20 02:15:31,748 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 382439424 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:15:33 INFO - 2015-11-20 02:15:33,711 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;103;108;108;107;98;108;102;108 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;121;141;155;118;139;139;114;154;121 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;182;182;181;184;184;183;186;182;185 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;69;74;72;54;58;56;68;71;53 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;85;115;75;74;75;111;74;76;114 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;85;129;96;85;87;87;87;86;87 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;94;94;94;94;95;94;99;150;128 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;84;84;84;84;86;84;84;84;85 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;51;55;54;53;54;55;54;64;55;53 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;65;65;68;68;67;68;68 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;81;83;82;82;82;82;84;85;84 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;129;108;110;127;115;120;121;120;117 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;123;134;135;135;123;135;134;134;122 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;74;74;90;85;60;53;59;62 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:15:33 INFO - 2015-11-20 02:15:33,712 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1082 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: __startTimestamp1448014533704__endTimestamp 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.80 Median:108.00 stddev:3.58 (3.3%) stddev-sans-first:3.77 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 103.0 108.0 108.0 107.0 98.0 108.0 102.0 108.0 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.60 Median:140.00 stddev:16.02 (11.4%) stddev-sans-first:15.54 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: Values: 154.0 121.0 141.0 155.0 118.0 139.0 139.0 114.0 154.0 121.0 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,713 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.60 (0.9%) stddev-sans-first:1.64 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: Values: 182.0 182.0 182.0 181.0 184.0 184.0 183.0 186.0 182.0 185.0 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:63.60 Median:68.50 stddev:8.04 (11.7%) stddev-sans-first:8.48 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: Values: 61.0 69.0 74.0 72.0 54.0 58.0 56.0 68.0 71.0 53.0 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.20 Median:75.00 stddev:17.77 (23.7%) stddev-sans-first:18.75 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 115.0 75.0 74.0 75.0 111.0 74.0 76.0 114.0 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:87.00 stddev:13.47 (15.5%) stddev-sans-first:14.23 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: Values: 88.0 85.0 129.0 96.0 85.0 87.0 87.0 87.0 86.0 87.0 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:103.80 Median:94.00 stddev:19.33 (20.6%) stddev-sans-first:20.29 02:15:33 INFO - 2015-11-20 02:15:33,714 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 94.0 94.0 94.0 95.0 94.0 99.0 150.0 128.0 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 84.0 84.0 84.0 86.0 84.0 84.0 84.0 85.0 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.46 (6.3%) stddev-sans-first:3.38 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: Values: 51.0 55.0 54.0 53.0 54.0 55.0 54.0 64.0 55.0 53.0 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:67.50 stddev:2.13 (3.2%) stddev-sans-first:1.99 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 65.0 65.0 68.0 68.0 67.0 68.0 68.0 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: Values: 83.0 81.0 83.0 82.0 82.0 82.0 82.0 84.0 85.0 84.0 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,715 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:120.50 stddev:6.67 (5.5%) stddev-sans-first:6.98 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: Values: 122.0 129.0 108.0 110.0 127.0 115.0 120.0 121.0 120.0 117.0 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.00 Median:134.50 stddev:5.77 (4.3%) stddev-sans-first:5.94 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: Values: 135.0 123.0 134.0 135.0 135.0 123.0 135.0 134.0 134.0 122.0 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:70.00 stddev:11.86 (16.9%) stddev-sans-first:12.54 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 74.0 74.0 90.0 85.0 60.0 53.0 59.0 62.0 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:15:33 INFO - 2015-11-20 02:15:33,716 DEBUG : BROWSER_OUTPUT: 02:15:34 INFO - 2015-11-20 02:15:34,312 INFO : Browser exited with error code: 0 02:15:34 INFO - 2015-11-20 02:15:34,359 INFO : Completed test kraken (00:00:55) 02:15:34 INFO - 2015-11-20 02:15:34,359 INFO : Starting test v8_7 02:15:34 INFO - 2015-11-20 02:15:34,359 DEBUG : operating with platform_type : mac_ 02:15:34 INFO - 2015-11-20 02:15:34,359 INFO : Initialising browser for v8_7 test... 02:15:34 INFO - 2015-11-20 02:15:34,372 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpggF1zN/profile http://localhost:49264/getInfo.html 02:15:36 INFO - 2015-11-20 02:15:36,360 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:15:36 INFO - 2015-11-20 02:15:36,360 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:15:36 INFO - 2015-11-20 02:15:36,360 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:15:36 INFO - 2015-11-20 02:15:36,360 DEBUG : BROWSER_OUTPUT: __metrics 02:15:36 INFO - 2015-11-20 02:15:36,376 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:36 INFO - 2015-11-20 02:15:36,640 DEBUG : BROWSER_OUTPUT: console.error: 02:15:36 INFO - 2015-11-20 02:15:36,641 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 02:15:36 INFO - 2015-11-20 02:15:36,641 DEBUG : BROWSER_OUTPUT: Stack: 02:15:36 INFO - 2015-11-20 02:15:36,641 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 02:15:36 INFO - 2015-11-20 02:15:36,642 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 02:15:36 INFO - 2015-11-20 02:15:36,642 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 02:15:36 INFO - 2015-11-20 02:15:36,642 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 02:15:36 INFO - 2015-11-20 02:15:36,642 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 02:15:36 INFO - 2015-11-20 02:15:36,642 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 02:15:36 INFO - 2015-11-20 02:15:36,643 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:15:36 INFO - 2015-11-20 02:15:36,643 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 02:15:36 INFO - 2015-11-20 02:15:36,644 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:15:36 INFO - 2015-11-20 02:15:36,644 DEBUG : BROWSER_OUTPUT: 02:15:37 INFO - 2015-11-20 02:15:37,072 INFO : Browser initialized. 02:15:37 INFO - 2015-11-20 02:15:37,072 INFO : Running cycle 1/1 for v8_7 test... 02:15:37 INFO - 2015-11-20 02:15:37,073 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpggF1zN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:15:48 INFO - 2015-11-20 02:15:48,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 225890304 02:15:48 INFO - 2015-11-20 02:15:48,830 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 693911552 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: |0;Richards;148.45605700712588 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.95704828031649 02:16:10 INFO - 2015-11-20 02:16:10,600 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4753.554502369669 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1700.6802721088436 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |6;Boyer;13157.894736842105 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |7;RegExp;26894.736842105263 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |8;Splay;731.0495626822158 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4524.886877828054 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: __startTimestamp1448014570594__endTimestamp 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.46 Median:148.46 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,601 DEBUG : BROWSER_OUTPUT: Values: 148.5 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.96 Median:161.96 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: Values: 162.0 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: Values: 280.5 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4753.55 Median:4753.55 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: Values: 4753.6 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1700.68 Median:1700.68 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: Values: 1700.7 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,602 DEBUG : BROWSER_OUTPUT: Values: 784.3 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13157.89 Median:13157.89 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: Values: 13157.9 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: Values: 26894.7 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:731.05 Median:731.05 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: Values: 731.0 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4524.89 Median:4524.89 stddev:0.00 (0.0%) 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: Values: 4524.9 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:16:10 INFO - 2015-11-20 02:16:10,603 DEBUG : BROWSER_OUTPUT: 02:16:11 INFO - 2015-11-20 02:16:11,226 INFO : Browser exited with error code: 0 02:16:11 INFO - 2015-11-20 02:16:11,244 INFO : Completed test v8_7 (00:00:36) 02:16:11 INFO - 2015-11-20 02:16:11,597 INFO : Completed test suite (00:20:07) 02:16:11 INFO - 2015-11-20 02:16:11,597 DEBUG : Working with test: dromaeo_css 02:16:11 INFO - 2015-11-20 02:16:11,598 DEBUG : Generating results file: dromaeo_css 02:16:11 INFO - 2015-11-20 02:16:11,598 DEBUG : Working with test: kraken 02:16:11 INFO - 2015-11-20 02:16:11,598 DEBUG : Generating results file: kraken 02:16:11 INFO - 2015-11-20 02:16:11,599 INFO : javascript benchmark 02:16:11 INFO - 2015-11-20 02:16:11,599 DEBUG : Working with test: v8_7 02:16:11 INFO - 2015-11-20 02:16:11,599 DEBUG : Generating results file: v8_7 02:16:11 INFO - 2015-11-20 02:16:11,599 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:16:11 INFO - 2015-11-20 02:16:11,980 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 02:16:11 INFO - 2015-11-20 02:16:11,980 DEBUG : process_Request line: dromaeo_css 7790.63 graph.html#tests=[[72,64,59]] 02:16:11 INFO - 2015-11-20 02:16:11,980 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:16:12 INFO - 2015-11-20 02:16:12,121 DEBUG : process_Request line: kraken 1378.30 graph.html#tests=[[232,64,59]] 02:16:12 INFO - 2015-11-20 02:16:12,121 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:16:12 INFO - 2015-11-20 02:16:12,145 DEBUG : process_Request line: v8_7 20396.01 graph.html#tests=[[230,64,59]] 02:16:12 INFO - 2015-11-20 02:16:12,145 INFO : javascript benchmark 02:16:12 INFO - 2015-11-20 02:16:12,147 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3442.3459542686887, 3508.158042069904, 3535.664111909368, 3540.2211513467028, 3591.784492930424, 5701.144828275761, 5841.269841269841, 5924.792632257871, 5978.461938425541, 6006.699665016748, 5878.265216847894, 5967.104934259853, 5968.134620480038, 6007.0, 6011.128386383972, 4508.61676757476, 5375.516203541681, 5461.15352120422, 5472.753726082336, 5511.22842802008, 5512.255845460852, 5518.503334699876, 5519.917201241985, 5526.171074338861, 5526.723663816813, 5493.0, 5500.724963751816, 5506.614536982393, 5512.834614961537, 5528.170774383834, 5320.122179840341, 5412.025835349636, 5472.890542189154, 5473.425290344497, 5530.5299049580835, 5353.892922141575, 5432.13085906257, 5443.646162999393, 5453.727313634303, 5482.725863706799, 5633.352164501094, 5783.074708046693, 5847.093700476433, 5885.61743486672, 6027.819165425044, 5818.5636077294375, 6215.720292586844, 6285.025820997753, 6309.621422714652, 6315.715792789336, 6245.313015568284, 6350.904736428911, 6352.047192921053, 6362.268339141012, 6371.490280777573, 6060.272767267912, 6090.847728806815, 6106.786262480792, 6120.96939515304, 6122.602030867979, 5152.690838549699, 6255.843603909939, 6299.748010079546, 6303.149074874925, 6469.741210351627, 6195.752169913243, 6292.653904035322, 6310.495160387158, 6313.021481670348, 6320.747170113144, 6341.175647165931, 6385.648789316632, 6387.393197646216, 6390.137331460286, 6399.520035997319, 6134.110553969649, 6294.0558916162945, 6295.559310848288, 6309.08518264849, 6319.368063193736, 6131.308192042429, 6215.844603884849, 6248.562600617913, 6271.122042913996, 6273.309935907047, 5104.821331253388, 5109.8722531936255, 5125.384953805567, 5129.846104616868, 5136.640435169502, 4490.932636010462, 4605.953940460552, 4613.754286342669, 4624.098300831306, 4666.696664716783, 4637.582617564368, 5808.419158084158, 5821.79623713168, 5830.067189249699, 5870.178175055496, 6334.271558770708, 6348.0, 6364.077208804697, 6385.138006369174, 6391.360863913572, 5724.971375143097, 5851.093080572518, 5872.559558033079, 5915.352365741648, 6034.0, 5485.4788795064405, 5517.834464966058, 5518.751656175482, 5521.641093328921, 5573.442655734394, 6485.254195767453, 6508.576942498722, 6568.835779105656, 6581.934180658323, 6605.405513503808, 6201.472874805692, 6291.937080629135, 6313.147725057059, 6365.039427910671, 6411.647359395091, 6424.164858568356, 6465.2564955030775, 6468.935310646833, 6478.319776423407, 6484.870302594016, 6251.124842521959, 6275.592086514362, 6286.308506064238, 6301.684915754102, 6333.809985700436, 5349.839504814861, 6100.412552313782, 6252.687365631609, 6268.404501572343, 6348.650824204528, 5251.658642188246, 6056.697165141637, 6097.857415702912, 6212.0, 6261.68691565429, 6238.594491358047, 6263.060540918898, 6279.0, 6310.810675679737, 6313.621182729051, 5067.822626208065, 5922.318933322551, 6022.376216936925, 6135.049067394561, 6175.752969881334, 6136.631802091889, 6150.907736384047, 6152.784652537319, 6163.7842675506145, 6168.660723660242, 6062.848428789315, 6118.541109416722, 6129.478994285536, 6135.416406698409, 6143.938560614337], "unit": "ms", "name": "dojo.html", "value": 5825.231428976102}, {"lowerIsBetter": false, "replicates": [544.3166799445553, 568.56504773848, 594.6105301027823, 614.1555361378105, 647.9956068094452, 31531.369372612535, 40973.0, 41000.58999410005, 41025.0, 41111.17777644449, 42766.78616606921, 43120.490782822606, 43124.0, 43141.56858431415, 43158.705238842886, 8873.866891996626, 8969.013408525057, 9735.756606084851, 9940.15508681763, 9961.35251208669, 8879.0, 8922.10778922109, 8944.329175311845, 8954.0, 12095.879041209608, 11896.7620647587, 11976.221545599552, 11998.220115692495, 12025.51897924082, 12072.577459788909, 11921.986631136364, 12046.638600841989, 12064.517419303218, 12073.758524829454, 12143.271403715806, 8900.42147260426, 9044.0, 9045.4572725636, 9053.230475409599, 11784.587539436165, 32134.678653213403, 42891.78554107241, 43035.35446968298, 43179.920501987384, 43186.568134318884, 3255.5604993326074, 3267.901962941092, 3540.929181416383, 3646.562412510489, 3848.5574158971795, 28351.858240708872, 28633.71366286352, 29102.41795164106, 29325.627552831484, 30074.398512029857, 2717.959230611523, 2760.489309477753, 2834.3339315260896, 2864.455753406846, 2941.485240082977, 514132.0, 519517.0, 520427.0, 520523.0, 521624.0, 68081.3191868075, 68538.65730671315, 68562.0, 68602.0, 68691.65654171698, 72385.0, 72425.0, 72526.0, 72741.0, 72840.0, 16169.757453638205, 16606.83393166077, 16611.252493637814, 16630.002199868046, 16667.91666041662, 12667.0, 12728.1726687765, 12734.29961352116, 12737.617871463872, 12760.234385936874, 16527.669446611002, 19639.705404418946, 20385.694214586794, 21470.677939830915, 21654.458638534164, 9284.62861485533, 9460.8580871287, 9483.383580067273, 9502.239820814457, 9546.236301095896, 974.6247694637474, 975.7170420577953, 1018.1091544898214, 1047.418682631147, 1049.95004995005, 25604.743952560235, 26135.477290454466, 29904.700952990628, 32112.518312225337, 32578.660625319262, 807.3944541593804, 995.8854731705802, 1066.9833964318443, 1076.219740687995, 1086.9456527173609, 14987.925060374628, 15078.698426031418, 15117.0, 16572.917135414245, 16745.748813767805, 666911.0, 674744.0, 675666.0, 676255.0, 761072.0, 51593.48406515962, 54348.72825635847, 64661.67669161624, 64788.67605661941, 64984.67507662431, 1335.7528857161456, 1446.6528033271939, 1463.1075044222803, 1465.3479201755329, 1465.7801329800616, 28798.71201288044, 29784.21507546685, 30480.933167339037, 31886.84056579795, 32044.83977580097, 56064.43935560592, 56738.0, 56746.0, 56762.432375675715, 56783.43216567781, 494275.528622369, 498877.0, 498926.0, 499865.0, 500847.0, 43195.78402107969, 43764.717646176025, 44408.777956111306, 44531.0, 44564.33153502635, 45826.08347832958, 45888.0, 46151.76924115358, 46966.53033469622, 47224.2916356248, 37376.252474950896, 38926.02684932786, 39110.72954518224, 39495.605043949196, 39557.60442395539, 37311.2537749238, 37427.87716368513, 38688.0, 38751.22497549977, 38776.41835372528, 38253.80873095617, 38527.0368240785, 39098.21803563856, 40050.1989960205, 40198.1960360797, 28831.0, 33614.71299274775, 33848.83075584705, 33900.3219935595, 34041.82979085089, 25314.87342563349, 25598.616020760077, 26093.347666308495, 26556.8672156638, 26881.596776047983], "unit": "ms", "name": "ext.html", "value": 20966.20724137365}, {"lowerIsBetter": false, "replicates": [361.54625944439726, 362.47622185941316, 368.47308349060864, 370.4646785395104, 375.4874596176219, 15965.361385544593, 17006.40477583285, 19493.12280947357, 20043.799562004395, 20192.394228173143, 19730.605387892232, 19778.70331945022, 19811.306604268855, 21216.89391553044, 21294.787052129475, 4753.691010084351, 6522.184726909137, 6700.564463309869, 6714.160729908762, 6715.891877840175, 4854.17479028566, 4902.926456103161, 7433.851322973537, 7630.4658673892845, 7635.541867487968, 7444.7390809001145, 7590.3927685785, 7608.239176082403, 7642.465027448081, 7646.579438130901, 7456.5898875561825, 7549.471536992412, 7605.809854753647, 7606.250562370658, 7619.238076192337, 7284.344409003215, 7294.3799777018485, 7303.01409309747, 7305.196428392873, 7305.598192099433, 27397.863010685018, 27826.443471130668, 27878.72121278802, 28443.573346399822, 28450.146495604957, 1864.8414884734677, 2192.3422973108163, 2222.577071627466, 2235.7205349331334, 2254.5490901819703, 15281.770773438408, 15514.301856416489, 15586.532404027785, 15801.60495987598, 16280.0, 1674.0, 1760.5246583422404, 1781.234069350179, 1788.8211178882138, 2002.6495363311362, 75356.24643753601, 88553.0, 100170.49914750452, 100458.0, 102323.48838255835, 10721.463926803628, 11012.119030477543, 11078.723031924266, 11092.500837462334, 11129.332240065622, 13370.665733356549, 13443.0, 13487.190768553919, 13542.932285338511, 13551.186928784304, 7774.494657847335, 8177.304929080976, 8544.273736732448, 8545.914540854636, 8576.614052367659, 7009.193942696553, 8654.826903461895, 8678.218960293603, 8721.563921803885, 8759.824803503894, 3967.6429121379215, 4024.9195016099516, 4120.031792528754, 4247.362895565628, 4333.869983900425, 1512.311898086368, 1532.99233503834, 1637.656092220647, 1702.9148542572823, 1809.6742586334585, 863.6372723456163, 889.5241046040467, 931.2224292715523, 956.6125719083782, 1094.8631421072366, 14107.083039602392, 19585.922774247552, 19737.60524789496, 19835.603287934162, 19854.1065652046, 933.4772527384687, 968.6028728221395, 987.1905037869022, 1037.4397825174472, 1056.6196169379018, 10171.796564068678, 10312.175025997902, 11052.418932467428, 11552.884471155348, 11554.59558915434, 695095.0, 703969.0, 745306.0, 748135.2593236999, 759163.0, 94121.0, 117978.0, 119199.40400298116, 120604.19093713601, 122397.0, 1180.0913296761446, 1218.3908045977012, 1232.796588562895, 1233.3709807997986, 1234.9135560510679, 14305.57083287503, 17542.824571754118, 18287.0, 18324.26702931921, 18730.71903921415, 48966.41727851403, 51352.74323628358, 53470.93058138738, 53870.0, 54082.45917540774, 70226.0, 71165.0, 72135.0, 75510.62244688741, 76074.23925760893, 9597.040295970348, 9664.565094570902, 9936.304458687822, 9949.403035817873, 9956.601735930482, 11952.0, 16885.831141688916, 19830.801691982895, 20173.0, 20410.77535347884, 15028.0, 15097.245137743288, 15367.61580960485, 15645.0, 16139.596510087342, 11746.76506469883, 15214.163221022507, 15256.0, 15473.226338682796, 15597.532074037797, 15986.840131598536, 16246.756298655766, 16411.93322434038, 16439.91780041092, 16448.506544803677, 9341.532923353941, 9695.078967498077, 9746.9025309746, 9815.2147828175, 9829.361091529028, 10412.895871041193, 11739.413029348327, 14486.85513144855, 15172.165530895465, 16191.433299834449], "unit": "ms", "name": "jquery.html", "value": 10307.65794331145}, {"lowerIsBetter": false, "replicates": [1564.7809306697065, 1569.8273189949111, 1692.5768557860536, 1893.5171531259532, 1902.362708492655, 7513.0, 7948.0, 8063.0, 8129.39029572783, 8136.633851476698, 6345.7144428500715, 8208.343332533397, 8327.875081873777, 8354.958225208866, 8791.296696264299, 2136.700861879338, 2186.1255497800926, 2369.8578085314934, 2398.2805158452484, 2399.8320117591775, 2176.662617294322, 2371.3715865295712, 2402.5555272274687, 2406.95186096278, 2409.3494756415844, 2320.640300753386, 2358.151065616377, 2364.0, 2370.8577485350934, 2376.2039716694926, 2128.6062078515524, 2174.923877664274, 2178.8256939444805, 2361.787439130478, 2406.133791834947, 2105.3052492677534, 2365.27859003004, 2401.2076014915037, 2411.638254261857, 2414.6015907375436, 8252.257296843252, 8348.958255208745, 8354.456960297623, 8354.624041918129, 8359.205875441823, 5083.872903177413, 5170.302009228782, 5178.482151784829, 5196.480351964811, 5198.090334191501, 3485.7385696072897, 3496.3798371172184, 3524.312759011994, 3561.4301711726257, 3582.140286331288, 1068.8610480637467, 1079.1366906474789, 1420.3324437514352, 1653.94147745443, 1675.2377668160957, 10996.450177491173, 11109.388983605979, 11119.0, 11132.554697812078, 11147.66557003283, 4471.150481408587, 4509.188346097734, 4588.128255631419, 4595.195840727859, 4620.584147426748, 9116.81766364669, 9128.22410095136, 9135.314851386172, 9139.90860091404, 9148.588313525906, 4426.933595996063, 5105.183170692671, 5130.179171332569, 5154.974225128851, 5170.379554453414, 4717.22165842639, 4720.0559888022535, 4732.574068333866, 4762.119007983465, 4771.856844294677, 3402.3365443738235, 3448.706859916935, 3473.774204676688, 3506.316268327703, 3506.403911335079, 966.4974213408988, 1045.482486169351, 1113.2429947635685, 1154.168998321224, 1159.9478023488964, 1083.864516935383, 1099.5217080569978, 1099.8955099265556, 1292.095533126815, 1424.7150569885857, 7696.345810606049, 7892.28969392746, 7948.523088614702, 7952.960235198787, 7963.283304502506, 1196.0371900620084, 1199.3763243113706, 1206.5294535131306, 1207.209277922962, 1223.7797196504537, 6009.519238461, 6113.358097399798, 6123.387661233841, 6166.907496387557, 6356.618602883842, 9523.19052880513, 9596.472194029257, 9654.517274136266, 9697.321187516805, 9841.704748857546, 9494.810103798023, 9613.951930240304, 9626.566804493674, 9629.988851170667, 9726.319157658896, 7496.7001319947685, 7615.314621684075, 7650.8087297818, 7717.498362606412, 7760.961195194101, 7812.414068944739, 7845.490043147177, 7850.018747656543, 7867.645955931882, 7876.921230787619, 8849.823003540021, 9008.391677838914, 9097.363184577016, 9122.407043542149, 9144.63421463134, 9198.2181514572, 9341.159295663423, 9512.667056652985, 9515.000924902786, 9525.237980961369, 6840.042394064934, 6917.446604271747, 6919.37725604698, 6928.896066559107, 6936.167659880846, 8008.199180082178, 8020.558869262247, 8097.757067287991, 8115.959420202861, 8130.796730081559, 7398.889016664647, 7520.9094681272, 7536.171021187774, 7665.080190377191, 7673.731419400518, 7372.631368431665, 7449.664765085476, 7472.813179670552, 7545.094588649397, 7601.467897247361, 7528.962355188189, 7584.620768961419, 7585.165631780389, 7588.734394296173, 7599.734009309647, 6776.0, 6911.308869113049, 6914.204866440424, 6922.10012698346, 6936.132983377078, 6492.513061520311, 6982.266861979419, 7031.156261248683, 7046.612436315847, 7049.471289653194], "unit": "ms", "name": "mootools.html", "value": 4758.089558928399}, {"lowerIsBetter": false, "replicates": [274.28138277712395, 319.39315300928234, 330.18115074614957, 332.5311311051417, 336.2400973799213, 5398.325209348832, 5477.342718873736, 6621.735130594782, 6732.73069077237, 6896.931030689691, 5321.3348331458565, 6637.0708100865795, 6771.984202369647, 6779.72881084756, 6786.083878676377, 5040.873978150539, 5062.873428164288, 5100.9489905100845, 5104.821331253407, 5115.667481613702, 4835.298881662157, 4980.128477516439, 5080.491950804909, 5093.083245015896, 5107.872303192431, 4991.575716064139, 5078.7968481260705, 5085.982803439309, 5097.980403919212, 5116.0, 5086.364204474441, 5087.9824035193105, 5088.084144853925, 5098.949010509885, 5108.08054550179, 4310.43964284641, 4334.241507736134, 4334.4798624165305, 4341.500727416356, 4349.934750978738, 5103.8213662522, 6596.80209593713, 6616.338366163393, 6642.335766423367, 6646.0, 5972.313183983854, 5975.731092100866, 5980.940190598082, 5984.97007514964, 6004.759809607611, 7063.609467455599, 7389.8522029559645, 7407.962960185218, 7407.999840043158, 7413.88879166813, 4554.499005109468, 4719.858404247878, 4753.548412900769, 4783.569478746895, 4788.904221915543, 6254.562180647356, 7423.146338171072, 7752.689892404297, 7760.340371068466, 7790.337821285198, 4236.957630423718, 4872.074305881871, 4895.485973972753, 4898.142825005681, 4901.289313049588, 4824.782884770194, 4952.975235123801, 5013.147764879979, 5016.44819069902, 5017.096922553976, 5881.2942446906645, 5883.7058147092475, 5883.794067207627, 5887.646741195542, 5889.882202355929, 7396.704131834774, 7398.704051837974, 7406.14829294638, 7408.333250007525, 7423.85152296951, 1634.1420754103954, 1691.2473949092537, 1693.7798086248956, 1729.740538919147, 1750.0374793863325, 1052.4053909541085, 1068.5031460370965, 1072.3726619927274, 1076.445630500293, 1080.0549519170725, 6237.937620623827, 6801.897971530431, 6827.590344579341, 6839.726410943606, 6846.726130954806, 7567.167611562723, 7582.62086895653, 7582.962085189539, 7583.544987300779, 7583.734569290048, 6572.07990881277, 6762.797116086525, 6801.2178599461695, 6819.7272109116075, 6845.486588505882, 3979.5423526294267, 4006.338954072545, 4011.719179657396, 4012.057166565855, 4013.097053163015, 7778.183290754502, 7809.726659567002, 7816.6091695416135, 7824.256695613907, 7826.2173782621285, 6552.868942621121, 7829.3736501079775, 7844.607769611496, 8032.196780322038, 8045.0, 6949.409300209438, 7512.797952327602, 8038.919610803817, 8044.195580442026, 8049.678012879419, 7469.7012119516785, 7556.773296801105, 7600.657970391456, 7614.771556853303, 7747.457677962489, 7618.200088990798, 7623.618819059136, 7643.235676432312, 7644.961775191088, 7645.426593005435, 7804.9609751950875, 8004.279614834692, 8008.399370047153, 8023.037235531773, 8042.3968202383885, 4306.806193721352, 4472.306792447046, 4760.97639007615, 4798.616110711065, 4820.373351464287, 6149.385061493994, 7664.961675191588, 7670.616469176407, 7685.308322251024, 7695.730649427243, 7217.855642887008, 7362.484626076338, 7404.777856664308, 7409.0, 7428.405727541675, 7354.742584009534, 7354.742584009534, 7355.0, 7360.0, 7362.0, 5838.357780644211, 7202.0, 7204.89192662121, 7214.350708436056, 7235.529690570096, 5735.4551317624755, 7377.5204611700065, 7402.1117465904435, 7402.629868506446, 7404.111506619241, 6181.660008699565, 7214.783556493314, 7222.855542889218, 7244.782656520313, 7259.7494776619415], "unit": "ms", "name": "prototype.html", "value": 5307.898677858111}, {"lowerIsBetter": false, "replicates": [696.7700658782602, 712.398023669999, 747.1407880936922, 748.2255865179541, 826.3802148388709, 14556.272186390677, 14943.925280373584, 14959.700805983874, 14963.0, 14965.925170374132, 13753.65615859604, 13845.238511881842, 13895.652608684788, 13901.930490347559, 13962.860371396308, 760.52467207995, 771.0901136658769, 771.907371115467, 947.2232769129316, 955.3074021334512, 947.1286416496839, 949.7957939043105, 962.9855552166723, 964.7298756348234, 966.1690945786653, 1002.1932344462705, 1019.6991887393236, 1020.4999550220375, 1021.0096206679547, 1021.0963297481708, 797.0753925446484, 807.648672827322, 808.6078252047752, 969.3263182088451, 1014.4217795856365, 747.7009196321515, 749.6776386153952, 754.1440465072128, 754.7924320811766, 754.8075240813612, 14408.423663053465, 14833.70332593342, 14851.2574371281, 14854.2572871356, 14856.777148342784, 12251.632451026484, 12319.322437265946, 12519.56181533642, 12609.558665446757, 12753.043521735906, 9842.409455432626, 9900.900990990142, 10033.799324013551, 10643.946780266126, 10725.30285531438, 3511.17487390463, 3539.1682954505673, 3573.3925232710503, 3577.421436727394, 3639.0720366306423, 76612.61693691551, 76870.0, 76908.61545692291, 76919.84620230645, 76982.61508692421, 9637.325387222967, 9646.42121472714, 9767.16979056774, 9849.803003940024, 9872.901270987342, 21744.347669569623, 21759.564808703737, 21768.782312176674, 21796.019179136976, 21813.454663633536, 7325.816854578572, 7417.258274172539, 7537.283958023979, 7672.347850432776, 7702.268284512962, 3940.566537680853, 4030.9182973051106, 4061.5329237137516, 4083.530394004668, 4093.0790572121036, 3386.0180547640907, 3434.4161492545827, 3436.0, 3436.6906978372067, 3437.020449171974, 606.4178388746765, 617.9691015449209, 620.0853740732383, 628.1237673445518, 635.3455940381415, 483.1134867518144, 526.6734624532737, 553.3608681972329, 567.0190570313381, 581.2269681323913, 8919.509426981449, 9199.310051746146, 9385.57764900581, 9401.388909720847, 9542.0, 377.71482530689156, 584.6667399582283, 598.8233471126028, 599.4185639929261, 607.5777334752305, 3965.762054276695, 4267.274563324242, 4374.21264172452, 4386.8903277417685, 4448.532904045093, 101042.0, 101423.0, 101483.0, 101604.49197753964, 105331.0, 80689.0, 81407.592962036, 82504.0, 83327.16672833315, 83621.0, 70648.2935170652, 72132.0, 72197.54611002702, 72344.0, 72666.63666681632, 8642.43824151428, 8712.607932643174, 8768.298536117223, 8806.0, 8973.50645714492, 48798.292059777734, 50689.49310506995, 51035.48964510307, 51666.74166629293, 51681.224781627556, 71247.28752712614, 77044.0, 77284.61357693176, 77713.44573108619, 79404.0, 10475.94762026185, 10794.028537431355, 11074.0, 11241.213115081866, 11414.258073225214, 12149.453274602842, 12462.626121216377, 12522.311272880079, 12935.223886566837, 12935.482580696667, 11389.487473063566, 11519.98887437483, 11980.940095299467, 12055.095867810125, 12379.442925068213, 11507.42462876836, 11570.363630000431, 11717.88282117168, 11895.286282823059, 12350.81473777876, 11589.362585057903, 11726.648200553997, 11804.0, 11810.645680629596, 11817.586384476503, 9538.95230523843, 9854.704358869245, 9943.552540135855, 10183.643572474928, 10758.354498730101, 8003.6798528058225, 9239.538023098952, 9368.197122894428, 9540.618375264912, 9623.831007798193], "unit": "ms", "name": "yui.html", "value": 7031.544359461388}], "name": "dromaeo_css", "value": 7790.633937889551}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 108.0, 108.0, 107.0, 98.0, 108.0, 102.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 105.8}, {"lowerIsBetter": true, "replicates": [154.0, 121.0, 141.0, 155.0, 118.0, 139.0, 139.0, 114.0, 154.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.6}, {"lowerIsBetter": true, "replicates": [182.0, 182.0, 182.0, 181.0, 184.0, 184.0, 183.0, 186.0, 182.0, 185.0], "unit": "ms", "name": "audio-dft", "value": 183.1}, {"lowerIsBetter": true, "replicates": [61.0, 69.0, 74.0, 72.0, 54.0, 58.0, 56.0, 68.0, 71.0, 53.0], "unit": "ms", "name": "audio-fft", "value": 63.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 115.0, 75.0, 74.0, 75.0, 111.0, 74.0, 76.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 88.2}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 129.0, 96.0, 85.0, 87.0, 87.0, 87.0, 86.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 91.7}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0, 150.0, 128.0], "unit": "ms", "name": "imaging-darkroom", "value": 103.8}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 86.0, 84.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.4}, {"lowerIsBetter": true, "replicates": [51.0, 55.0, 54.0, 53.0, 54.0, 55.0, 54.0, 64.0, 55.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 65.0, 65.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 83.0, 82.0, 82.0, 82.0, 82.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [122.0, 129.0, 108.0, 110.0, 127.0, 115.0, 120.0, 121.0, 120.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [135.0, 123.0, 134.0, 135.0, 135.0, 123.0, 135.0, 134.0, 134.0, 122.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.0}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 74.0, 74.0, 90.0, 85.0, 60.0, 53.0, 59.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1378.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.45605700712588], "unit": "score", "name": "Richards", "value": 237.794272}, {"lowerIsBetter": false, "replicates": [161.95704828031649], "unit": "score", "name": "DeltaBlue", "value": 408.2440418743769}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [4753.554502369669], "unit": "score", "name": "Decrypt", "value": 55.99620239282153}, {"lowerIsBetter": false, "replicates": [1700.6802721088436], "unit": "score", "name": "RayTrace", "value": 435.113532}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [13157.894736842105], "unit": "score", "name": "Boyer", "value": 50.65118800000001}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [731.0495626822158], "unit": "score", "name": "Splay", "value": 111.47123828514457}, {"lowerIsBetter": false, "replicates": [4524.886877828054], "unit": "score", "name": "NavierStokes", "value": 327.9640000000003}], "name": "v8_7", "value": 20396.007915433987}]} 02:16:12 INFO - RETURN: dromaeo_css: 7790.63 02:16:12 INFO - RETURN: kraken: 1378.30 02:16:12 INFO - RETURN: v8_7: 20396.01 02:16:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20396.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1378.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7790.63"}}} 02:16:12 INFO - Return code: 0 02:16:12 INFO - # TBPL SUCCESS # 02:16:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:16:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:16:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:16:12 INFO - 2015-11-20 02:16:12.225 screenresolution[1672:10714] starting screenresolution argv=screenresolution get 02:16:12 INFO - 2015-11-20 02:16:12.228 screenresolution[1672:10714] Display 0: 1600x1200x32@60 02:16:12 INFO - 2015-11-20 02:16:12.234 screenresolution[1673:10717] starting screenresolution argv=screenresolution list 02:16:12 INFO - Available Modes on Display 0 02:16:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:16:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:16:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:16:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:16:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:16:12 INFO - Intel Iris: 02:16:12 INFO - Chipset Model: Intel Iris 02:16:12 INFO - Type: GPU 02:16:12 INFO - Bus: Built-In 02:16:12 INFO - VRAM (Dynamic, Max): 1536 MB 02:16:12 INFO - Vendor: Intel (0x8086) 02:16:12 INFO - Device ID: 0x0a2e 02:16:12 INFO - Revision ID: 0x0009 02:16:12 INFO - Displays: 02:16:12 INFO - Display: 02:16:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:16:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:16:12 INFO - Display Serial Number: 1600x1200 60 02:16:12 INFO - Main Display: Yes 02:16:12 INFO - Mirror: Off 02:16:12 INFO - Online: Yes 02:16:12 INFO - Rotation: Supported 02:16:12 INFO - Return code: 0 02:16:12 INFO - Running post-action listener: _resource_record_post_action 02:16:12 INFO - Running post-run listener: _resource_record_post_run 02:16:13 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 33713664; Write bytes: 689936384; Read time: 394; Write time: 2066 02:16:13 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 336142848; Write bytes: 337823744; Read time: 25969; Write time: 631 02:16:13 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 32787968; Write bytes: 341745664; Read time: 380; Write time: 1402 02:16:13 INFO - Running post-run listener: _upload_blobber_files 02:16:13 INFO - Blob upload gear active. 02:16:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:16:13 INFO - Copying logs to upload dir... 02:16:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1304.059351 ========= master_lag: 119.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 43 secs) (at 2015-11-20 02:18:13.436425) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 02:18:13.441806) ========= 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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009406 build_url: 'https://queue.taskcluster.net/v1/task/ItKGn1M6RC-DPA_Es6Mzcg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.49 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 02:18:13.945843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 02:18:13.946144) ========= 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.CJoZZqCbzt/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.jwqI8qLjaW/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.004568 ========= master_lag: 1.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 02:18:14.959406) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-20 02:18:14.959697) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-20 02:18:18.551385) ========= ========= Total master_lag: 121.80 =========