builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1448371676.94 results: success (0) buildid: 20151124030554 builduid: 36a9e66d186840abb728eb130731057a revision: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.939019) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.939755) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.940180) ========= 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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005439 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.964017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.964516) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.981159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:56.981580) ========= 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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.004983 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.030462) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.030751) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.031076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.031370) ========= 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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-24 05:27:57-- 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% 50.1M=0s 2015-11-24 05:27:57 (50.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.219143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.221094) ========= 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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.026592 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.269697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:57.270142) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c7500d7c6de994c6263912a0a558b3b9c3308c2 --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 2c7500d7c6de994c6263912a0a558b3b9c3308c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-24 05:27:57,348 truncating revision to first 12 chars 2015-11-24 05:27:57,348 Setting DEBUG logging. 2015-11-24 05:27:57,348 attempt 1/10 2015-11-24 05:27:57,348 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c7500d7c6de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 05:27:58,002 unpacking tar archive at: fx-team-2c7500d7c6de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:58.179062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:58.179396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:58.190381) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:58.190693) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:27:58.191273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-24 05:27:58.191936) ========= /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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:27:58 INFO - MultiFileLogger online at 20151124 05:27:58 in /builds/slave/test 05:27:58 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 05:27:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:58 INFO - {'append_to_log': False, 05:27:58 INFO - 'base_work_dir': '/builds/slave/test', 05:27:58 INFO - 'blob_upload_branch': 'Fx-Team', 05:27:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:58 INFO - 'branch': 'Fx-Team', 05:27:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:58 INFO - 'config_files': ('talos/mac_config.py',), 05:27:58 INFO - 'default_actions': ('clobber', 05:27:58 INFO - 'read-buildbot-config', 05:27:58 INFO - 'download-and-extract', 05:27:58 INFO - 'populate-webroot', 05:27:58 INFO - 'create-virtualenv', 05:27:58 INFO - 'install', 05:27:58 INFO - 'run-tests'), 05:27:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:58 INFO - 'download_minidump_stackwalk': True, 05:27:58 INFO - 'download_symbols': 'ondemand', 05:27:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:58 INFO - 'installer_path': 'installer.exe', 05:27:58 INFO - 'log_level': 'info', 05:27:58 INFO - 'log_name': 'talos', 05:27:58 INFO - 'log_to_console': True, 05:27:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:27:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:27:58 INFO - 'opt_config_files': (), 05:27:58 INFO - 'pip_index': False, 05:27:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:58 INFO - 'cmd': ('bash', 05:27:58 INFO - '-c', 05:27:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:58 INFO - 'enabled': True, 05:27:58 INFO - 'halt_on_failure': False, 05:27:58 INFO - 'name': 'check_screen_resolution'},), 05:27:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:58 INFO - 'cmd': ('bash', 05:27:58 INFO - '-c', 05:27:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:58 INFO - 'enabled': True, 05:27:58 INFO - 'halt_on_failure': False, 05:27:58 INFO - 'name': 'check_screen_resolution'},), 05:27:58 INFO - 'run_cmd_checks_enabled': True, 05:27:58 INFO - 'sps_profile': False, 05:27:58 INFO - 'sps_profile_interval': 0, 05:27:58 INFO - 'suite': 'dromaeojs', 05:27:58 INFO - 'system_bits': '64', 05:27:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:58 INFO - 'title': 't-yosemite-r7-0028', 05:27:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:58 INFO - 'use_talos_json': True, 05:27:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:58 INFO - 'work_dir': 'build'} 05:27:58 INFO - ##### 05:27:58 INFO - ##### Running clobber step. 05:27:58 INFO - ##### 05:27:58 INFO - Running pre-action listener: _resource_record_pre_action 05:27:58 INFO - Running main action method: clobber 05:27:58 INFO - rmtree: /builds/slave/test/build 05:27:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:59 INFO - Running post-action listener: _resource_record_post_action 05:27:59 INFO - ##### 05:27:59 INFO - ##### Running read-buildbot-config step. 05:27:59 INFO - ##### 05:27:59 INFO - Running pre-action listener: _resource_record_pre_action 05:27:59 INFO - Running main action method: read_buildbot_config 05:27:59 INFO - Using buildbot properties: 05:27:59 INFO - { 05:27:59 INFO - "properties": { 05:27:59 INFO - "buildnumber": 25, 05:27:59 INFO - "product": "firefox", 05:27:59 INFO - "script_repo_revision": "production", 05:27:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:27:59 INFO - "repository": "", 05:27:59 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:27:59 INFO - "buildid": "20151124030554", 05:27:59 INFO - "slavename": "t-yosemite-r7-0028", 05:27:59 INFO - "pgo_build": "False", 05:27:59 INFO - "basedir": "/builds/slave/test", 05:27:59 INFO - "project": "", 05:27:59 INFO - "platform": "yosemite_r7", 05:27:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:27:59 INFO - "slavebuilddir": "test", 05:27:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:27:59 INFO - "branch": "fx-team", 05:27:59 INFO - "repo_path": "integration/fx-team", 05:27:59 INFO - "stage_platform": "macosx64", 05:27:59 INFO - "builduid": "36a9e66d186840abb728eb130731057a", 05:27:59 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 05:27:59 INFO - }, 05:27:59 INFO - "sourcestamp": { 05:27:59 INFO - "repository": "", 05:27:59 INFO - "hasPatch": false, 05:27:59 INFO - "project": "", 05:27:59 INFO - "branch": "fx-team-macosx64-talos", 05:27:59 INFO - "changes": [ 05:27:59 INFO - { 05:27:59 INFO - "category": null, 05:27:59 INFO - "files": [ 05:27:59 INFO - { 05:27:59 INFO - "url": null, 05:27:59 INFO - "name": "https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:27:59 INFO - } 05:27:59 INFO - ], 05:27:59 INFO - "repository": "", 05:27:59 INFO - "rev": "2c7500d7c6de994c6263912a0a558b3b9c3308c2", 05:27:59 INFO - "who": "mratcliffe@mozilla.com", 05:27:59 INFO - "when": 1448369348, 05:27:59 INFO - "number": 6700000, 05:27:59 INFO - "comments": "Bug 1225289 - Make eslint plugin code conform to .eslintrc r=pbrosset\n\nAdded use strict statements now that we are no longer set up for ES6 modules.", 05:27:59 INFO - "project": "", 05:27:59 INFO - "at": "Tue 24 Nov 2015 04:49:08", 05:27:59 INFO - "branch": "fx-team-macosx64-talos", 05:27:59 INFO - "revlink": "", 05:27:59 INFO - "properties": [ 05:27:59 INFO - [ 05:27:59 INFO - "buildid", 05:27:59 INFO - "20151124030554", 05:27:59 INFO - "Change" 05:27:59 INFO - ], 05:27:59 INFO - [ 05:27:59 INFO - "builduid", 05:27:59 INFO - "36a9e66d186840abb728eb130731057a", 05:27:59 INFO - "Change" 05:27:59 INFO - ], 05:27:59 INFO - [ 05:27:59 INFO - "pgo_build", 05:27:59 INFO - "False", 05:27:59 INFO - "Change" 05:27:59 INFO - ] 05:27:59 INFO - ], 05:27:59 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 05:27:59 INFO - } 05:27:59 INFO - ], 05:27:59 INFO - "revision": "2c7500d7c6de994c6263912a0a558b3b9c3308c2" 05:27:59 INFO - } 05:27:59 INFO - } 05:27:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:27:59 INFO - Running post-action listener: _resource_record_post_action 05:27:59 INFO - ##### 05:27:59 INFO - ##### Running download-and-extract step. 05:27:59 INFO - ##### 05:27:59 INFO - Running pre-action listener: _resource_record_pre_action 05:27:59 INFO - Running main action method: download_and_extract 05:27:59 INFO - mkdir: /builds/slave/test/build/tests 05:27: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')]} 05:27:59 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json 05:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json 05:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:28:00 INFO - Downloaded 1149 bytes. 05:28:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:28:00 INFO - Using the following test package requirements: 05:28:00 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:28:00 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:28:00 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'jsshell-mac.zip'], 05:28:00 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:28:00 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:28:00 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:28:00 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:28:00 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:28:00 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:28:00 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:28:00 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:28:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:00 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:28:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:28:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:28:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:01 INFO - Downloaded 17526959 bytes. 05:28:01 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 05:28:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:28:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:28:04 INFO - Return code: 0 05:28:04 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 05:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:04 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:05 INFO - Downloaded 17526959 bytes. 05:28:05 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 05:28:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:28:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:28:09 INFO - Return code: 0 05:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:09 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:28:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:28:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:28:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:09 INFO - Downloaded 11130997 bytes. 05:28:09 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 05:28:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:28:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:28:10 INFO - Return code: 0 05:28: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')]} 05:28:10 INFO - https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:28:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:28:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:28:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osqUG2hkRPuECkOjnOcW2Q/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 05:28:13 INFO - Downloaded 109910450 bytes. 05:28:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:28:13 INFO - mkdir: /builds/slave/test/properties 05:28:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:13 INFO - Contents: 05:28:13 INFO - build_url:https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:28:13 INFO - Running post-action listener: _resource_record_post_action 05:28:13 INFO - Running post-action listener: set_extra_try_arguments 05:28:13 INFO - ##### 05:28:13 INFO - ##### Running populate-webroot step. 05:28:13 INFO - ##### 05:28:13 INFO - Running pre-action listener: _resource_record_pre_action 05:28:13 INFO - Running main action method: populate_webroot 05:28:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:13 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:28:13 INFO - '../fennec_ids.txt'], 05:28:13 INFO - 'tests': ['tcheck2']}, 05:28:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:13 INFO - '--tppagecycles', 05:28:13 INFO - '7'], 05:28:13 INFO - 'tests': ['tsvgm']}}, 05:28:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:28:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:28:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:28:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'tests': ['damp', 'tps']}, 05:28:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['damp', 'tps']}, 05:28:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:28:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:13 INFO - 'other': {'tests': ['a11yr', 05:28:13 INFO - 'ts_paint', 05:28:13 INFO - 'tpaint', 05:28:13 INFO - 'sessionrestore', 05:28:13 INFO - 'sessionrestore_no_auto_restore']}, 05:28:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['a11yr', 05:28:13 INFO - 'ts_paint', 05:28:13 INFO - 'tpaint', 05:28:13 INFO - 'sessionrestore', 05:28:13 INFO - 'sessionrestore_no_auto_restore']}, 05:28:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['a11yr', 05:28:13 INFO - 'ts_paint', 05:28:13 INFO - 'tpaint', 05:28:13 INFO - 'sessionrestore', 05:28:13 INFO - 'sessionrestore_no_auto_restore']}, 05:28:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['a11yr', 05:28:13 INFO - 'ts_paint', 05:28:13 INFO - 'tpaint', 05:28:13 INFO - 'sessionrestore', 05:28:13 INFO - 'sessionrestore_no_auto_restore']}, 05:28:13 INFO - 'other_l64': {'tests': ['a11yr', 05:28:13 INFO - 'ts_paint', 05:28:13 INFO - 'tpaint', 05:28:13 INFO - 'sessionrestore', 05:28:13 INFO - 'sessionrestore_no_auto_restore']}, 05:28:13 INFO - 'other_nol64': {'tests': ['a11yr', 05:28:13 INFO - 'ts_paint', 05:28:13 INFO - 'tpaint', 05:28:13 INFO - 'sessionrestore', 05:28:13 INFO - 'sessionrestore_no_auto_restore']}, 05:28:13 INFO - 'svgr': {'tests': ['tsvgx', 05:28:13 INFO - 'tsvgr_opacity', 05:28:13 INFO - 'tart', 05:28:13 INFO - 'tscrollx', 05:28:13 INFO - 'cart']}, 05:28:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['tsvgx', 05:28:13 INFO - 'tsvgr_opacity', 05:28:13 INFO - 'tart', 05:28:13 INFO - 'tscrollx', 05:28:13 INFO - 'cart']}, 05:28:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'tests': ['tp5o']}, 05:28:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'talos_options': ['--e10s'], 05:28:13 INFO - 'tests': ['tp5o']}, 05:28:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'talos_options': ['--xperf_path', 05:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:13 INFO - 'tests': ['tp5n']}, 05:28:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:13 INFO - 'talos_options': ['--e10s', 05:28:13 INFO - '--xperf_path', 05:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:13 INFO - 'tests': ['tp5n']}}, 05:28:13 INFO - 'talos.zip': {'path': '', 05:28:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:13 INFO - Running post-action listener: _resource_record_post_action 05:28:13 INFO - ##### 05:28:13 INFO - ##### Running create-virtualenv step. 05:28:13 INFO - ##### 05:28:13 INFO - Running pre-action listener: _resource_record_pre_action 05:28:13 INFO - Running main action method: create_virtualenv 05:28:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:13 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 05:28:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:13 INFO - Using real prefix '/tools/python27' 05:28:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:17 INFO - Installing pip.................done. 05:28:17 INFO - Return code: 0 05:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28: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', 'pip>=1.5'] in /builds/slave/test/build 05:28: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 pip>=1.5 05:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:17 INFO - 'HOME': '/Users/cltbld', 05:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:17 INFO - 'LOGNAME': 'cltbld', 05:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:17 INFO - 'MOZ_NO_REMOTE': '1', 05:28:17 INFO - 'NO_EM_RESTART': '1', 05:28:17 INFO - 'PAGER': '/bin/cat', 05:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:17 INFO - 'PWD': '/builds/slave/test', 05:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:17 INFO - 'SHELL': '/bin/bash', 05:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:17 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:17 INFO - 'USER': 'cltbld', 05:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:17 INFO - 'XPC_FLAGS': '0x0', 05:28:17 INFO - 'XPC_SERVICE_NAME': '0', 05:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:28:18 INFO - Cleaning up... 05:28:18 INFO - Return code: 0 05:28:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:18 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 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28:18 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 05:28:18 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 05:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:18 INFO - 'HOME': '/Users/cltbld', 05:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:18 INFO - 'LOGNAME': 'cltbld', 05:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:18 INFO - 'MOZ_NO_REMOTE': '1', 05:28:18 INFO - 'NO_EM_RESTART': '1', 05:28:18 INFO - 'PAGER': '/bin/cat', 05:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:18 INFO - 'PWD': '/builds/slave/test', 05:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:18 INFO - 'SHELL': '/bin/bash', 05:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:18 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:18 INFO - 'USER': 'cltbld', 05:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:18 INFO - 'XPC_FLAGS': '0x0', 05:28:18 INFO - 'XPC_SERVICE_NAME': '0', 05:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:18 INFO - Downloading/unpacking psutil>=0.7.1 05:28: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 05:28: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 05:28: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 05:28: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 05:28: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 05:28: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 05:28:20 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:28:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:21 INFO - Installing collected packages: psutil 05:28:21 INFO - Running setup.py install for psutil 05:28:21 INFO - building 'psutil._psutil_osx' extension 05:28:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:28:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:28:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:28:21 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 05:28:22 INFO - building 'psutil._psutil_posix' extension 05:28:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:28:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:28:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:28:22 INFO - ^ 05:28:22 INFO - 1 warning generated. 05:28:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:22 INFO - Successfully installed psutil 05:28:22 INFO - Cleaning up... 05:28:22 INFO - Return code: 0 05:28:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:22 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 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28:22 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 05:28:22 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 05:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:22 INFO - 'HOME': '/Users/cltbld', 05:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:22 INFO - 'LOGNAME': 'cltbld', 05:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:22 INFO - 'MOZ_NO_REMOTE': '1', 05:28:22 INFO - 'NO_EM_RESTART': '1', 05:28:22 INFO - 'PAGER': '/bin/cat', 05:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:22 INFO - 'PWD': '/builds/slave/test', 05:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:22 INFO - 'SHELL': '/bin/bash', 05:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:22 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:22 INFO - 'USER': 'cltbld', 05:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:22 INFO - 'XPC_FLAGS': '0x0', 05:28:22 INFO - 'XPC_SERVICE_NAME': '0', 05:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:28:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:28:24 INFO - Installing collected packages: mozsystemmonitor 05:28:24 INFO - Running setup.py install for mozsystemmonitor 05:28:24 INFO - Successfully installed mozsystemmonitor 05:28:24 INFO - Cleaning up... 05:28:25 INFO - Return code: 0 05:28:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:25 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 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28:25 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 05:28:25 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 05:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:25 INFO - 'HOME': '/Users/cltbld', 05:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:25 INFO - 'LOGNAME': 'cltbld', 05:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:25 INFO - 'MOZ_NO_REMOTE': '1', 05:28:25 INFO - 'NO_EM_RESTART': '1', 05:28:25 INFO - 'PAGER': '/bin/cat', 05:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:25 INFO - 'PWD': '/builds/slave/test', 05:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:25 INFO - 'SHELL': '/bin/bash', 05:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:25 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:25 INFO - 'USER': 'cltbld', 05:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:25 INFO - 'XPC_FLAGS': '0x0', 05:28:25 INFO - 'XPC_SERVICE_NAME': '0', 05:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:28 INFO - Downloading docopt-0.6.1.tar.gz 05:28:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:28 INFO - Running setup.py install for blobuploader 05:28:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:28 INFO - Running setup.py install for requests 05:28:29 INFO - Running setup.py install for docopt 05:28:29 INFO - Successfully installed blobuploader requests docopt 05:28:29 INFO - Cleaning up... 05:28:29 INFO - Return code: 0 05:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:29 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 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28:29 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 05:28:29 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 05:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:29 INFO - 'HOME': '/Users/cltbld', 05:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:29 INFO - 'LOGNAME': 'cltbld', 05:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:29 INFO - 'MOZ_NO_REMOTE': '1', 05:28:29 INFO - 'NO_EM_RESTART': '1', 05:28:29 INFO - 'PAGER': '/bin/cat', 05:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:29 INFO - 'PWD': '/builds/slave/test', 05:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:29 INFO - 'SHELL': '/bin/bash', 05:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:29 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:29 INFO - 'USER': 'cltbld', 05:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:29 INFO - 'XPC_FLAGS': '0x0', 05:28:29 INFO - 'XPC_SERVICE_NAME': '0', 05:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Q2AzfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-tDoE2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-0AZjlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-FelnHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qnXYy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xdEYWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JJYRuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-nDkAY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-QeIQXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-y17M_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-h0MWhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-aDB9kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-EZ0fW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ivY4rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-He1J1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-dwklyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-caIJKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:31 INFO - Running setup.py install for manifestparser 05:28:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:31 INFO - Running setup.py install for mozcrash 05:28:31 INFO - Running setup.py install for mozdebug 05:28:32 INFO - Running setup.py install for mozdevice 05:28:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Running setup.py install for mozfile 05:28:32 INFO - Running setup.py install for mozhttpd 05:28:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Running setup.py install for mozinfo 05:28:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Running setup.py install for mozInstall 05:28:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:32 INFO - Running setup.py install for mozleak 05:28:32 INFO - Running setup.py install for mozlog 05:28:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Running setup.py install for moznetwork 05:28:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Running setup.py install for mozprocess 05:28:33 INFO - Running setup.py install for mozprofile 05:28:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Running setup.py install for mozrunner 05:28:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Running setup.py install for mozscreenshot 05:28:33 INFO - Running setup.py install for moztest 05:28:34 INFO - Running setup.py install for mozversion 05:28:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:34 INFO - Cleaning up... 05:28:34 INFO - Return code: 0 05:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:34 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 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28:34 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 05:28:34 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 05:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:34 INFO - 'HOME': '/Users/cltbld', 05:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:34 INFO - 'LOGNAME': 'cltbld', 05:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:34 INFO - 'MOZ_NO_REMOTE': '1', 05:28:34 INFO - 'NO_EM_RESTART': '1', 05:28:34 INFO - 'PAGER': '/bin/cat', 05:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:34 INFO - 'PWD': '/builds/slave/test', 05:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:34 INFO - 'SHELL': '/bin/bash', 05:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:34 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:34 INFO - 'USER': 'cltbld', 05:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:34 INFO - 'XPC_FLAGS': '0x0', 05:28:34 INFO - 'XPC_SERVICE_NAME': '0', 05:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Ch1A5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:34 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)) 05:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-R4lyjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:34 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)) 05:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-3Jsu2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:34 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)) 05:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-28kmQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:34 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)) 05:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XK4rKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:34 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)) 05:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-2K9R2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-q3oaGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-h8XLh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OcdGCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-1h8M1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UGATVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-KRXlTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-09iOZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-vuH8wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:35 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)) 05:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-F6f0YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-j5ScUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jNQtjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:36 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)) 05:28:36 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)) 05:28:36 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)) 05:28:36 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)) 05:28:36 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)) 05:28:36 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)) 05:28:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:36 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 05:28:36 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 05:28:36 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 05:28:36 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 05:28:36 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 05:28:36 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 05:28:38 INFO - Downloading blessings-1.5.1.tar.gz 05:28:38 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 05:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:38 INFO - Installing collected packages: blessings 05:28:38 INFO - Running setup.py install for blessings 05:28:38 INFO - Successfully installed blessings 05:28:38 INFO - Cleaning up... 05:28:38 INFO - Return code: 0 05:28:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:38 INFO - Reading from file tmpfile_stdout 05:28:38 INFO - Current package versions: 05:28:38 INFO - blessings == 1.5.1 05:28:38 INFO - blobuploader == 1.2.4 05:28:38 INFO - docopt == 0.6.1 05:28:38 INFO - manifestparser == 1.1 05:28:38 INFO - mozInstall == 1.12 05:28:38 INFO - mozcrash == 0.16 05:28:38 INFO - mozdebug == 0.1 05:28:38 INFO - mozdevice == 0.47 05:28:38 INFO - mozfile == 1.2 05:28:38 INFO - mozhttpd == 0.7 05:28:38 INFO - mozinfo == 0.9 05:28:38 INFO - mozleak == 0.1 05:28:38 INFO - mozlog == 3.1 05:28:38 INFO - moznetwork == 0.27 05:28:38 INFO - mozprocess == 0.22 05:28:38 INFO - mozprofile == 0.27 05:28:38 INFO - mozrunner == 6.11 05:28:38 INFO - mozscreenshot == 0.1 05:28:38 INFO - mozsystemmonitor == 0.0 05:28:38 INFO - moztest == 0.7 05:28:38 INFO - mozversion == 1.4 05:28:38 INFO - psutil == 3.1.1 05:28:38 INFO - requests == 1.2.3 05:28:38 INFO - wsgiref == 0.1.2 05:28:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:38 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 0x107fe5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff558cb8440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, '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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 05:28:38 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 05:28:38 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 05:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:38 INFO - 'HOME': '/Users/cltbld', 05:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:38 INFO - 'LOGNAME': 'cltbld', 05:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:38 INFO - 'MOZ_NO_REMOTE': '1', 05:28:38 INFO - 'NO_EM_RESTART': '1', 05:28:38 INFO - 'PAGER': '/bin/cat', 05:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:38 INFO - 'PWD': '/builds/slave/test', 05:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:38 INFO - 'SHELL': '/bin/bash', 05:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:28:38 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:38 INFO - 'USER': 'cltbld', 05:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:38 INFO - 'XPC_FLAGS': '0x0', 05:28:38 INFO - 'XPC_SERVICE_NAME': '0', 05:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 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)) 05:28:39 INFO - Cleaning up... 05:28:39 INFO - Return code: 0 05:28:39 INFO - Running post-action listener: _resource_record_post_action 05:28:39 INFO - Running post-action listener: _start_resource_monitoring 05:28:39 INFO - Starting resource monitoring. 05:28:39 INFO - ##### 05:28:39 INFO - ##### Running install step. 05:28:39 INFO - ##### 05:28:39 INFO - Running pre-action listener: _resource_record_pre_action 05:28:39 INFO - Running main action method: install 05:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:39 INFO - Reading from file tmpfile_stdout 05:28:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:39 INFO - Reading from file tmpfile_stdout 05:28:39 INFO - Output received: 05:28:39 INFO - Usage: mozinstall [options] installer 05:28:39 INFO - Options: 05:28:39 INFO - -h, --help show this help message and exit 05:28:39 INFO - -d DEST, --destination=DEST 05:28:39 INFO - Directory to install application into. [default: 05:28:39 INFO - "/builds/slave/test"] 05:28:39 INFO - --app=APP Application being installed. [default: firefox] 05:28:39 INFO - mkdir: /builds/slave/test/build/application 05:28:39 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'] 05:28:39 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 05:29:10 INFO - Reading from file tmpfile_stdout 05:29:10 INFO - Output received: 05:29:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:29:10 INFO - Running post-action listener: _resource_record_post_action 05:29:10 INFO - ##### 05:29:10 INFO - ##### Running run-tests step. 05:29:10 INFO - ##### 05:29:10 INFO - Running pre-action listener: _resource_record_pre_action 05:29:10 INFO - Running main action method: run_tests 05:29:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:10 INFO - 2015-11-24 05:29:10.671 screenresolution[1641:7469] starting screenresolution argv=screenresolution get 05:29:10 INFO - 2015-11-24 05:29:10.673 screenresolution[1641:7469] Display 0: 1600x1200x32@60 05:29:10 INFO - 2015-11-24 05:29:10.679 screenresolution[1642:7471] starting screenresolution argv=screenresolution list 05:29:10 INFO - Available Modes on Display 0 05:29:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:10 INFO - Intel Iris: 05:29:10 INFO - Chipset Model: Intel Iris 05:29:10 INFO - Type: GPU 05:29:10 INFO - Bus: Built-In 05:29:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:10 INFO - Vendor: Intel (0x8086) 05:29:10 INFO - Device ID: 0x0a2e 05:29:10 INFO - Revision ID: 0x0009 05:29:10 INFO - Displays: 05:29:10 INFO - Display: 05:29:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:10 INFO - Display Serial Number: 1600x1200 60 05:29:10 INFO - Main Display: Yes 05:29:10 INFO - Mirror: Off 05:29:10 INFO - Online: Yes 05:29:10 INFO - Rotation: Supported 05:29:10 INFO - Return code: 0 05:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:10 INFO - Python 2.7.3 05:29:10 INFO - Return code: 0 05:29:10 INFO - grabbing minidump binary from tooltool 05:29: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')]} 05:29:10 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 0x107f099f0>, '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 0x107c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efc8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:10 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 05:29:10 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 05:29:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:11 INFO - Return code: 0 05:29:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:29:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:29:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:11 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/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost'] in /builds/slave/test/build 05:29:11 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/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost 05:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a1FFrV76FZ/Render', 05:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:11 INFO - 'HOME': '/Users/cltbld', 05:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:11 INFO - 'LOGNAME': 'cltbld', 05:29:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:11 INFO - 'MOZ_NO_REMOTE': '1', 05:29:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:11 INFO - 'NO_EM_RESTART': '1', 05:29:11 INFO - 'PAGER': '/bin/cat', 05:29:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:11 INFO - 'PWD': '/builds/slave/test', 05:29:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:11 INFO - 'SHELL': '/bin/bash', 05:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PCQP0Sgko5/Listeners', 05:29:11 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 05:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:11 INFO - 'USER': 'cltbld', 05:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:11 INFO - 'XPC_FLAGS': '0x0', 05:29:11 INFO - 'XPC_SERVICE_NAME': '0', 05:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:11 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/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost'] with output_timeout 3600 05:29:11 INFO - mozversion INFO | application_buildid: 20151124030554 05:29:11 INFO - mozversion INFO | application_changeset: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 05:29:11 INFO - mozversion INFO | application_display_name: Nightly 05:29:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:11 INFO - mozversion INFO | application_name: Firefox 05:29:11 INFO - mozversion INFO | application_remotingname: firefox 05:29:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:29:11 INFO - mozversion INFO | application_vendor: Mozilla 05:29:11 INFO - mozversion INFO | application_version: 45.0a1 05:29:11 INFO - mozversion INFO | platform_buildid: 20151124030554 05:29:11 INFO - mozversion INFO | platform_changeset: 2c7500d7c6de994c6263912a0a558b3b9c3308c2 05:29:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:29:11 INFO - mozversion INFO | platform_version: 45.0a1 05:29:11 INFO - 2015-11-24 05:29:11,229 DEBUG : using testdate: 1448371751 05:29:11 INFO - 2015-11-24 05:29:11,229 DEBUG : actual date: 1448371751 05:29:11 INFO - 2015-11-24 05:29:11,579 INFO : starting webserver on 'localhost:49274' 05:29:11 INFO - 2015-11-24 05:29:11,580 INFO : Starting test suite t-yosemite-r7-0028 05:29:11 INFO - 2015-11-24 05:29:11,580 INFO : Starting test dromaeo_css 05:29:11 INFO - 2015-11-24 05:29:11,580 DEBUG : operating with platform_type : mac_ 05:29:11 INFO - 2015-11-24 05:29:11,581 INFO : Initialising browser for dromaeo_css test... 05:29:11 INFO - 2015-11-24 05:29:11,594 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpuBM4Hz/profile http://localhost:49274/getInfo.html 05:29:13 INFO - 2015-11-24 05:29:13,843 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:13 INFO - 2015-11-24 05:29:13,844 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:13 INFO - 2015-11-24 05:29:13,844 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:29:13 INFO - 2015-11-24 05:29:13,844 DEBUG : BROWSER_OUTPUT: __metrics 05:29:13 INFO - 2015-11-24 05:29:13,859 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:14 INFO - 2015-11-24 05:29:14,122 DEBUG : BROWSER_OUTPUT: console.error: 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: Stack: 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 05:29:14 INFO - 2015-11-24 05:29:14,123 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:29:14 INFO - 2015-11-24 05:29:14,124 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-11-24 05:29:14,552 INFO : Browser initialized. 05:29:14 INFO - 2015-11-24 05:29:14,552 INFO : Running cycle 1/1 for dromaeo_css test... 05:29:14 INFO - 2015-11-24 05:29:14,552 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpuBM4Hz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:26 INFO - 2015-11-24 05:29:26,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 225742848 05:29:26 INFO - 2015-11-24 05:29:26,312 DEBUG : BROWSER_OUTPUT: 05:30:17 INFO - 2015-11-24 05:30:17,642 DEBUG : BROWSER_OUTPUT: 1448371817642 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] 05:32:27 INFO - 2015-11-24 05:32:27,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:32:30 INFO - 2015-11-24 05:32:30,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 447242240 05:32:30 INFO - 2015-11-24 05:32:30,172 DEBUG : BROWSER_OUTPUT: 05:35:33 INFO - 2015-11-24 05:35:33,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:35:33 INFO - 2015-11-24 05:35:33,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 370585600 05:35:33 INFO - 2015-11-24 05:35:33,717 DEBUG : BROWSER_OUTPUT: 05:38:35 INFO - 2015-11-24 05:38:35,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:38:36 INFO - 2015-11-24 05:38:36,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 366555136 05:38:36 INFO - 2015-11-24 05:38:36,443 DEBUG : BROWSER_OUTPUT: 05:41:38 INFO - 2015-11-24 05:41:38,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:41:39 INFO - 2015-11-24 05:41:39,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 329420800 05:41:39 INFO - 2015-11-24 05:41:39,100 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-24 05:44:42,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:44:42 INFO - 2015-11-24 05:44:42,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 326946816 05:44:42 INFO - 2015-11-24 05:44:42,787 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:47:45 INFO - 2015-11-24 05:47:45,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 414568448 05:47:45 INFO - 2015-11-24 05:47:45,844 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,845 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:47:45 INFO - 2015-11-24 05:47:45,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:47:45 INFO - 2015-11-24 05:47:45,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:47:45 INFO - 2015-11-24 05:47:45,845 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:47:45 INFO - 2015-11-24 05:47:45,848 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3182.5067114597236;3463.480477928312;3481.9651803481956;3494.650534946504;3526.9294614107716;5618;5692.658440493573;5693.943060569398;5698.544116470688;5733.197352370671;5698.914516282259;5774.682392468423;5778.566607504444;5785.479306862381;5790.363060063401;4617.468991066037;4694.718316900997;5186.818461353853;5206.869828254286;5264.184051472009;5206.401263854648;5229.712365819878;5267.1045922193125;5275.788968441258;5288.0745869472885;5253.212018197263;5264.736763161845;5269.077911365515;5272.235525848769;5273;5118;5182;5217.765200565984;5238.214267859832;5284.4187139414635;4315.4605674290715;5045.672031317989;5145.6398052136365;5148.3564554430695;5156.561692256163;5439.510444060014;5605.859853503654;5657.066584013633;5722.027255366597;5771.249737534135;5781.653100813923;6178.41305076017;6197.87604247917;6200.3179650238435;6231.22109736283;6240;6310.7791227306825;6342.460890824285;6343.429091381798;6350.904736428957;5892.057270836645;5893.764249430061;5894.764209431618;5914.615549989237;5929.911051334234;6199.504039676815;6288.5598008139905;6319.33646967071;6322.936770632235;6352.841178970562;6082.847928801727;6122.123717501779;6142.560166306883;6170.969145154335;6186.350433204539;6327.715252813635;6330.366963303725;6330.588511746721;6342.270638876496;6358.300586935434;6041.24484439445;6236.376362363727;6245.781397651061;6279.466245369194;6289.339619339995;6135.447809697149;6226.346233645492;6234.781782637586;6269.247690277196;6305;4968.577670897942;4979.751012449363;4987.925181122286;4990.975045124751;5015.84952451427;4463.575960283768;4464.464264288241;4470.217711900469;4497.617702495325;4519.0058187198765;5529.060059789846;5593.244911936918;5649.745761440745;5652;5665.858353541194;6130.734471166852;6200.844978875474;6232.626042437469;6280.089387038854;6281.8743625127245;5755.050416681284;5765.1640512125505;5765.8558536036935;5787.884242315215;5815.389384114692;5208.817691380859;5430.945690543044;5437.184422336682;5437.45625437461;5448.673079615236;5308.840734777963;6184.381561843779;6298.433141017331;6304.653244071436;6331.778387756499;6279.026750853625;6314.905276420765;6323.114763933145;6324.30432652417;6360.427561519486;6196.318404975359;6312.337204593451;6329.683515824098;6332.588381755171;6359.682015899094;6097.75608975636;6135.386461353829;6160.630362178284;6165.383461653799;6182.103594978613;6313.684315784284;6316.3683631638305;6319.3364696706185;6333.778317758856;6352.396522330371;5880.588358814842;6182.690865456799;6197.411245931629;6198.039303907902;6200.844978875564;5131.717755523482;6056.242969628796;6105.328413874381;6131.601445906002;6140.232470941132;5944.227250457413;5988.760449581968;5988.940110598838;5996.070609055603;6007.459328660441;5087.728018291109;6050.739789314397;6101.572889897665;6109.236345456818;6131.448169664752;5971.7611295547695;5981.850453738692;6000.399960003964;6004.219451471281;6005.339412664691 05:47:45 INFO - 2015-11-24 05:47:45,849 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.5331095224534;569.8233547600242;582.3594046548797;633.6451587111216;642.2197030607811;26660.600090998625;42115.94710132248;42597.7870110649;42760.572394276045;42760.57239427609;45164;45357.54642453574;45435;45470.545294547046;45576.86057848555;8848.867266990968;8948.686795962143;9748.171405430528;9914.454704991258;9919.752006199868;8810.691625793099;12089.879101208964;12161.452734626919;12174.634760957186;12176.208546444454;11835.881641183563;11910;11916.285022898654;11916.642500724993;11918.880811191908;8826.691065812665;8926.419782714167;11847.644570662851;11919.702007449796;11919.821202681967;8741.388102832805;8888.377813553054;8895.510746908918;11956.641300760992;12056.578019769266;41806.581934180875;42176;42205;42235.7888210557;42314.576854231374;3220.3237320162793;3234.498652708834;3284.835758212104;3393.372226138172;3819.5607505136986;29501.11496655104;29883.850580747174;30300.848495757382;30456.086317410514;31106;2762.958555621667;2768.8754006069776;2795.049683107733;2881.121258016304;2931.5016447204025;482375;484015;484476;484659;484685;70431.94352084723;70763.2923670767;70980.64509677418;70987;71008;74523;74767.62616186994;74846.6257668719;74909;75063;16177;16650.333986640642;16687;16766.245518951677;16790.32838686439;12532.937335313265;12602.55891043809;12611.180273282207;12628.494860205672;12629.621111366674;21604.45988850291;21876.89061554682;21968.89015554912;22010.779892200873;22016.899155042505;9054.275657947348;9246.90753092474;9259.675911343205;9288.767780805534;9317.580708868118;941.6421759731395;965.9275554333453;970.4904924914335;1059.5496913811598;1070.4540684250933;24734.25797226086;29057;29157.708422915923;29766.40467190644;29785.85107074451;967.666155176463;1013.8681971343678;1018.221060888421;1056.6988408303596;1151.3840095548842;14465.638359041108;14476.420943162366;14660.193689347188;14784.334704938303;14809.703805923822;527715.7228427744;528725;529024;530627.346863271;537725;51457.48542514602;59902;60287.69856150779;60356;60604.69697651572;1412.4420853762706;1447.3631602095254;1456.621278467585;1465.1062851660265;1466.288849907794;27995.44009119847;29458.558121628623;30632;30715.846420767753;30802.69197308088;55014.899702006536;55531.722341388035;55621.72189139028;55675.44324556865;55745.721271393384;398399;405718;405821;406292;406560;31635.050948471584;32008;32257.67742322547;32303.35393292168;32339.191520211243;45898.54101458943;46344.84137896579;46842.76578617221;47232.81917952079;47242.29136563023;38240.61759382371;38538.229235415696;39329.016774580865;39349.2130157401;39899.20201595894;37459;38137;38494.230115398095;38502.80748596239;38599.0350241235;37933;38280.08599570066;38580.80709596434;38664.226715466095;38714.032149195365;31888.043358699277;34216.34210395956;34330.48504272488;34570.790022349094;34621;25107.372315691522;25110.246692599252;25147.371315717253;25416.364590885376;25792 05:47:45 INFO - 2015-11-24 05:47:45,851 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.45542503107794;360.4125275800446;366.14322485384196;367.80690137677715;372.81731951343835;15710.978786378877;17329.74005389917;19643.607127857453;20434.59130817383;21067.367978960618;11142;11377.829332559997;11379;14299.285035748224;18837.246510139612;3986.581408952062;5198.45416231296;5340.332458442695;5350.0904846176245;5356.437574054727;4078.3066878630702;4116.361963895601;5789.247397838296;5944.256967879015;5947.40525947404;5844.357120716718;5851.327097383792;5899.557533185007;5917.082852157901;6123.448889599935;6474.320196379383;6516.543841931067;6527.0209468579615;6531.7387304507765;6536;5582.218489411485;5631.63394379364;5722.084466485342;5726.856828579277;5733.140028995684;13181.011424143227;13195.802062969064;13242.53651122206;20758.546901716887;25651.10221142251;1705.266735303819;2022.2618744158276;2034.5138968574258;2039.6022775558772;2073.554185850034;9668.75828104296;10862.837057444145;12073.792620737944;14713.55859324222;14982;1687.4178408449188;1706.650136721969;1715.4682048564985;1738.3133662203359;1750.4311098892783;100491;104771.47614261956;105155.47422262993;105242.94757052408;105391.94608053898;8882.245009174292;11014.669559913216;11059.22585419029;11068.225224234387;11080.002799747901;13287.269200193889;13346.532871349651;13349.933250333686;13352.599422017354;13360.198388096745;8108.513489190667;8242.134575869568;8261.793455163548;8291.58542072906;8314.750557483285;8313.501189928624;8317.792055198668;8366.539840308842;8399.286060684788;8402.159784021549;4078.979605102015;4303.505096913895;4350.608445239944;4362.214801335726;4409.536998615164;1762.903040332794;1808.5297822566229;1812.3928483958023;1843.3640394064028;1924.3264857300112;333.8097284547833;793.888855560222;951.3150531617224;1015.9542820573092;1025.0620682075967;8351.3736469765;10899.346039237671;11217.3830439325;11274.661760147208;11402.087832973342;425.2749062847899;435.63842011131317;437.58866665334483;804.7746630943345;895.9920089898864;5202.635815492879;10417.5832966682;10704.411257380763;10726.570937162582;10756.139508839275;733568;735009;778507;783981;798987;86743.13256867477;104391;118512;120051;125560.37219813843;1046.2414749306845;1166.632510759108;1167.229628445222;1181.2440038375446;1201.8197270409335;17725.556861078578;17839;17947.461576152735;17979.73030404571;18049.458516244533;49769;50005.49983500501;50285.24572131494;50378;50411.74794126006;67618.66190669015;69063.61872762415;69876;69912.60174796374;71710;9409.247260219303;9536.758861667364;9878.4566848824;9997.900020999698;10009.449480278654;11728.12039097054;11845.46695398692;15712.528624141294;20103;20222.907752015242;15738.213089345716;15765.132917689638;15797.842021579638;16208.270627821541;16350.937189082671;14982.400703972155;15276.770848437505;15435.922820385826;15466.458673946358;16202.756958645394;12865.614031579067;13568;14554.12675239489;15970.680586387974;16130.951488153232;9132.49771262587;9354.766130846783;9376.859347109663;9391.624335026523;9415.05849415053;9688.370255933341;15028.248587570797;15158.014729042578;15312.464063757716;15501.689966200838 05:47:45 INFO - 2015-11-24 05:47:45,855 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1280.9551665691702;1560.7190705672974;1561.593985563754;1891.883788564747;1910.8184722451367;7748.728794492194;8024.598770061495;8219.095899451055;8571.614277357517;8584.699535516258;8298.045724741656;8399.580020998941;8456.027556830966;8474.449160804543;8477.533735644538;2134.8185404240658;2174.63031284682;2369.3247424484025;2392.2823153054014;2393.365758074112;2196.923107691231;2199.3841724317135;2371.7509661485556;2411.8914648840755;2412.3366074329524;2342.344143639775;2355.8115350771895;2381.5117900830373;2386.296042667417;2388.868612226327;2129.882856442895;2180.574787916357;2368.9289321320302;2392.820538459614;2395.0898658509655;2185.650295952656;2193.6928829963817;2194.133317339642;2196.198387588535;2378.2746262389965;8212.794680132985;8309.37679674027;8314.958425207835;8325.458845175044;8336.333093352518;5094.617903657204;5151.381834179922;5157.252198431244;5190.92213616796;5194.246834209056;3479.2171761353748;3557.3596752584526;3601.8559257629927;3637.563492380905;3645.6536629020466;1033.7984093101848;1047.2721458586286;1051.905586511792;1062.8299472084507;1080.9028835731738;10921.781564368748;11028.889711102947;11070.059044981266;11086.22396432242;11103.777924441465;4655.231886738718;4666.113438446684;4726.267428548512;4735.644826638016;4742.5731684148595;9814.9018509814;9827.262955278382;9828.361156524947;9858.654947076819;9865.506724663737;5188.714620695822;5190.870228244248;5220.269162317279;5228.660137091077;5248.947510524922;4686.789094490756;4692.319613656001;4699.506551812079;4722.220833562424;4724.622030237572;3656.3966945454235;3744.213715119801;3759.6992240620684;3760.6239376062176;3784.564775050849;1199.91600587958;1238.5665017243894;1240.2806372304042;1247.7941139712027;1250.1374051904338;1356.5184359552413;1370.4792178971927;1392.7701929181571;1393.6724869655623;1394.4352537222442;7791.4935529190425;7927.762167134995;7941.166177551389;7952.005999250094;7953.602319883983;495.3461430911163;501.9949800502021;507.56603104345993;508.83208541181324;510.1302279613325;4841.540053694894;6165.951788196017;6174.351693072253;6232.56372053961;6253.6873156342;9272.211861991806;10128.442935638463;10206.387616743019;10216.387016779017;10216.744581385525;9840.212782977345;10039.849402258971;10070.899291006996;10112.443815590066;10113.747156321004;7896.131425543185;7977.401694872908;7995.680172793023;8041.356691464669;8055.355571554144;7489.70041198346;7867.645955931882;7885.5662938538935;7886.211378862068;7901.209879012053;8896.955515222382;9025.007249202452;9041.728748137566;9053.637854485747;9070.863937040818;7796.9220307796195;9006.594703238501;9272.350935434455;9314.48770317639;9420.95289523548;6883.862322753416;7302.160251570925;7375.631218439164;7380.483366164317;7414.8887766682465;8055.154208808225;8056.234657707509;8057.959710201411;8068.07217170033;8082;7421.109466864011;7482.401407887465;7496.850062998818;7621.809454763676;7686.884696729442;7135.108111486064;7327.963360183165;7346.77959661211;7419.554826710415;7475.177730449537;7439.9256007439235;7453.664585093576;7455;7491.550506969599;7503.287187717158;6748.257691654012;6805.591664500146;6850.588964662136;6857.55425897315;6861.622610756257;6892;6946.37482626566;6948.235694073547;6954.860902782018;6959.8608027838145 05:47:45 INFO - 2015-11-24 05:47:45,855 DEBUG : BROWSER_OUTPUT: |4;prototype.html;324.5829109594172;327.51527738946356;333.07903646417674;335.966403359664;336.53558089836037;6696.5982041077505;6715.059891615166;6763.695633696483;6794.524383293171;6803.897941530881;5880.500157486619;6222.439980401763;6694.364035416627;6726.293739157391;6726.562773419724;4774.641901857357;4933.309336692857;4938.925916111261;4941.77762000709;4945.802167913279;4905.190643543829;4923.384576927884;4930.876728081808;4942.3327850740225;4973.403191617011;4870.951290487085;4874.878128046809;4877.34155888954;4886.315915771795;4890.364252647151;4623.907521849578;4718.41019872516;4735.408073990751;4887.193613053842;4894.755262236892;4101.876943691665;4144.378343248507;4191;4205.285101532747;4232.809523571416;6416.165898433221;6444.581102228341;6448.322926092739;6449.516286278501;6471.935280647227;5508.256385387961;5574.219609254667;5707.62900411476;5710.029295019815;5876.823695289148;7099.6450177490915;7220.566765994057;7238.601876896769;7243.637818109073;7261.927380726231;4755;4755.667103302771;4756.28655701644;4756.809727610891;4763.49983251757;7433.368163706037;7637.847243055107;7657.387409007266;7663.885041724323;7677.270659287359;4676.859694209179;4692.272697731857;4705.058988202373;4707.270373092176;4715.481297057321;4761.452432970253;4793.945332026949;4794.161021821237;4799.208130658472;4803.879903002383;5730.169125476866;5733.971330143323;5742.368339482654;5749.712514374264;5751.798687045934;7013.719451221996;7261.164966028974;7268.164161121539;7299;7322.524035937647;1489.4265707702396;1643.0388222889505;1665.9750103748454;1666.6833301672643;1668.115898573758;976.2141476111798;1041.6146025970288;1063.4788953412772;1064.5635289531256;1067;6732.091167692397;6751.831204219934;6752.3922846944015;6758.560693554903;6784.559003664746;7496.0255166827965;7504.662290196954;7508.849823003618;7514.4364172687265;7528.924710752932;6521.739130434825;6724.193096828314;6728.529002969843;6738.258791532928;6739.696713647898;3871;3963.8018099095507;3974.344233201547;3975.5626881043063;4021.8994525136522;7707.730229442055;7876.803079923047;7925.207479252144;7933.286004259644;7944.721934732257;7786.688532458638;7824.37405007598;7872.448928574945;7896.249856263646;7907.525548466995;7663.19536448676;7890.921090789134;7898.170692077364;7908.051033875971;7918.129005809241;6115.938840611537;6161.815145545641;6618.569792963442;7595.658195381332;7610.429217808797;5633.802816901389;7153.284671532805;7482.925170748223;7483.775486735407;7495.287947644965;7844.21557844211;7860.410469214946;7869.213078692085;7872.409569282212;7889.250521200477;4842;4898.53463920927;4901.289313049517;4902.632302577393;4905.632077594123;6028;7236.782896513113;7451.733205355211;7452.403807695479;7483.70065197386;7171.067761191011;7173.318534739192;7181.533200341961;7197.820054498679;7207.243239459781;7163.820904477429;7172.103487064117;7173.246809084971;7173.497855150298;7193.064901562763;6779.322067793181;7006.789796306119;7076.646167691698;7084.079069720903;7091.219965803861;7222.399936023133;7224.205337412775;7228.096487939008;7231.5299505531975;7234.6744396501235;6959.756408525677;7062;7064.788056358112;7071.36357727807;7082.610456424946 05:47:45 INFO - 2015-11-24 05:47:45,856 DEBUG : BROWSER_OUTPUT: |5;yui.html;709.7835160276115;750.782273140789;762.8321769210775;814.4502460838936;820.429801288105;10728.678139655804;12189.878101218985;12207.816882746765;12211.633650990485;12235.755284894296;14171.716565668681;14356.425742970294;14368.066075705097;14378.784318235208;14389.496367627135;754.1628792040831;768.2931702833407;768.561919705768;949.1268033409245;962.8315044867155;959.0074273127315;959.4818797849153;972.1153750087421;975.1467465967279;977.1938151025397;1012.306569999549;1033.0702367868903;1033.0908800255766;1033.7829055898271;1035.321864178964;800.2997377294867;813.1908750792969;815.3314282288526;1002.6240159940022;1025.656405104291;759.2748924776824;764.2090436398302;765.1239330966068;765.7779244019227;767.8464307138595;14952.850471495363;15116.697666046728;15189.696206075927;15209.695806083817;15254.161021143833;12393.194442361219;12641.241525508407;12663.430145643468;12893.161944473579;12990.870091299155;9827.459489728062;10080.596776128947;10089.798204035951;10097.495125243708;10103.19174466041;3519.4896739972814;3547.94678079829;3558.6441355864467;3560.092176495003;3560.964390356089;77130.61434692847;78611;79247.81128283081;79303.60348198279;79624.40751185002;9523.571564208334;9547.42715437076;9583.329166958247;9621.470819105016;9911.454869982075;21465.141394344053;21736.13055477795;21741.78258217429;21748.565028699337;21776.673349899764;6120.816375508742;7146.071010768567;7220.133583969957;7433.628318584158;7469.626518674045;3896.3571010782903;3929.960700393017;3936.3308237599676;3945.9408108877815;4051.858184963512;3036.59006034187;3552.87564935226;3566.037169964147;3572.91067723309;3608.891733248007;641.6022066318819;650.2716957008181;655.2890114226022;677.1738479055545;677.4377266868487;507.21128644956707;524.090702630935;552.9917051244234;610.2676787854592;619.5322531488697;8475.703350382708;8843.778905527284;8936.642534298555;9086.954565227265;9697.321187516947;500.65955150498013;503.2702581257192;519.9272101905736;582.033823852403;594.4234092929851;3328.4341661917533;3918.529776426847;3946.1713040261293;4052.7365721228616;4148.357004664282;98912.01087989172;102226;102964.42588935187;104054;104452;85663;86275.56862215648;86827.13172868316;87489.12510874809;88190;72314.63842680753;72671.27328726751;72853.27146728571;75591.62204188944;75813;8260.096672392625;8465.322774178174;8569.314454843723;8960.283177345927;9100.45397276139;51547;52145.7392713034;52826.73586632042;54070.91858162893;54843;68504.6574767123;69735.65132174306;71144.28855711376;71456.64271678608;75283;11123.83314250303;11159.38623375722;11279.436028198394;11397.715057123638;11561.942190289332;10155.339902906288;12415.875841241472;12543.372831358212;12550.748985020065;13175.934120329337;11478.598249061242;11489.195756296978;11593;11977.760444791229;12428.316442595382;11233.66299011031;11696.47365868555;12021.939890300842;12022.27866328023;12406.689832754253;11075.335479871233;11802.82295765547;11809.11431642613;11810.881891181321;12478.87521124777;9549;9727.509817440672;9774.218062554837;9782.315237933277;10414.791704165722;9224.38113402478;9259;10083.445410502492;10101.747456313651;10124.949375253076 05:47:45 INFO - 2015-11-24 05:47:45,856 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,2104 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: __startTimestamp1448372865844__endTimestamp 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,857 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5738.37 Median:5981.85 stddev:652.63 (10.9%) stddev-sans-first:623.07 05:47:45 INFO - 2015-11-24 05:47:45,859 DEBUG : BROWSER_OUTPUT: Values: 3182.5 3463.5 3482.0 3494.7 3526.9 5618.0 5692.7 5693.9 5698.5 5733.2 5698.9 5774.7 5778.6 5785.5 5790.4 4617.5 4694.7 5186.8 5206.9 5264.2 5206.4 5229.7 5267.1 5275.8 5288.1 5253.2 5264.7 5269.1 5272.2 5273.0 5118.0 5182.0 5217.8 5238.2 5284.4 4315.5 5045.7 5145.6 5148.4 5156.6 5439.5 5605.9 5657.1 5722.0 5771.2 5781.7 6178.4 6197.9 6200.3 6231.2 6240.0 6310.8 6342.5 6343.4 6350.9 5892.1 5893.8 5894.8 5914.6 5929.9 6199.5 6288.6 6319.3 6322.9 6352.8 6082.8 6122.1 6142.6 6171.0 6186.4 6327.7 6330.4 6330.6 6342.3 6358.3 6041.2 6236.4 6245.8 6279.5 6289.3 6135.4 6226.3 6234.8 6269.2 6305.0 4968.6 4979.8 4987.9 4991.0 5015.8 4463.6 4464.5 4470.2 4497.6 4519.0 5529.1 5593.2 5649.7 5652.0 5665.9 6130.7 6200.8 6232.6 6280.1 6281.9 5755.1 5765.2 5765.9 5787.9 5815.4 5208.8 5430.9 5437.2 5437.5 5448.7 5308.8 6184.4 6298.4 6304.7 6331.8 6279.0 6314.9 6323.1 6324.3 6360.4 6196.3 6312.3 6329.7 6332.6 6359.7 6097.8 6135.4 6160.6 6165.4 6182.1 6313.7 6316.4 6319.3 6333.8 6352.4 5880.6 6182.7 6197.4 6198.0 6200.8 5131.7 6056.2 6105.3 6131.6 6140.2 5944.2 5988.8 5988.9 5996.1 6007.5 5087.7 6050.7 6101.6 6109.2 6131.4 5971.8 5981.9 6000.4 6004.2 6005.3 05:47:45 INFO - 2015-11-24 05:47:45,859 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,859 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63539.07 Median:38387.16 stddev:126275.21 (329.0%) stddev-sans-first:126540.89 05:47:45 INFO - 2015-11-24 05:47:45,860 DEBUG : BROWSER_OUTPUT: Values: 552.5 569.8 582.4 633.6 642.2 26660.6 42115.9 42597.8 42760.6 42760.6 45164.0 45357.5 45435.0 45470.5 45576.9 8848.9 8948.7 9748.2 9914.5 9919.8 8810.7 12089.9 12161.5 12174.6 12176.2 11835.9 11910.0 11916.3 11916.6 11918.9 8826.7 8926.4 11847.6 11919.7 11919.8 8741.4 8888.4 8895.5 11956.6 12056.6 41806.6 42176.0 42205.0 42235.8 42314.6 3220.3 3234.5 3284.8 3393.4 3819.6 29501.1 29883.9 30300.8 30456.1 31106.0 2763.0 2768.9 2795.0 2881.1 2931.5 482375.0 484015.0 484476.0 484659.0 484685.0 70431.9 70763.3 70980.6 70987.0 71008.0 74523.0 74767.6 74846.6 74909.0 75063.0 16177.0 16650.3 16687.0 16766.2 16790.3 12532.9 12602.6 12611.2 12628.5 12629.6 21604.5 21876.9 21968.9 22010.8 22016.9 9054.3 9246.9 9259.7 9288.8 9317.6 941.6 965.9 970.5 1059.5 1070.5 24734.3 29057.0 29157.7 29766.4 29785.9 967.7 1013.9 1018.2 1056.7 1151.4 14465.6 14476.4 14660.2 14784.3 14809.7 527715.7 528725.0 529024.0 530627.3 537725.0 51457.5 59902.0 60287.7 60356.0 60604.7 1412.4 1447.4 1456.6 1465.1 1466.3 27995.4 29458.6 30632.0 30715.8 30802.7 55014.9 55531.7 55621.7 55675.4 55745.7 398399.0 405718.0 405821.0 406292.0 406560.0 31635.1 32008.0 32257.7 32303.4 32339.2 45898.5 46344.8 46842.8 47232.8 47242.3 38240.6 38538.2 39329.0 39349.2 39899.2 37459.0 38137.0 38494.2 38502.8 38599.0 37933.0 38280.1 38580.8 38664.2 38714.0 31888.0 34216.3 34330.5 34570.8 34621.0 25107.4 25110.2 25147.4 25416.4 25792.0 05:47:45 INFO - 2015-11-24 05:47:45,860 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,860 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38277.43 Median:2037.06 stddev:126076.60 (6189.2%) stddev-sans-first:126398.12 05:47:45 INFO - 2015-11-24 05:47:45,862 DEBUG : BROWSER_OUTPUT: Values: 359.5 360.4 366.1 367.8 372.8 15711.0 17329.7 19643.6 20434.6 21067.4 11142.0 11377.8 11379.0 14299.3 18837.2 3986.6 5198.5 5340.3 5350.1 5356.4 4078.3 4116.4 5789.2 5944.3 5947.4 5844.4 5851.3 5899.6 5917.1 6123.4 6474.3 6516.5 6527.0 6531.7 6536.0 5582.2 5631.6 5722.1 5726.9 5733.1 13181.0 13195.8 13242.5 20758.5 25651.1 1705.3 2022.3 2034.5 2039.6 2073.6 9668.8 10862.8 12073.8 14713.6 14982.0 1687.4 1706.7 1715.5 1738.3 1750.4 100491.0 104771.5 105155.5 105242.9 105391.9 8882.2 11014.7 11059.2 11068.2 11080.0 13287.3 13346.5 13349.9 13352.6 13360.2 8108.5 8242.1 8261.8 8291.6 8314.8 8313.5 8317.8 8366.5 8399.3 8402.2 4079.0 4303.5 4350.6 4362.2 4409.5 1762.9 1808.5 1812.4 1843.4 1924.3 333.8 793.9 951.3 1016.0 1025.1 8351.4 10899.3 11217.4 11274.7 11402.1 425.3 435.6 437.6 804.8 896.0 5202.6 10417.6 10704.4 10726.6 10756.1 733568.0 735009.0 778507.0 783981.0 798987.0 86743.1 104391.0 118512.0 120051.0 125560.4 1046.2 1166.6 1167.2 1181.2 1201.8 17725.6 17839.0 17947.5 17979.7 18049.5 49769.0 50005.5 50285.2 50378.0 50411.7 67618.7 69063.6 69876.0 69912.6 71710.0 9409.2 9536.8 9878.5 9997.9 10009.4 11728.1 11845.5 15712.5 20103.0 20222.9 15738.2 15765.1 15797.8 16208.3 16350.9 14982.4 15276.8 15435.9 15466.5 16202.8 12865.6 13568.0 14554.1 15970.7 16131.0 9132.5 9354.8 9376.9 9391.6 9415.1 9688.4 15028.2 15158.0 15312.5 15501.7 05:47:45 INFO - 2015-11-24 05:47:45,862 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,862 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5816.26 Median:5207.26 stddev:3049.01 (58.6%) stddev-sans-first:3038.50 05:47:45 INFO - 2015-11-24 05:47:45,862 DEBUG : BROWSER_OUTPUT: Values: 1281.0 1560.7 1561.6 1891.9 1910.8 7748.7 8024.6 8219.1 8571.6 8584.7 8298.0 8399.6 8456.0 8474.4 8477.5 2134.8 2174.6 2369.3 2392.3 2393.4 2196.9 2199.4 2371.8 2411.9 2412.3 2342.3 2355.8 2381.5 2386.3 2388.9 2129.9 2180.6 2368.9 2392.8 2395.1 2185.7 2193.7 2194.1 2196.2 2378.3 8212.8 8309.4 8315.0 8325.5 8336.3 5094.6 5151.4 5157.3 5190.9 5194.2 3479.2 3557.4 3601.9 3637.6 3645.7 1033.8 1047.3 1051.9 1062.8 1080.9 10921.8 11028.9 11070.1 11086.2 11103.8 4655.2 4666.1 4726.3 4735.6 4742.6 9814.9 9827.3 9828.4 9858.7 9865.5 5188.7 5190.9 5220.3 5228.7 5248.9 4686.8 4692.3 4699.5 4722.2 4724.6 3656.4 3744.2 3759.7 3760.6 3784.6 1199.9 1238.6 1240.3 1247.8 1250.1 1356.5 1370.5 1392.8 1393.7 1394.4 7791.5 7927.8 7941.2 7952.0 7953.6 495.3 502.0 507.6 508.8 510.1 4841.5 6166.0 6174.4 6232.6 6253.7 9272.2 10128.4 10206.4 10216.4 10216.7 9840.2 10039.8 10070.9 10112.4 10113.7 7896.1 7977.4 7995.7 8041.4 8055.4 7489.7 7867.6 7885.6 7886.2 7901.2 8897.0 9025.0 9041.7 9053.6 9070.9 7796.9 9006.6 9272.4 9314.5 9421.0 6883.9 7302.2 7375.6 7380.5 7414.9 8055.2 8056.2 8058.0 8068.1 8082.0 7421.1 7482.4 7496.9 7621.8 7686.9 7135.1 7328.0 7346.8 7419.6 7475.2 7439.9 7453.7 7455.0 7491.6 7503.3 6748.3 6805.6 6850.6 6857.6 6861.6 6892.0 6946.4 6948.2 6954.9 6959.9 05:47:45 INFO - 2015-11-24 05:47:45,862 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,862 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5887.69 Median:6725.24 stddev:1896.97 (28.2%) stddev-sans-first:1855.77 05:47:45 INFO - 2015-11-24 05:47:45,864 DEBUG : BROWSER_OUTPUT: Values: 324.6 327.5 333.1 336.0 336.5 6696.6 6715.1 6763.7 6794.5 6803.9 5880.5 6222.4 6694.4 6726.3 6726.6 4774.6 4933.3 4938.9 4941.8 4945.8 4905.2 4923.4 4930.9 4942.3 4973.4 4871.0 4874.9 4877.3 4886.3 4890.4 4623.9 4718.4 4735.4 4887.2 4894.8 4101.9 4144.4 4191.0 4205.3 4232.8 6416.2 6444.6 6448.3 6449.5 6471.9 5508.3 5574.2 5707.6 5710.0 5876.8 7099.6 7220.6 7238.6 7243.6 7261.9 4755.0 4755.7 4756.3 4756.8 4763.5 7433.4 7637.8 7657.4 7663.9 7677.3 4676.9 4692.3 4705.1 4707.3 4715.5 4761.5 4793.9 4794.2 4799.2 4803.9 5730.2 5734.0 5742.4 5749.7 5751.8 7013.7 7261.2 7268.2 7299.0 7322.5 1489.4 1643.0 1666.0 1666.7 1668.1 976.2 1041.6 1063.5 1064.6 1067.0 6732.1 6751.8 6752.4 6758.6 6784.6 7496.0 7504.7 7508.8 7514.4 7528.9 6521.7 6724.2 6728.5 6738.3 6739.7 3871.0 3963.8 3974.3 3975.6 4021.9 7707.7 7876.8 7925.2 7933.3 7944.7 7786.7 7824.4 7872.4 7896.2 7907.5 7663.2 7890.9 7898.2 7908.1 7918.1 6115.9 6161.8 6618.6 7595.7 7610.4 5633.8 7153.3 7482.9 7483.8 7495.3 7844.2 7860.4 7869.2 7872.4 7889.3 4842.0 4898.5 4901.3 4902.6 4905.6 6028.0 7236.8 7451.7 7452.4 7483.7 7171.1 7173.3 7181.5 7197.8 7207.2 7163.8 7172.1 7173.2 7173.5 7193.1 6779.3 7006.8 7076.6 7084.1 7091.2 7222.4 7224.2 7228.1 7231.5 7234.7 6959.8 7062.0 7064.8 7071.4 7082.6 05:47:45 INFO - 2015-11-24 05:47:45,864 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-24 05:47:45,864 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19083.73 Median:505.24 stddev:27501.27 (5443.2%) stddev-sans-first:27543.82 05:47:45 INFO - 2015-11-24 05:47:45,865 DEBUG : BROWSER_OUTPUT: Values: 709.8 750.8 762.8 814.5 820.4 10728.7 12189.9 12207.8 12211.6 12235.8 14171.7 14356.4 14368.1 14378.8 14389.5 754.2 768.3 768.6 949.1 962.8 959.0 959.5 972.1 975.1 977.2 1012.3 1033.1 1033.1 1033.8 1035.3 800.3 813.2 815.3 1002.6 1025.7 759.3 764.2 765.1 765.8 767.8 14952.9 15116.7 15189.7 15209.7 15254.2 12393.2 12641.2 12663.4 12893.2 12990.9 9827.5 10080.6 10089.8 10097.5 10103.2 3519.5 3547.9 3558.6 3560.1 3561.0 77130.6 78611.0 79247.8 79303.6 79624.4 9523.6 9547.4 9583.3 9621.5 9911.5 21465.1 21736.1 21741.8 21748.6 21776.7 6120.8 7146.1 7220.1 7433.6 7469.6 3896.4 3930.0 3936.3 3945.9 4051.9 3036.6 3552.9 3566.0 3572.9 3608.9 641.6 650.3 655.3 677.2 677.4 507.2 524.1 553.0 610.3 619.5 8475.7 8843.8 8936.6 9087.0 9697.3 500.7 503.3 519.9 582.0 594.4 3328.4 3918.5 3946.2 4052.7 4148.4 98912.0 102226.0 102964.4 104054.0 104452.0 85663.0 86275.6 86827.1 87489.1 88190.0 72314.6 72671.3 72853.3 75591.6 75813.0 8260.1 8465.3 8569.3 8960.3 9100.5 51547.0 52145.7 52826.7 54070.9 54843.0 68504.7 69735.7 71144.3 71456.6 75283.0 11123.8 11159.4 11279.4 11397.7 11561.9 10155.3 12415.9 12543.4 12550.7 13175.9 11478.6 11489.2 11593.0 11977.8 12428.3 11233.7 11696.5 12021.9 12022.3 12406.7 11075.3 11802.8 11809.1 11810.9 12478.9 9549.0 9727.5 9774.2 9782.3 10414.8 9224.4 9259.0 10083.4 10101.7 10124.9 05:47:45 INFO - 2015-11-24 05:47:45,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:47:45 INFO - 2015-11-24 05:47:45,866 DEBUG : BROWSER_OUTPUT: 05:47:46 INFO - 2015-11-24 05:47:46,378 INFO : Browser exited with error code: 0 05:47:46 INFO - 2015-11-24 05:47:46,402 INFO : Completed test dromaeo_css (00:18:34) 05:47:46 INFO - 2015-11-24 05:47:46,402 INFO : Starting test kraken 05:47:46 INFO - 2015-11-24 05:47:46,402 DEBUG : operating with platform_type : mac_ 05:47:46 INFO - 2015-11-24 05:47:46,402 INFO : Initialising browser for kraken test... 05:47:46 INFO - 2015-11-24 05:47:46,415 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpu6fOI4/profile http://localhost:49274/getInfo.html 05:47:48 INFO - 2015-11-24 05:47:48,569 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:47:48 INFO - 2015-11-24 05:47:48,569 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:47:48 INFO - 2015-11-24 05:47:48,569 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:47:48 INFO - 2015-11-24 05:47:48,569 DEBUG : BROWSER_OUTPUT: __metrics 05:47:48 INFO - 2015-11-24 05:47:48,587 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:49 INFO - 2015-11-24 05:47:49,219 INFO : Browser initialized. 05:47:49 INFO - 2015-11-24 05:47:49,220 INFO : Running cycle 1/1 for kraken test... 05:47:49 INFO - 2015-11-24 05:47:49,220 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpu6fOI4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:48:01 INFO - 2015-11-24 05:48:01,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 227110912 05:48:01 INFO - 2015-11-24 05:48:01,125 DEBUG : BROWSER_OUTPUT: 05:48:03 INFO - 2015-11-24 05:48:03,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:04 INFO - 2015-11-24 05:48:04,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 276377600 05:48:04 INFO - 2015-11-24 05:48:04,266 DEBUG : BROWSER_OUTPUT: 05:48:06 INFO - 2015-11-24 05:48:06,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:48:07 INFO - 2015-11-24 05:48:07,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 290295808 05:48:07 INFO - 2015-11-24 05:48:07,402 DEBUG : BROWSER_OUTPUT: 05:48:10 INFO - 2015-11-24 05:48:10,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:48:11 INFO - 2015-11-24 05:48:11,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 276283392 05:48:11 INFO - 2015-11-24 05:48:11,197 DEBUG : BROWSER_OUTPUT: 05:48:13 INFO - 2015-11-24 05:48:13,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:48:13 INFO - 2015-11-24 05:48:13,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 278454272 05:48:13 INFO - 2015-11-24 05:48:13,690 DEBUG : BROWSER_OUTPUT: 05:48:15 INFO - 2015-11-24 05:48:15,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:16 INFO - 2015-11-24 05:48:16,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 278974464 05:48:16 INFO - 2015-11-24 05:48:16,416 DEBUG : BROWSER_OUTPUT: 05:48:19 INFO - 2015-11-24 05:48:19,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:19 INFO - 2015-11-24 05:48:19,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 279777280 05:48:19 INFO - 2015-11-24 05:48:19,702 DEBUG : BROWSER_OUTPUT: 05:48:22 INFO - 2015-11-24 05:48:22,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:23 INFO - 2015-11-24 05:48:23,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 280207360 05:48:23 INFO - 2015-11-24 05:48:23,065 DEBUG : BROWSER_OUTPUT: 05:48:25 INFO - 2015-11-24 05:48:25,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:48:26 INFO - 2015-11-24 05:48:26,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 280600576 05:48:26 INFO - 2015-11-24 05:48:26,484 DEBUG : BROWSER_OUTPUT: 05:48:28 INFO - 2015-11-24 05:48:28,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:28 INFO - 2015-11-24 05:48:28,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 314376192 05:48:28 INFO - 2015-11-24 05:48:28,654 DEBUG : BROWSER_OUTPUT: 05:48:30 INFO - 2015-11-24 05:48:30,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:31 INFO - 2015-11-24 05:48:31,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 316182528 05:48:31 INFO - 2015-11-24 05:48:31,066 DEBUG : BROWSER_OUTPUT: 05:48:33 INFO - 2015-11-24 05:48:33,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:33 INFO - 2015-11-24 05:48:33,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 322752512 05:48:33 INFO - 2015-11-24 05:48:33,697 DEBUG : BROWSER_OUTPUT: 05:48:36 INFO - 2015-11-24 05:48:36,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:36 INFO - 2015-11-24 05:48:36,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 322654208 05:48:36 INFO - 2015-11-24 05:48:36,844 DEBUG : BROWSER_OUTPUT: 05:48:39 INFO - 2015-11-24 05:48:39,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:39 INFO - 2015-11-24 05:48:39,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 322572288 05:48:39 INFO - 2015-11-24 05:48:39,963 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:48:41 INFO - 2015-11-24 05:48:41,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 382623744 05:48:41 INFO - 2015-11-24 05:48:41,883 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,883 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:48:41 INFO - 2015-11-24 05:48:41,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:48:41 INFO - 2015-11-24 05:48:41,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:48:41 INFO - 2015-11-24 05:48:41,883 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;110;111;110;97;110;113;119 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;121;143;155;118;147;142;119;156;118 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;184;179;183;185;186;186;185;182;181 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |3;audio-fft;65;67;76;74;58;56;58;72;72;60 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;84;119;76;101;116;145;79;74;106 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;88;87;85;87;87;88;88;89;88 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;94;94;95;93;94;93;93;94;94 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;86;96;140;121;84;84;85;84;84;86 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;54;54;70;81;54;63;53;53 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;63;64;67;66;65;66;69;68 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;83;81;80;83;80;83;83;83;83 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;109;137;120;122;121;116;124;120;126 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;135;143;168;172;128;134;137;135;124 05:48:41 INFO - 2015-11-24 05:48:41,884 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;64;64;65;65;65;65;65;64 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1076 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: __startTimestamp1448372921878__endTimestamp 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:5.83 (5.3%) stddev-sans-first:6.18 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 110.0 111.0 110.0 97.0 110.0 113.0 119.0 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,885 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:136.70 Median:145.00 stddev:15.87 (10.9%) stddev-sans-first:16.30 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: Values: 148.0 121.0 143.0 155.0 118.0 147.0 142.0 119.0 156.0 118.0 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:2.27 (1.2%) stddev-sans-first:2.40 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: Values: 183.0 184.0 179.0 183.0 185.0 186.0 186.0 185.0 182.0 181.0 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:65.80 Median:69.50 stddev:7.47 (10.7%) stddev-sans-first:7.91 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 76.0 74.0 58.0 56.0 58.0 72.0 72.0 60.0 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.60 Median:75.00 stddev:23.10 (30.8%) stddev-sans-first:24.05 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 119.0 76.0 101.0 116.0 145.0 79.0 74.0 106.0 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.07 (1.2%) stddev-sans-first:1.13 05:48:41 INFO - 2015-11-24 05:48:41,886 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 87.0 85.0 87.0 87.0 88.0 88.0 89.0 88.0 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 94.0 95.0 93.0 94.0 93.0 93.0 94.0 94.0 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:84.50 stddev:19.57 (23.2%) stddev-sans-first:20.49 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: Values: 86.0 96.0 140.0 121.0 84.0 84.0 85.0 84.0 84.0 86.0 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:56.50 stddev:9.30 (16.5%) stddev-sans-first:9.82 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 54.0 54.0 70.0 81.0 54.0 63.0 53.0 53.0 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.12 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 64.0 67.0 66.0 65.0 66.0 69.0 68.0 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,887 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:83.00 stddev:1.62 (2.0%) stddev-sans-first:1.36 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: Values: 79.0 83.0 81.0 80.0 83.0 80.0 83.0 83.0 83.0 83.0 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.50 stddev:7.15 (5.9%) stddev-sans-first:7.57 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: Values: 120.0 109.0 137.0 120.0 122.0 121.0 116.0 124.0 120.0 126.0 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:136.00 stddev:16.07 (11.8%) stddev-sans-first:16.90 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 143.0 168.0 172.0 128.0 134.0 137.0 135.0 124.0 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:48:41 INFO - 2015-11-24 05:48:41,888 DEBUG : BROWSER_OUTPUT: 05:48:42 INFO - 2015-11-24 05:48:42,497 INFO : Browser exited with error code: 0 05:48:42 INFO - 2015-11-24 05:48:42,542 INFO : Completed test kraken (00:00:56) 05:48:42 INFO - 2015-11-24 05:48:42,543 INFO : Starting test v8_7 05:48:42 INFO - 2015-11-24 05:48:42,543 DEBUG : operating with platform_type : mac_ 05:48:42 INFO - 2015-11-24 05:48:42,543 INFO : Initialising browser for v8_7 test... 05:48:42 INFO - 2015-11-24 05:48:42,556 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp5tPqCV/profile http://localhost:49274/getInfo.html 05:48:44 INFO - 2015-11-24 05:48:44,531 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:48:44 INFO - 2015-11-24 05:48:44,531 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:48:44 INFO - 2015-11-24 05:48:44,531 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:48:44 INFO - 2015-11-24 05:48:44,531 DEBUG : BROWSER_OUTPUT: __metrics 05:48:44 INFO - 2015-11-24 05:48:44,548 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:44 INFO - 2015-11-24 05:48:44,809 DEBUG : BROWSER_OUTPUT: console.error: 05:48:44 INFO - 2015-11-24 05:48:44,810 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 05:48:44 INFO - 2015-11-24 05:48:44,810 DEBUG : BROWSER_OUTPUT: Stack: 05:48:44 INFO - 2015-11-24 05:48:44,810 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 05:48:44 INFO - 2015-11-24 05:48:44,810 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 05:48:44 INFO - 2015-11-24 05:48:44,811 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:48:44 INFO - 2015-11-24 05:48:44,812 DEBUG : BROWSER_OUTPUT: 05:48:45 INFO - 2015-11-24 05:48:45,210 INFO : Browser initialized. 05:48:45 INFO - 2015-11-24 05:48:45,210 INFO : Running cycle 1/1 for v8_7 test... 05:48:45 INFO - 2015-11-24 05:48:45,210 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp5tPqCV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:48:57 INFO - 2015-11-24 05:48:57,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 226807808 05:48:57 INFO - 2015-11-24 05:48:57,223 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 703401984 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: |0;Richards;174.1250217656277 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.7741935483871 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.88543140028287 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4748.815165876777 05:49:18 INFO - 2015-11-24 05:49:18,940 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1731.833910034602 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: |7;RegExp;31562.5 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: |8;Splay;660.0660066006601 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4522.522522522522 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: __startTimestamp1448372958932__endTimestamp 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.13 Median:174.13 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: Values: 174.1 05:49:18 INFO - 2015-11-24 05:49:18,941 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.77 Median:161.77 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: Values: 161.8 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: Values: 282.9 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4748.82 Median:4748.82 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: Values: 4748.8 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1731.83 Median:1731.83 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: Values: 1731.8 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,942 DEBUG : BROWSER_OUTPUT: Values: 789.9 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: Values: 12268.3 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31562.50 Median:31562.50 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: Values: 31562.5 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:660.07 Median:660.07 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: Values: 660.1 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4522.52 Median:4522.52 stddev:0.00 (0.0%) 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: Values: 4522.5 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:49:18 INFO - 2015-11-24 05:49:18,943 DEBUG : BROWSER_OUTPUT: 05:49:19 INFO - 2015-11-24 05:49:19,698 INFO : Browser exited with error code: 0 05:49:19 INFO - 2015-11-24 05:49:19,717 INFO : Completed test v8_7 (00:00:37) 05:49:19 INFO - 2015-11-24 05:49:19,970 INFO : Completed test suite (00:20:08) 05:49:19 INFO - 2015-11-24 05:49:19,970 DEBUG : Working with test: dromaeo_css 05:49:19 INFO - 2015-11-24 05:49:19,970 DEBUG : Generating results file: dromaeo_css 05:49:19 INFO - 2015-11-24 05:49:19,971 DEBUG : Working with test: kraken 05:49:19 INFO - 2015-11-24 05:49:19,971 DEBUG : Generating results file: kraken 05:49:19 INFO - 2015-11-24 05:49:19,971 INFO : javascript benchmark 05:49:19 INFO - 2015-11-24 05:49:19,972 DEBUG : Working with test: v8_7 05:49:19 INFO - 2015-11-24 05:49:19,972 DEBUG : Generating results file: v8_7 05:49:19 INFO - 2015-11-24 05:49:19,972 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:49:20 INFO - 2015-11-24 05:49:20,024 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 05:49:20 INFO - 2015-11-24 05:49:20,024 DEBUG : process_Request line: dromaeo_css 7564.50 graph.html#tests=[[72,64,59]] 05:49:20 INFO - 2015-11-24 05:49:20,024 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:49:20 INFO - 2015-11-24 05:49:20,049 DEBUG : process_Request line: kraken 1404.00 graph.html#tests=[[232,64,59]] 05:49:20 INFO - 2015-11-24 05:49:20,049 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:49:20 INFO - 2015-11-24 05:49:20,077 DEBUG : process_Request line: v8_7 20040.72 graph.html#tests=[[230,64,59]] 05:49:20 INFO - 2015-11-24 05:49:20,078 INFO : javascript benchmark 05:49:20 INFO - 2015-11-24 05:49:20,080 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3182.5067114597236, 3463.480477928312, 3481.9651803481956, 3494.650534946504, 3526.9294614107716, 5618.0, 5692.658440493573, 5693.943060569398, 5698.544116470688, 5733.197352370671, 5698.914516282259, 5774.682392468423, 5778.566607504444, 5785.479306862381, 5790.363060063401, 4617.468991066037, 4694.718316900997, 5186.818461353853, 5206.869828254286, 5264.184051472009, 5206.401263854648, 5229.712365819878, 5267.1045922193125, 5275.788968441258, 5288.0745869472885, 5253.212018197263, 5264.736763161845, 5269.077911365515, 5272.235525848769, 5273.0, 5118.0, 5182.0, 5217.765200565984, 5238.214267859832, 5284.4187139414635, 4315.4605674290715, 5045.672031317989, 5145.6398052136365, 5148.3564554430695, 5156.561692256163, 5439.510444060014, 5605.859853503654, 5657.066584013633, 5722.027255366597, 5771.249737534135, 5781.653100813923, 6178.41305076017, 6197.87604247917, 6200.3179650238435, 6231.22109736283, 6240.0, 6310.7791227306825, 6342.460890824285, 6343.429091381798, 6350.904736428957, 5892.057270836645, 5893.764249430061, 5894.764209431618, 5914.615549989237, 5929.911051334234, 6199.504039676815, 6288.5598008139905, 6319.33646967071, 6322.936770632235, 6352.841178970562, 6082.847928801727, 6122.123717501779, 6142.560166306883, 6170.969145154335, 6186.350433204539, 6327.715252813635, 6330.366963303725, 6330.588511746721, 6342.270638876496, 6358.300586935434, 6041.24484439445, 6236.376362363727, 6245.781397651061, 6279.466245369194, 6289.339619339995, 6135.447809697149, 6226.346233645492, 6234.781782637586, 6269.247690277196, 6305.0, 4968.577670897942, 4979.751012449363, 4987.925181122286, 4990.975045124751, 5015.84952451427, 4463.575960283768, 4464.464264288241, 4470.217711900469, 4497.617702495325, 4519.0058187198765, 5529.060059789846, 5593.244911936918, 5649.745761440745, 5652.0, 5665.858353541194, 6130.734471166852, 6200.844978875474, 6232.626042437469, 6280.089387038854, 6281.8743625127245, 5755.050416681284, 5765.1640512125505, 5765.8558536036935, 5787.884242315215, 5815.389384114692, 5208.817691380859, 5430.945690543044, 5437.184422336682, 5437.45625437461, 5448.673079615236, 5308.840734777963, 6184.381561843779, 6298.433141017331, 6304.653244071436, 6331.778387756499, 6279.026750853625, 6314.905276420765, 6323.114763933145, 6324.30432652417, 6360.427561519486, 6196.318404975359, 6312.337204593451, 6329.683515824098, 6332.588381755171, 6359.682015899094, 6097.75608975636, 6135.386461353829, 6160.630362178284, 6165.383461653799, 6182.103594978613, 6313.684315784284, 6316.3683631638305, 6319.3364696706185, 6333.778317758856, 6352.396522330371, 5880.588358814842, 6182.690865456799, 6197.411245931629, 6198.039303907902, 6200.844978875564, 5131.717755523482, 6056.242969628796, 6105.328413874381, 6131.601445906002, 6140.232470941132, 5944.227250457413, 5988.760449581968, 5988.940110598838, 5996.070609055603, 6007.459328660441, 5087.728018291109, 6050.739789314397, 6101.572889897665, 6109.236345456818, 6131.448169664752, 5971.7611295547695, 5981.850453738692, 6000.399960003964, 6004.219451471281, 6005.339412664691], "unit": "ms", "name": "dojo.html", "value": 5697.443086206216}, {"lowerIsBetter": false, "replicates": [552.5331095224534, 569.8233547600242, 582.3594046548797, 633.6451587111216, 642.2197030607811, 26660.600090998625, 42115.94710132248, 42597.7870110649, 42760.572394276045, 42760.57239427609, 45164.0, 45357.54642453574, 45435.0, 45470.545294547046, 45576.86057848555, 8848.867266990968, 8948.686795962143, 9748.171405430528, 9914.454704991258, 9919.752006199868, 8810.691625793099, 12089.879101208964, 12161.452734626919, 12174.634760957186, 12176.208546444454, 11835.881641183563, 11910.0, 11916.285022898654, 11916.642500724993, 11918.880811191908, 8826.691065812665, 8926.419782714167, 11847.644570662851, 11919.702007449796, 11919.821202681967, 8741.388102832805, 8888.377813553054, 8895.510746908918, 11956.641300760992, 12056.578019769266, 41806.581934180875, 42176.0, 42205.0, 42235.7888210557, 42314.576854231374, 3220.3237320162793, 3234.498652708834, 3284.835758212104, 3393.372226138172, 3819.5607505136986, 29501.11496655104, 29883.850580747174, 30300.848495757382, 30456.086317410514, 31106.0, 2762.958555621667, 2768.8754006069776, 2795.049683107733, 2881.121258016304, 2931.5016447204025, 482375.0, 484015.0, 484476.0, 484659.0, 484685.0, 70431.94352084723, 70763.2923670767, 70980.64509677418, 70987.0, 71008.0, 74523.0, 74767.62616186994, 74846.6257668719, 74909.0, 75063.0, 16177.0, 16650.333986640642, 16687.0, 16766.245518951677, 16790.32838686439, 12532.937335313265, 12602.55891043809, 12611.180273282207, 12628.494860205672, 12629.621111366674, 21604.45988850291, 21876.89061554682, 21968.89015554912, 22010.779892200873, 22016.899155042505, 9054.275657947348, 9246.90753092474, 9259.675911343205, 9288.767780805534, 9317.580708868118, 941.6421759731395, 965.9275554333453, 970.4904924914335, 1059.5496913811598, 1070.4540684250933, 24734.25797226086, 29057.0, 29157.708422915923, 29766.40467190644, 29785.85107074451, 967.666155176463, 1013.8681971343678, 1018.221060888421, 1056.6988408303596, 1151.3840095548842, 14465.638359041108, 14476.420943162366, 14660.193689347188, 14784.334704938303, 14809.703805923822, 527715.7228427744, 528725.0, 529024.0, 530627.346863271, 537725.0, 51457.48542514602, 59902.0, 60287.69856150779, 60356.0, 60604.69697651572, 1412.4420853762706, 1447.3631602095254, 1456.621278467585, 1465.1062851660265, 1466.288849907794, 27995.44009119847, 29458.558121628623, 30632.0, 30715.846420767753, 30802.69197308088, 55014.899702006536, 55531.722341388035, 55621.72189139028, 55675.44324556865, 55745.721271393384, 398399.0, 405718.0, 405821.0, 406292.0, 406560.0, 31635.050948471584, 32008.0, 32257.67742322547, 32303.35393292168, 32339.191520211243, 45898.54101458943, 46344.84137896579, 46842.76578617221, 47232.81917952079, 47242.29136563023, 38240.61759382371, 38538.229235415696, 39329.016774580865, 39349.2130157401, 39899.20201595894, 37459.0, 38137.0, 38494.230115398095, 38502.80748596239, 38599.0350241235, 37933.0, 38280.08599570066, 38580.80709596434, 38664.226715466095, 38714.032149195365, 31888.043358699277, 34216.34210395956, 34330.48504272488, 34570.790022349094, 34621.0, 25107.372315691522, 25110.246692599252, 25147.371315717253, 25416.364590885376, 25792.0], "unit": "ms", "name": "ext.html", "value": 20583.854601408995}, {"lowerIsBetter": false, "replicates": [359.45542503107794, 360.4125275800446, 366.14322485384196, 367.80690137677715, 372.81731951343835, 15710.978786378877, 17329.74005389917, 19643.607127857453, 20434.59130817383, 21067.367978960618, 11142.0, 11377.829332559997, 11379.0, 14299.285035748224, 18837.246510139612, 3986.581408952062, 5198.45416231296, 5340.332458442695, 5350.0904846176245, 5356.437574054727, 4078.3066878630702, 4116.361963895601, 5789.247397838296, 5944.256967879015, 5947.40525947404, 5844.357120716718, 5851.327097383792, 5899.557533185007, 5917.082852157901, 6123.448889599935, 6474.320196379383, 6516.543841931067, 6527.0209468579615, 6531.7387304507765, 6536.0, 5582.218489411485, 5631.63394379364, 5722.084466485342, 5726.856828579277, 5733.140028995684, 13181.011424143227, 13195.802062969064, 13242.53651122206, 20758.546901716887, 25651.10221142251, 1705.266735303819, 2022.2618744158276, 2034.5138968574258, 2039.6022775558772, 2073.554185850034, 9668.75828104296, 10862.837057444145, 12073.792620737944, 14713.55859324222, 14982.0, 1687.4178408449188, 1706.650136721969, 1715.4682048564985, 1738.3133662203359, 1750.4311098892783, 100491.0, 104771.47614261956, 105155.47422262993, 105242.94757052408, 105391.94608053898, 8882.245009174292, 11014.669559913216, 11059.22585419029, 11068.225224234387, 11080.002799747901, 13287.269200193889, 13346.532871349651, 13349.933250333686, 13352.599422017354, 13360.198388096745, 8108.513489190667, 8242.134575869568, 8261.793455163548, 8291.58542072906, 8314.750557483285, 8313.501189928624, 8317.792055198668, 8366.539840308842, 8399.286060684788, 8402.159784021549, 4078.979605102015, 4303.505096913895, 4350.608445239944, 4362.214801335726, 4409.536998615164, 1762.903040332794, 1808.5297822566229, 1812.3928483958023, 1843.3640394064028, 1924.3264857300112, 333.8097284547833, 793.888855560222, 951.3150531617224, 1015.9542820573092, 1025.0620682075967, 8351.3736469765, 10899.346039237671, 11217.3830439325, 11274.661760147208, 11402.087832973342, 425.2749062847899, 435.63842011131317, 437.58866665334483, 804.7746630943345, 895.9920089898864, 5202.635815492879, 10417.5832966682, 10704.411257380763, 10726.570937162582, 10756.139508839275, 733568.0, 735009.0, 778507.0, 783981.0, 798987.0, 86743.13256867477, 104391.0, 118512.0, 120051.0, 125560.37219813843, 1046.2414749306845, 1166.632510759108, 1167.229628445222, 1181.2440038375446, 1201.8197270409335, 17725.556861078578, 17839.0, 17947.461576152735, 17979.73030404571, 18049.458516244533, 49769.0, 50005.49983500501, 50285.24572131494, 50378.0, 50411.74794126006, 67618.66190669015, 69063.61872762415, 69876.0, 69912.60174796374, 71710.0, 9409.247260219303, 9536.758861667364, 9878.4566848824, 9997.900020999698, 10009.449480278654, 11728.12039097054, 11845.46695398692, 15712.528624141294, 20103.0, 20222.907752015242, 15738.213089345716, 15765.132917689638, 15797.842021579638, 16208.270627821541, 16350.937189082671, 14982.400703972155, 15276.770848437505, 15435.922820385826, 15466.458673946358, 16202.756958645394, 12865.614031579067, 13568.0, 14554.12675239489, 15970.680586387974, 16130.951488153232, 9132.49771262587, 9354.766130846783, 9376.859347109663, 9391.624335026523, 9415.05849415053, 9688.370255933341, 15028.248587570797, 15158.014729042578, 15312.464063757716, 15501.689966200838], "unit": "ms", "name": "jquery.html", "value": 9291.288281955678}, {"lowerIsBetter": false, "replicates": [1280.9551665691702, 1560.7190705672974, 1561.593985563754, 1891.883788564747, 1910.8184722451367, 7748.728794492194, 8024.598770061495, 8219.095899451055, 8571.614277357517, 8584.699535516258, 8298.045724741656, 8399.580020998941, 8456.027556830966, 8474.449160804543, 8477.533735644538, 2134.8185404240658, 2174.63031284682, 2369.3247424484025, 2392.2823153054014, 2393.365758074112, 2196.923107691231, 2199.3841724317135, 2371.7509661485556, 2411.8914648840755, 2412.3366074329524, 2342.344143639775, 2355.8115350771895, 2381.5117900830373, 2386.296042667417, 2388.868612226327, 2129.882856442895, 2180.574787916357, 2368.9289321320302, 2392.820538459614, 2395.0898658509655, 2185.650295952656, 2193.6928829963817, 2194.133317339642, 2196.198387588535, 2378.2746262389965, 8212.794680132985, 8309.37679674027, 8314.958425207835, 8325.458845175044, 8336.333093352518, 5094.617903657204, 5151.381834179922, 5157.252198431244, 5190.92213616796, 5194.246834209056, 3479.2171761353748, 3557.3596752584526, 3601.8559257629927, 3637.563492380905, 3645.6536629020466, 1033.7984093101848, 1047.2721458586286, 1051.905586511792, 1062.8299472084507, 1080.9028835731738, 10921.781564368748, 11028.889711102947, 11070.059044981266, 11086.22396432242, 11103.777924441465, 4655.231886738718, 4666.113438446684, 4726.267428548512, 4735.644826638016, 4742.5731684148595, 9814.9018509814, 9827.262955278382, 9828.361156524947, 9858.654947076819, 9865.506724663737, 5188.714620695822, 5190.870228244248, 5220.269162317279, 5228.660137091077, 5248.947510524922, 4686.789094490756, 4692.319613656001, 4699.506551812079, 4722.220833562424, 4724.622030237572, 3656.3966945454235, 3744.213715119801, 3759.6992240620684, 3760.6239376062176, 3784.564775050849, 1199.91600587958, 1238.5665017243894, 1240.2806372304042, 1247.7941139712027, 1250.1374051904338, 1356.5184359552413, 1370.4792178971927, 1392.7701929181571, 1393.6724869655623, 1394.4352537222442, 7791.4935529190425, 7927.762167134995, 7941.166177551389, 7952.005999250094, 7953.602319883983, 495.3461430911163, 501.9949800502021, 507.56603104345993, 508.83208541181324, 510.1302279613325, 4841.540053694894, 6165.951788196017, 6174.351693072253, 6232.56372053961, 6253.6873156342, 9272.211861991806, 10128.442935638463, 10206.387616743019, 10216.387016779017, 10216.744581385525, 9840.212782977345, 10039.849402258971, 10070.899291006996, 10112.443815590066, 10113.747156321004, 7896.131425543185, 7977.401694872908, 7995.680172793023, 8041.356691464669, 8055.355571554144, 7489.70041198346, 7867.645955931882, 7885.5662938538935, 7886.211378862068, 7901.209879012053, 8896.955515222382, 9025.007249202452, 9041.728748137566, 9053.637854485747, 9070.863937040818, 7796.9220307796195, 9006.594703238501, 9272.350935434455, 9314.48770317639, 9420.95289523548, 6883.862322753416, 7302.160251570925, 7375.631218439164, 7380.483366164317, 7414.8887766682465, 8055.154208808225, 8056.234657707509, 8057.959710201411, 8068.07217170033, 8082.0, 7421.109466864011, 7482.401407887465, 7496.850062998818, 7621.809454763676, 7686.884696729442, 7135.108111486064, 7327.963360183165, 7346.77959661211, 7419.554826710415, 7475.177730449537, 7439.9256007439235, 7453.664585093576, 7455.0, 7491.550506969599, 7503.287187717158, 6748.257691654012, 6805.591664500146, 6850.588964662136, 6857.55425897315, 6861.622610756257, 6892.0, 6946.37482626566, 6948.235694073547, 6954.860902782018, 6959.8608027838145], "unit": "ms", "name": "mootools.html", "value": 4677.034339119698}, {"lowerIsBetter": false, "replicates": [324.5829109594172, 327.51527738946356, 333.07903646417674, 335.966403359664, 336.53558089836037, 6696.5982041077505, 6715.059891615166, 6763.695633696483, 6794.524383293171, 6803.897941530881, 5880.500157486619, 6222.439980401763, 6694.364035416627, 6726.293739157391, 6726.562773419724, 4774.641901857357, 4933.309336692857, 4938.925916111261, 4941.77762000709, 4945.802167913279, 4905.190643543829, 4923.384576927884, 4930.876728081808, 4942.3327850740225, 4973.403191617011, 4870.951290487085, 4874.878128046809, 4877.34155888954, 4886.315915771795, 4890.364252647151, 4623.907521849578, 4718.41019872516, 4735.408073990751, 4887.193613053842, 4894.755262236892, 4101.876943691665, 4144.378343248507, 4191.0, 4205.285101532747, 4232.809523571416, 6416.165898433221, 6444.581102228341, 6448.322926092739, 6449.516286278501, 6471.935280647227, 5508.256385387961, 5574.219609254667, 5707.62900411476, 5710.029295019815, 5876.823695289148, 7099.6450177490915, 7220.566765994057, 7238.601876896769, 7243.637818109073, 7261.927380726231, 4755.0, 4755.667103302771, 4756.28655701644, 4756.809727610891, 4763.49983251757, 7433.368163706037, 7637.847243055107, 7657.387409007266, 7663.885041724323, 7677.270659287359, 4676.859694209179, 4692.272697731857, 4705.058988202373, 4707.270373092176, 4715.481297057321, 4761.452432970253, 4793.945332026949, 4794.161021821237, 4799.208130658472, 4803.879903002383, 5730.169125476866, 5733.971330143323, 5742.368339482654, 5749.712514374264, 5751.798687045934, 7013.719451221996, 7261.164966028974, 7268.164161121539, 7299.0, 7322.524035937647, 1489.4265707702396, 1643.0388222889505, 1665.9750103748454, 1666.6833301672643, 1668.115898573758, 976.2141476111798, 1041.6146025970288, 1063.4788953412772, 1064.5635289531256, 1067.0, 6732.091167692397, 6751.831204219934, 6752.3922846944015, 6758.560693554903, 6784.559003664746, 7496.0255166827965, 7504.662290196954, 7508.849823003618, 7514.4364172687265, 7528.924710752932, 6521.739130434825, 6724.193096828314, 6728.529002969843, 6738.258791532928, 6739.696713647898, 3871.0, 3963.8018099095507, 3974.344233201547, 3975.5626881043063, 4021.8994525136522, 7707.730229442055, 7876.803079923047, 7925.207479252144, 7933.286004259644, 7944.721934732257, 7786.688532458638, 7824.37405007598, 7872.448928574945, 7896.249856263646, 7907.525548466995, 7663.19536448676, 7890.921090789134, 7898.170692077364, 7908.051033875971, 7918.129005809241, 6115.938840611537, 6161.815145545641, 6618.569792963442, 7595.658195381332, 7610.429217808797, 5633.802816901389, 7153.284671532805, 7482.925170748223, 7483.775486735407, 7495.287947644965, 7844.21557844211, 7860.410469214946, 7869.213078692085, 7872.409569282212, 7889.250521200477, 4842.0, 4898.53463920927, 4901.289313049517, 4902.632302577393, 4905.632077594123, 6028.0, 7236.782896513113, 7451.733205355211, 7452.403807695479, 7483.70065197386, 7171.067761191011, 7173.318534739192, 7181.533200341961, 7197.820054498679, 7207.243239459781, 7163.820904477429, 7172.103487064117, 7173.246809084971, 7173.497855150298, 7193.064901562763, 6779.322067793181, 7006.789796306119, 7076.646167691698, 7084.079069720903, 7091.219965803861, 7222.399936023133, 7224.205337412775, 7228.096487939008, 7231.5299505531975, 7234.6744396501235, 6959.756408525677, 7062.0, 7064.788056358112, 7071.36357727807, 7082.610456424946], "unit": "ms", "name": "prototype.html", "value": 5246.146828943373}, {"lowerIsBetter": false, "replicates": [709.7835160276115, 750.782273140789, 762.8321769210775, 814.4502460838936, 820.429801288105, 10728.678139655804, 12189.878101218985, 12207.816882746765, 12211.633650990485, 12235.755284894296, 14171.716565668681, 14356.425742970294, 14368.066075705097, 14378.784318235208, 14389.496367627135, 754.1628792040831, 768.2931702833407, 768.561919705768, 949.1268033409245, 962.8315044867155, 959.0074273127315, 959.4818797849153, 972.1153750087421, 975.1467465967279, 977.1938151025397, 1012.306569999549, 1033.0702367868903, 1033.0908800255766, 1033.7829055898271, 1035.321864178964, 800.2997377294867, 813.1908750792969, 815.3314282288526, 1002.6240159940022, 1025.656405104291, 759.2748924776824, 764.2090436398302, 765.1239330966068, 765.7779244019227, 767.8464307138595, 14952.850471495363, 15116.697666046728, 15189.696206075927, 15209.695806083817, 15254.161021143833, 12393.194442361219, 12641.241525508407, 12663.430145643468, 12893.161944473579, 12990.870091299155, 9827.459489728062, 10080.596776128947, 10089.798204035951, 10097.495125243708, 10103.19174466041, 3519.4896739972814, 3547.94678079829, 3558.6441355864467, 3560.092176495003, 3560.964390356089, 77130.61434692847, 78611.0, 79247.81128283081, 79303.60348198279, 79624.40751185002, 9523.571564208334, 9547.42715437076, 9583.329166958247, 9621.470819105016, 9911.454869982075, 21465.141394344053, 21736.13055477795, 21741.78258217429, 21748.565028699337, 21776.673349899764, 6120.816375508742, 7146.071010768567, 7220.133583969957, 7433.628318584158, 7469.626518674045, 3896.3571010782903, 3929.960700393017, 3936.3308237599676, 3945.9408108877815, 4051.858184963512, 3036.59006034187, 3552.87564935226, 3566.037169964147, 3572.91067723309, 3608.891733248007, 641.6022066318819, 650.2716957008181, 655.2890114226022, 677.1738479055545, 677.4377266868487, 507.21128644956707, 524.090702630935, 552.9917051244234, 610.2676787854592, 619.5322531488697, 8475.703350382708, 8843.778905527284, 8936.642534298555, 9086.954565227265, 9697.321187516947, 500.65955150498013, 503.2702581257192, 519.9272101905736, 582.033823852403, 594.4234092929851, 3328.4341661917533, 3918.529776426847, 3946.1713040261293, 4052.7365721228616, 4148.357004664282, 98912.01087989172, 102226.0, 102964.42588935187, 104054.0, 104452.0, 85663.0, 86275.56862215648, 86827.13172868316, 87489.12510874809, 88190.0, 72314.63842680753, 72671.27328726751, 72853.27146728571, 75591.62204188944, 75813.0, 8260.096672392625, 8465.322774178174, 8569.314454843723, 8960.283177345927, 9100.45397276139, 51547.0, 52145.7392713034, 52826.73586632042, 54070.91858162893, 54843.0, 68504.6574767123, 69735.65132174306, 71144.28855711376, 71456.64271678608, 75283.0, 11123.83314250303, 11159.38623375722, 11279.436028198394, 11397.715057123638, 11561.942190289332, 10155.339902906288, 12415.875841241472, 12543.372831358212, 12550.748985020065, 13175.934120329337, 11478.598249061242, 11489.195756296978, 11593.0, 11977.760444791229, 12428.316442595382, 11233.66299011031, 11696.47365868555, 12021.939890300842, 12022.27866328023, 12406.689832754253, 11075.335479871233, 11802.82295765547, 11809.11431642613, 11810.881891181321, 12478.87521124777, 9549.0, 9727.509817440672, 9774.218062554837, 9782.315237933277, 10414.791704165722, 9224.38113402478, 9259.0, 10083.445410502492, 10101.747456313651, 10124.949375253076], "unit": "ms", "name": "yui.html", "value": 7007.310631546411}], "name": "dromaeo_css", "value": 7564.502454612229}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 110.0, 111.0, 110.0, 97.0, 110.0, 113.0, 119.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 121.0, 143.0, 155.0, 118.0, 147.0, 142.0, 119.0, 156.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 136.7}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 179.0, 183.0, 185.0, 186.0, 186.0, 185.0, 182.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 183.4}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 76.0, 74.0, 58.0, 56.0, 58.0, 72.0, 72.0, 60.0], "unit": "ms", "name": "audio-fft", "value": 65.8}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 119.0, 76.0, 101.0, 116.0, 145.0, 79.0, 74.0, 106.0], "unit": "ms", "name": "audio-oscillator", "value": 98.6}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 87.0, 85.0, 87.0, 87.0, 88.0, 88.0, 89.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 87.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [86.0, 96.0, 140.0, 121.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 54.0, 54.0, 70.0, 81.0, 54.0, 63.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 64.0, 67.0, 66.0, 65.0, 66.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [79.0, 83.0, 81.0, 80.0, 83.0, 80.0, 83.0, 83.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [120.0, 109.0, 137.0, 120.0, 122.0, 121.0, 116.0, 124.0, 120.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [135.0, 135.0, 143.0, 168.0, 172.0, 128.0, 134.0, 137.0, 135.0, 124.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.5}], "name": "kraken", "value": 1403.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [174.1250217656277], "unit": "score", "name": "Richards", "value": 202.73938599999994}, {"lowerIsBetter": false, "replicates": [161.7741935483871], "unit": "score", "name": "DeltaBlue", "value": 408.7054835493521}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [4748.815165876777], "unit": "score", "name": "Decrypt", "value": 56.052086826347306}, {"lowerIsBetter": false, "replicates": [1731.833910034602], "unit": "score", "name": "RayTrace", "value": 427.2863556443558}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [31562.5], "unit": "score", "name": "RegExp", "value": 28.86289108910892}, {"lowerIsBetter": false, "replicates": [660.0660066006601], "unit": "score", "name": "Splay", "value": 123.45886499999997}, {"lowerIsBetter": false, "replicates": [4522.522522522522], "unit": "score", "name": "NavierStokes", "value": 328.13545816733085}], "name": "v8_7", "value": 20040.72310843613}]} 05:49:20 INFO - RETURN: dromaeo_css: 7564.50 05:49:20 INFO - RETURN: kraken: 1404.00 05:49:20 INFO - RETURN: v8_7: 20040.72 05:49:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20040.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1404.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7564.50"}}} 05:49:20 INFO - Return code: 0 05:49:20 INFO - # TBPL SUCCESS # 05:49:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:49:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:49:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:49:20 INFO - 2015-11-24 05:49:20.185 screenresolution[1674:10083] starting screenresolution argv=screenresolution get 05:49:20 INFO - 2015-11-24 05:49:20.187 screenresolution[1674:10083] Display 0: 1600x1200x32@60 05:49:20 INFO - 2015-11-24 05:49:20.193 screenresolution[1675:10086] starting screenresolution argv=screenresolution list 05:49:20 INFO - Available Modes on Display 0 05:49:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:49:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:49:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:49:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:49:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:49:20 INFO - Intel Iris: 05:49:20 INFO - Chipset Model: Intel Iris 05:49:20 INFO - Type: GPU 05:49:20 INFO - Bus: Built-In 05:49:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:49:20 INFO - Vendor: Intel (0x8086) 05:49:20 INFO - Device ID: 0x0a2e 05:49:20 INFO - Revision ID: 0x0009 05:49:20 INFO - Displays: 05:49:20 INFO - Display: 05:49:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:49:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:49:20 INFO - Display Serial Number: 1600x1200 60 05:49:20 INFO - Main Display: Yes 05:49:20 INFO - Mirror: Off 05:49:20 INFO - Online: Yes 05:49:20 INFO - Rotation: Supported 05:49:20 INFO - Return code: 0 05:49:20 INFO - Running post-action listener: _resource_record_post_action 05:49:20 INFO - Running post-run listener: _resource_record_post_run 05:49:21 INFO - Total resource usage - Wall time: 1240s; CPU: 53.0%; Read bytes: 39171584; Write bytes: 693459968; Read time: 424; Write time: 2152 05:49:21 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 342036992; Write bytes: 338937856; Read time: 26909; Write time: 684 05:49:21 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 37144064; Write bytes: 343036928; Read time: 400; Write time: 1433 05:49:21 INFO - Running post-run listener: _upload_blobber_files 05:49:21 INFO - Blob upload gear active. 05:49:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:49:21 INFO - Copying logs to upload dir... 05:49:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.317758 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-24 05:49:21.548951) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:49:21.551930) ========= 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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009385 build_url: 'https://queue.taskcluster.net/v1/task/osqUG2hkRPuECkOjnOcW2Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:49:21.576089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:49:21.576734) ========= 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.a1FFrV76FZ/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.PCQP0Sgko5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005149 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:49:21.628664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 05:49:21.629367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 05:49:21.630042) ========= ========= Total master_lag: 0.21 =========