builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0021 starttime: 1447943790.56 results: success (0) buildid: 20151119052820 builduid: 766a51b7c64343cbb2ce847ef371ba8d revision: 9a49075671cb62db97b9567a510a0bb361c9114a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.558705) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.559237) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.559631) ========= 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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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.005750 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.585133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.585522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.602826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.603388) ========= 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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.656272) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.659806) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.660358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:30.660741) ========= 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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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-19 06:36:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2015-11-19 06:36:30 (8.17 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174386 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:31.265662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:31.266025) ========= 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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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.019267 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:31.306722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 06:36:31.307156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9a49075671cb62db97b9567a510a0bb361c9114a --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 9a49075671cb62db97b9567a510a0bb361c9114a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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-19 06:36:31,376 truncating revision to first 12 chars 2015-11-19 06:36:31,376 Setting DEBUG logging. 2015-11-19 06:36:31,376 attempt 1/10 2015-11-19 06:36:31,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9a49075671cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 06:36:32,423 unpacking tar archive at: fx-team-9a49075671cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.280946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 06:36:32.606525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:32.606899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:32.620087) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:32.620493) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:36:32.620936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-19 06:36:32.621296) ========= /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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:36:32 INFO - MultiFileLogger online at 20151119 06:36:32 in /builds/slave/test 06:36:32 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 06:36:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:32 INFO - {'append_to_log': False, 06:36:32 INFO - 'base_work_dir': '/builds/slave/test', 06:36:32 INFO - 'blob_upload_branch': 'Fx-Team', 06:36:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:32 INFO - 'branch': 'Fx-Team', 06:36:32 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:32 INFO - 'config_files': ('talos/mac_config.py',), 06:36:32 INFO - 'default_actions': ('clobber', 06:36:32 INFO - 'read-buildbot-config', 06:36:32 INFO - 'download-and-extract', 06:36:32 INFO - 'populate-webroot', 06:36:32 INFO - 'create-virtualenv', 06:36:32 INFO - 'install', 06:36:32 INFO - 'run-tests'), 06:36:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:32 INFO - 'download_minidump_stackwalk': True, 06:36:32 INFO - 'download_symbols': 'ondemand', 06:36:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:32 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:32 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:32 INFO - 'installer_path': 'installer.exe', 06:36:32 INFO - 'log_level': 'info', 06:36:32 INFO - 'log_name': 'talos', 06:36:32 INFO - 'log_to_console': True, 06:36:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:36:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:36:32 INFO - 'opt_config_files': (), 06:36:32 INFO - 'pip_index': False, 06:36:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:32 INFO - 'cmd': ('bash', 06:36:32 INFO - '-c', 06:36:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:32 INFO - 'enabled': True, 06:36:32 INFO - 'halt_on_failure': False, 06:36:32 INFO - 'name': 'check_screen_resolution'},), 06:36:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:32 INFO - 'cmd': ('bash', 06:36:32 INFO - '-c', 06:36:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:32 INFO - 'enabled': True, 06:36:32 INFO - 'halt_on_failure': False, 06:36:32 INFO - 'name': 'check_screen_resolution'},), 06:36:32 INFO - 'run_cmd_checks_enabled': True, 06:36:32 INFO - 'sps_profile': False, 06:36:32 INFO - 'sps_profile_interval': 0, 06:36:32 INFO - 'suite': 'dromaeojs', 06:36:32 INFO - 'system_bits': '64', 06:36:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:32 INFO - 'title': 't-yosemite-r7-0021', 06:36:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:32 INFO - 'use_talos_json': True, 06:36:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:32 INFO - 'work_dir': 'build'} 06:36:32 INFO - ##### 06:36:32 INFO - ##### Running clobber step. 06:36:32 INFO - ##### 06:36:32 INFO - Running pre-action listener: _resource_record_pre_action 06:36:32 INFO - Running main action method: clobber 06:36:32 INFO - rmtree: /builds/slave/test/build 06:36:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:33 INFO - Running post-action listener: _resource_record_post_action 06:36:33 INFO - ##### 06:36:33 INFO - ##### Running read-buildbot-config step. 06:36:33 INFO - ##### 06:36:33 INFO - Running pre-action listener: _resource_record_pre_action 06:36:33 INFO - Running main action method: read_buildbot_config 06:36:33 INFO - Using buildbot properties: 06:36:33 INFO - { 06:36:33 INFO - "properties": { 06:36:33 INFO - "buildnumber": 1, 06:36:33 INFO - "product": "firefox", 06:36:33 INFO - "script_repo_revision": "production", 06:36:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:36:33 INFO - "repository": "", 06:36:33 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:36:33 INFO - "buildid": "20151119052820", 06:36:33 INFO - "slavename": "t-yosemite-r7-0021", 06:36:33 INFO - "pgo_build": "False", 06:36:33 INFO - "basedir": "/builds/slave/test", 06:36:33 INFO - "project": "", 06:36:33 INFO - "platform": "yosemite_r7", 06:36:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:36:33 INFO - "slavebuilddir": "test", 06:36:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:36:33 INFO - "branch": "fx-team", 06:36:33 INFO - "repo_path": "integration/fx-team", 06:36:33 INFO - "stage_platform": "macosx64", 06:36:33 INFO - "builduid": "766a51b7c64343cbb2ce847ef371ba8d", 06:36:33 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:36:33 INFO - }, 06:36:33 INFO - "sourcestamp": { 06:36:33 INFO - "repository": "", 06:36:33 INFO - "hasPatch": false, 06:36:33 INFO - "project": "", 06:36:33 INFO - "branch": "fx-team-macosx64-talos", 06:36:33 INFO - "changes": [ 06:36:33 INFO - { 06:36:33 INFO - "category": null, 06:36:33 INFO - "files": [ 06:36:33 INFO - { 06:36:33 INFO - "url": null, 06:36:33 INFO - "name": "https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 06:36:33 INFO - } 06:36:33 INFO - ], 06:36:33 INFO - "repository": "", 06:36:33 INFO - "rev": "9a49075671cb62db97b9567a510a0bb361c9114a", 06:36:33 INFO - "who": "cbook@mozilla.com", 06:36:33 INFO - "when": 1447942316, 06:36:33 INFO - "number": 6682516, 06:36:33 INFO - "comments": "Backed out changeset 24c5d435977d (bug 1213421) for dt6 leak", 06:36:33 INFO - "project": "", 06:36:33 INFO - "at": "Thu 19 Nov 2015 06:11:56", 06:36:33 INFO - "branch": "fx-team-macosx64-talos", 06:36:33 INFO - "revlink": "", 06:36:33 INFO - "properties": [ 06:36:33 INFO - [ 06:36:33 INFO - "buildid", 06:36:33 INFO - "20151119052820", 06:36:33 INFO - "Change" 06:36:33 INFO - ], 06:36:33 INFO - [ 06:36:33 INFO - "builduid", 06:36:33 INFO - "766a51b7c64343cbb2ce847ef371ba8d", 06:36:33 INFO - "Change" 06:36:33 INFO - ], 06:36:33 INFO - [ 06:36:33 INFO - "pgo_build", 06:36:33 INFO - "False", 06:36:33 INFO - "Change" 06:36:33 INFO - ] 06:36:33 INFO - ], 06:36:33 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:36:33 INFO - } 06:36:33 INFO - ], 06:36:33 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:36:33 INFO - } 06:36:33 INFO - } 06:36:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 06:36:33 INFO - Running post-action listener: _resource_record_post_action 06:36:33 INFO - ##### 06:36:33 INFO - ##### Running download-and-extract step. 06:36:33 INFO - ##### 06:36:33 INFO - Running pre-action listener: _resource_record_pre_action 06:36:33 INFO - Running main action method: download_and_extract 06:36:33 INFO - mkdir: /builds/slave/test/build/tests 06:36:33 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')]} 06:36:33 INFO - https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:36:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/test_packages.json 06:36:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/test_packages.json 06:36:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:36:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:36:45 INFO - Downloaded 1149 bytes. 06:36:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:36:45 INFO - Using the following test package requirements: 06:36:45 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:36:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 06:36:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'jsshell-mac.zip'], 06:36:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 06:36:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:36:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 06:36:45 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 06:36:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 06:36:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:36:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:36:45 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 06:36:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:45 INFO - https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:36:46 INFO - Downloaded 17476838 bytes. 06:36:46 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 06:36:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:36:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 06:36:48 INFO - Return code: 0 06:36:48 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 06:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:48 INFO - https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:36:54 INFO - Downloaded 17476838 bytes. 06:36:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 06:36:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:36:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 06:36:58 INFO - Return code: 0 06:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:58 INFO - https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:36:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:36:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:36:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:37:00 INFO - Downloaded 11130997 bytes. 06:37:00 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 06:37:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:37:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 06:37:01 INFO - Return code: 0 06:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:01 INFO - https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:37:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:37:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:37:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 06:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8QpLV3dpQW6bfw4cRL7oIg/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 06:37:04 INFO - Downloaded 108847568 bytes. 06:37:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:37:04 INFO - mkdir: /builds/slave/test/properties 06:37:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:04 INFO - Contents: 06:37:04 INFO - build_url:https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:37:04 INFO - Running post-action listener: _resource_record_post_action 06:37:04 INFO - Running post-action listener: set_extra_try_arguments 06:37:04 INFO - ##### 06:37:04 INFO - ##### Running populate-webroot step. 06:37:04 INFO - ##### 06:37:04 INFO - Running pre-action listener: _resource_record_pre_action 06:37:04 INFO - Running main action method: populate_webroot 06:37:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:37:04 INFO - '../fennec_ids.txt'], 06:37:04 INFO - 'tests': ['tcheck2']}, 06:37:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:04 INFO - '--tppagecycles', 06:37:04 INFO - '7'], 06:37:04 INFO - 'tests': ['tsvgm']}}, 06:37:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:37:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:37:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:37:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'tests': ['damp', 'tps']}, 06:37:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['damp', 'tps']}, 06:37:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:37:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:04 INFO - 'other': {'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore']}, 06:37:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore']}, 06:37:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore']}, 06:37:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore']}, 06:37:04 INFO - 'other_l64': {'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore']}, 06:37:04 INFO - 'other_nol64': {'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore']}, 06:37:04 INFO - 'svgr': {'tests': ['tsvgx', 06:37:04 INFO - 'tsvgr_opacity', 06:37:04 INFO - 'tart', 06:37:04 INFO - 'tscrollx', 06:37:04 INFO - 'cart']}, 06:37:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['tsvgx', 06:37:04 INFO - 'tsvgr_opacity', 06:37:04 INFO - 'tart', 06:37:04 INFO - 'tscrollx', 06:37:04 INFO - 'cart']}, 06:37:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'tests': ['tp5o']}, 06:37:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--e10s'], 06:37:04 INFO - 'tests': ['tp5o']}, 06:37:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--xperf_path', 06:37:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:04 INFO - 'tests': ['tp5n']}, 06:37:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--e10s', 06:37:04 INFO - '--xperf_path', 06:37:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:04 INFO - 'tests': ['tp5n']}}, 06:37:04 INFO - 'talos.zip': {'path': '', 06:37:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:04 INFO - Running post-action listener: _resource_record_post_action 06:37:04 INFO - ##### 06:37:04 INFO - ##### Running create-virtualenv step. 06:37:04 INFO - ##### 06:37:04 INFO - Running pre-action listener: _resource_record_pre_action 06:37:04 INFO - Running main action method: create_virtualenv 06:37:04 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:04 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 06:37:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:04 INFO - Using real prefix '/tools/python27' 06:37:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:07 INFO - Installing pip.................done. 06:37:07 INFO - Return code: 0 06:37:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:07 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')]} 06:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:07 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')]} 06:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:07 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:07 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 06:37:07 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 06:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:07 INFO - 'HOME': '/Users/cltbld', 06:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:07 INFO - 'LOGNAME': 'cltbld', 06:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:07 INFO - 'MOZ_NO_REMOTE': '1', 06:37:07 INFO - 'NO_EM_RESTART': '1', 06:37:07 INFO - 'PAGER': '/bin/cat', 06:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:07 INFO - 'PWD': '/builds/slave/test', 06:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:07 INFO - 'SHELL': '/bin/bash', 06:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:07 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:07 INFO - 'USER': 'cltbld', 06:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:07 INFO - 'XPC_FLAGS': '0x0', 06:37:07 INFO - 'XPC_SERVICE_NAME': '0', 06:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:08 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 06:37:08 INFO - Cleaning up... 06:37:08 INFO - Return code: 0 06:37:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:37:08 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')]} 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 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')]} 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:08 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 06:37:08 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 06:37:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:08 INFO - 'HOME': '/Users/cltbld', 06:37:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:08 INFO - 'LOGNAME': 'cltbld', 06:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:08 INFO - 'MOZ_NO_REMOTE': '1', 06:37:08 INFO - 'NO_EM_RESTART': '1', 06:37:08 INFO - 'PAGER': '/bin/cat', 06:37:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:08 INFO - 'PWD': '/builds/slave/test', 06:37:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:08 INFO - 'SHELL': '/bin/bash', 06:37:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:08 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:08 INFO - 'USER': 'cltbld', 06:37:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:08 INFO - 'XPC_FLAGS': '0x0', 06:37:08 INFO - 'XPC_SERVICE_NAME': '0', 06:37:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:08 INFO - Downloading/unpacking psutil>=0.7.1 06:37:08 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 06:37:08 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 06:37:08 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 06:37:08 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 06:37:08 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 06:37:08 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 06:37:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:11 INFO - Installing collected packages: psutil 06:37:11 INFO - Running setup.py install for psutil 06:37:11 INFO - building 'psutil._psutil_osx' extension 06:37:11 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 06:37:11 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 06:37:11 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 06:37:11 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 06:37:11 INFO - building 'psutil._psutil_posix' extension 06:37:11 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 06:37:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:37:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:37:11 INFO - ^ 06:37:11 INFO - 1 warning generated. 06:37:11 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 06:37:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:11 INFO - Successfully installed psutil 06:37:11 INFO - Cleaning up... 06:37:11 INFO - Return code: 0 06:37:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:11 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:11 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 06:37:11 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 06:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:12 INFO - 'HOME': '/Users/cltbld', 06:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:12 INFO - 'LOGNAME': 'cltbld', 06:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:12 INFO - 'MOZ_NO_REMOTE': '1', 06:37:12 INFO - 'NO_EM_RESTART': '1', 06:37:12 INFO - 'PAGER': '/bin/cat', 06:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:12 INFO - 'PWD': '/builds/slave/test', 06:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:12 INFO - 'SHELL': '/bin/bash', 06:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:12 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:12 INFO - 'USER': 'cltbld', 06:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:12 INFO - 'XPC_FLAGS': '0x0', 06:37:12 INFO - 'XPC_SERVICE_NAME': '0', 06:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:37:12 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 06:37:12 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 06:37:12 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 06:37:12 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 06:37:12 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 06:37:12 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 06:37:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:37:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:37:14 INFO - Installing collected packages: mozsystemmonitor 06:37:14 INFO - Running setup.py install for mozsystemmonitor 06:37:14 INFO - Successfully installed mozsystemmonitor 06:37:14 INFO - Cleaning up... 06:37:14 INFO - Return code: 0 06:37:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:14 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')]} 06:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:14 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')]} 06:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:14 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:14 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 06:37:14 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 06:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:14 INFO - 'HOME': '/Users/cltbld', 06:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:14 INFO - 'LOGNAME': 'cltbld', 06:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:14 INFO - 'MOZ_NO_REMOTE': '1', 06:37:14 INFO - 'NO_EM_RESTART': '1', 06:37:14 INFO - 'PAGER': '/bin/cat', 06:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:14 INFO - 'PWD': '/builds/slave/test', 06:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:14 INFO - 'SHELL': '/bin/bash', 06:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:14 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:14 INFO - 'USER': 'cltbld', 06:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:14 INFO - 'XPC_FLAGS': '0x0', 06:37:14 INFO - 'XPC_SERVICE_NAME': '0', 06:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:14 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:17 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:18 INFO - Downloading docopt-0.6.1.tar.gz 06:37:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:18 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:18 INFO - Running setup.py install for blobuploader 06:37:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:18 INFO - Running setup.py install for requests 06:37:18 INFO - Running setup.py install for docopt 06:37:19 INFO - Successfully installed blobuploader requests docopt 06:37:19 INFO - Cleaning up... 06:37:19 INFO - Return code: 0 06:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:19 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:19 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 06:37:19 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 06:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:19 INFO - 'HOME': '/Users/cltbld', 06:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:19 INFO - 'LOGNAME': 'cltbld', 06:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:19 INFO - 'MOZ_NO_REMOTE': '1', 06:37:19 INFO - 'NO_EM_RESTART': '1', 06:37:19 INFO - 'PAGER': '/bin/cat', 06:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:19 INFO - 'PWD': '/builds/slave/test', 06:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:19 INFO - 'SHELL': '/bin/bash', 06:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:19 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:19 INFO - 'USER': 'cltbld', 06:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:19 INFO - 'XPC_FLAGS': '0x0', 06:37:19 INFO - 'XPC_SERVICE_NAME': '0', 06:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:19 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-WuEPNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:19 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-Nghwzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:19 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-rZ36Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:19 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-tLcxu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:19 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-p4VgO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:19 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-YUl914-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-d2JFka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-CtPnKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-eda2nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-kC9Wb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-9IDqIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-jV1v7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-PTb_rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-yb48oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-miTrYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:20 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-9WVZzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:21 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-AaGl1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:21 INFO - Running setup.py install for manifestparser 06:37:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:21 INFO - Running setup.py install for mozcrash 06:37:21 INFO - Running setup.py install for mozdebug 06:37:21 INFO - Running setup.py install for mozdevice 06:37:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:21 INFO - Running setup.py install for mozfile 06:37:21 INFO - Running setup.py install for mozhttpd 06:37:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Running setup.py install for mozinfo 06:37:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Running setup.py install for mozInstall 06:37:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Running setup.py install for mozleak 06:37:22 INFO - Running setup.py install for mozlog 06:37:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Running setup.py install for moznetwork 06:37:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:22 INFO - Running setup.py install for mozprocess 06:37:22 INFO - Running setup.py install for mozprofile 06:37:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:23 INFO - Running setup.py install for mozrunner 06:37:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:23 INFO - Running setup.py install for mozscreenshot 06:37:23 INFO - Running setup.py install for moztest 06:37:23 INFO - Running setup.py install for mozversion 06:37:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:23 INFO - Cleaning up... 06:37:23 INFO - Return code: 0 06:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:23 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')]} 06:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:23 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')]} 06:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:23 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:23 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 06:37:23 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 06:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:23 INFO - 'HOME': '/Users/cltbld', 06:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:23 INFO - 'LOGNAME': 'cltbld', 06:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:23 INFO - 'MOZ_NO_REMOTE': '1', 06:37:23 INFO - 'NO_EM_RESTART': '1', 06:37:23 INFO - 'PAGER': '/bin/cat', 06:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:23 INFO - 'PWD': '/builds/slave/test', 06:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:23 INFO - 'SHELL': '/bin/bash', 06:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:23 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:23 INFO - 'USER': 'cltbld', 06:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:23 INFO - 'XPC_FLAGS': '0x0', 06:37:23 INFO - 'XPC_SERVICE_NAME': '0', 06:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-k1iLbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-vbntJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-gqaVR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-T7cAw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-WhsVSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-q2tyCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-d2WIEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-KqArw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-Rgv5p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:24 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)) 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:24 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-NYiKex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-8R4udJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:25 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)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-ZTZlG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:25 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)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-bE2dzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:25 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)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-xga9IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:25 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)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-LurrOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:25 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)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-9KVu7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:25 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)) 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:25 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-gWm0kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:25 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)) 06:37:25 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)) 06:37:25 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)) 06:37:25 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)) 06:37:25 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)) 06:37:25 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)) 06:37:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:27 INFO - Downloading blessings-1.5.1.tar.gz 06:37:27 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 06:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:28 INFO - Installing collected packages: blessings 06:37:28 INFO - Running setup.py install for blessings 06:37:28 INFO - Successfully installed blessings 06:37:28 INFO - Cleaning up... 06:37:28 INFO - Return code: 0 06:37:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:28 INFO - Reading from file tmpfile_stdout 06:37:28 INFO - Current package versions: 06:37:28 INFO - blessings == 1.5.1 06:37:28 INFO - blobuploader == 1.2.4 06:37:28 INFO - docopt == 0.6.1 06:37:28 INFO - manifestparser == 1.1 06:37:28 INFO - mozInstall == 1.12 06:37:28 INFO - mozcrash == 0.16 06:37:28 INFO - mozdebug == 0.1 06:37:28 INFO - mozdevice == 0.47 06:37:28 INFO - mozfile == 1.2 06:37:28 INFO - mozhttpd == 0.7 06:37:28 INFO - mozinfo == 0.9 06:37:28 INFO - mozleak == 0.1 06:37:28 INFO - mozlog == 3.0 06:37:28 INFO - moznetwork == 0.27 06:37:28 INFO - mozprocess == 0.22 06:37:28 INFO - mozprofile == 0.27 06:37:28 INFO - mozrunner == 6.11 06:37:28 INFO - mozscreenshot == 0.1 06:37:28 INFO - mozsystemmonitor == 0.0 06:37:28 INFO - moztest == 0.7 06:37:28 INFO - mozversion == 1.4 06:37:28 INFO - psutil == 3.1.1 06:37:28 INFO - requests == 1.2.3 06:37:28 INFO - wsgiref == 0.1.2 06:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:28 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 0x10e48b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e468228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc759cc0640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, '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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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 06:37:28 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 06:37:28 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 06:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:28 INFO - 'HOME': '/Users/cltbld', 06:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:28 INFO - 'LOGNAME': 'cltbld', 06:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:28 INFO - 'MOZ_NO_REMOTE': '1', 06:37:28 INFO - 'NO_EM_RESTART': '1', 06:37:28 INFO - 'PAGER': '/bin/cat', 06:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:28 INFO - 'PWD': '/builds/slave/test', 06:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:28 INFO - 'SHELL': '/bin/bash', 06:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:28 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:28 INFO - 'USER': 'cltbld', 06:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:28 INFO - 'XPC_FLAGS': '0x0', 06:37:28 INFO - 'XPC_SERVICE_NAME': '0', 06:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 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)) 06:37:28 INFO - Cleaning up... 06:37:28 INFO - Return code: 0 06:37:28 INFO - Running post-action listener: _resource_record_post_action 06:37:28 INFO - Running post-action listener: _start_resource_monitoring 06:37:28 INFO - Starting resource monitoring. 06:37:28 INFO - ##### 06:37:28 INFO - ##### Running install step. 06:37:28 INFO - ##### 06:37:28 INFO - Running pre-action listener: _resource_record_pre_action 06:37:28 INFO - Running main action method: install 06:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:29 INFO - Reading from file tmpfile_stdout 06:37:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:29 INFO - Reading from file tmpfile_stdout 06:37:29 INFO - Output received: 06:37:29 INFO - Usage: mozinstall [options] installer 06:37:29 INFO - Options: 06:37:29 INFO - -h, --help show this help message and exit 06:37:29 INFO - -d DEST, --destination=DEST 06:37:29 INFO - Directory to install application into. [default: 06:37:29 INFO - "/builds/slave/test"] 06:37:29 INFO - --app=APP Application being installed. [default: firefox] 06:37:29 INFO - mkdir: /builds/slave/test/build/application 06:37:29 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'] 06:37:29 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 06:37:59 INFO - Reading from file tmpfile_stdout 06:37:59 INFO - Output received: 06:37:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:37:59 INFO - Running post-action listener: _resource_record_post_action 06:37:59 INFO - ##### 06:37:59 INFO - ##### Running run-tests step. 06:37:59 INFO - ##### 06:37:59 INFO - Running pre-action listener: _resource_record_pre_action 06:37:59 INFO - Running main action method: run_tests 06:37:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:37:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:37:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:37:59 INFO - 2015-11-19 06:37:59.420 screenresolution[2008:12402] starting screenresolution argv=screenresolution get 06:37:59 INFO - 2015-11-19 06:37:59.422 screenresolution[2008:12402] Display 0: 1600x1200x32@60 06:37:59 INFO - 2015-11-19 06:37:59.428 screenresolution[2009:12405] starting screenresolution argv=screenresolution list 06:37:59 INFO - Available Modes on Display 0 06:37:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:37:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:37:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:37:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:37:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:37:59 INFO - Intel Iris: 06:37:59 INFO - Chipset Model: Intel Iris 06:37:59 INFO - Type: GPU 06:37:59 INFO - Bus: Built-In 06:37:59 INFO - VRAM (Dynamic, Max): 1536 MB 06:37:59 INFO - Vendor: Intel (0x8086) 06:37:59 INFO - Device ID: 0x0a2e 06:37:59 INFO - Revision ID: 0x0009 06:37:59 INFO - Displays: 06:37:59 INFO - Display: 06:37:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:37:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:37:59 INFO - Display Serial Number: 1600x1200 60 06:37:59 INFO - Main Display: Yes 06:37:59 INFO - Mirror: Off 06:37:59 INFO - Online: Yes 06:37:59 INFO - Rotation: Supported 06:37:59 INFO - Return code: 0 06:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:59 INFO - Python 2.7.3 06:37:59 INFO - Return code: 0 06:37:59 INFO - grabbing minidump binary from tooltool 06:37: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')]} 06:37:59 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 0x10e3af9f0>, '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 0x10e10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3a28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:59 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 06:37:59 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 06:37:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:59 INFO - Return code: 0 06:37:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:37:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:37:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:59 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/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost'] in /builds/slave/test/build 06:37:59 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/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --webServer localhost 06:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbG1pLTf6X/Render', 06:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:59 INFO - 'HOME': '/Users/cltbld', 06:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:59 INFO - 'LOGNAME': 'cltbld', 06:37:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:59 INFO - 'MOZ_NO_REMOTE': '1', 06:37:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:59 INFO - 'NO_EM_RESTART': '1', 06:37:59 INFO - 'PAGER': '/bin/cat', 06:37:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:59 INFO - 'PWD': '/builds/slave/test', 06:37:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:59 INFO - 'SHELL': '/bin/bash', 06:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3YkJhHDRSM/Listeners', 06:37:59 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 06:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:59 INFO - 'USER': 'cltbld', 06:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:59 INFO - 'XPC_FLAGS': '0x0', 06:37:59 INFO - 'XPC_SERVICE_NAME': '0', 06:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:59 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/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost'] with output_timeout 3600 06:37:59 INFO - mozversion INFO | application_buildid: 20151119052820 06:37:59 INFO - mozversion INFO | application_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:37:59 INFO - mozversion INFO | application_display_name: Nightly 06:37:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:59 INFO - mozversion INFO | application_name: Firefox 06:37:59 INFO - mozversion INFO | application_remotingname: firefox 06:37:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:37:59 INFO - mozversion INFO | application_vendor: Mozilla 06:37:59 INFO - mozversion INFO | application_version: 45.0a1 06:37:59 INFO - mozversion INFO | platform_buildid: 20151119052820 06:37:59 INFO - mozversion INFO | platform_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:37:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:37:59 INFO - mozversion INFO | platform_version: 45.0a1 06:37:59 INFO - 2015-11-19 06:37:59,969 DEBUG : using testdate: 1447943879 06:37:59 INFO - 2015-11-19 06:37:59,969 DEBUG : actual date: 1447943879 06:38:00 INFO - 2015-11-19 06:38:00,360 INFO : starting webserver on 'localhost:50106' 06:38:00 INFO - 2015-11-19 06:38:00,360 INFO : Starting test suite t-yosemite-r7-0021 06:38:00 INFO - 2015-11-19 06:38:00,361 INFO : Starting test dromaeo_css 06:38:00 INFO - 2015-11-19 06:38:00,361 DEBUG : operating with platform_type : mac_ 06:38:00 INFO - 2015-11-19 06:38:00,362 INFO : Initialising browser for dromaeo_css test... 06:38:00 INFO - 2015-11-19 06:38:00,374 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmpP6hcgV/profile http://localhost:50106/getInfo.html 06:38:02 INFO - 2015-11-19 06:38:02,318 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:38:02 INFO - 2015-11-19 06:38:02,318 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:38:02 INFO - 2015-11-19 06:38:02,319 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:38:02 INFO - 2015-11-19 06:38:02,319 DEBUG : BROWSER_OUTPUT: __metrics 06:38:02 INFO - 2015-11-19 06:38:02,326 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:03 INFO - 2015-11-19 06:38:03,143 INFO : Browser initialized. 06:38:03 INFO - 2015-11-19 06:38:03,143 INFO : Running cycle 1/1 for dromaeo_css test... 06:38:03 INFO - 2015-11-19 06:38:03,144 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmpP6hcgV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:38:14 INFO - 2015-11-19 06:38:14,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 225263616 06:38:14 INFO - 2015-11-19 06:38:14,939 DEBUG : BROWSER_OUTPUT: 06:39:06 INFO - 2015-11-19 06:39:06,295 DEBUG : BROWSER_OUTPUT: 1447943946286 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] 06:41:16 INFO - 2015-11-19 06:41:16,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50106/tests/dromaeo/cssquery-ext.html) 06:41:17 INFO - 2015-11-19 06:41:17,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 330149888 06:41:17 INFO - 2015-11-19 06:41:17,438 DEBUG : BROWSER_OUTPUT: 06:44:20 INFO - 2015-11-19 06:44:20,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/dromaeo/cssquery-ext.html (next: http://localhost:50106/tests/dromaeo/cssquery-jquery.html) 06:44:20 INFO - 2015-11-19 06:44:20,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 362131456 06:44:20 INFO - 2015-11-19 06:44:20,675 DEBUG : BROWSER_OUTPUT: 06:47:22 INFO - 2015-11-19 06:47:22,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50106/tests/dromaeo/cssquery-mootools.html) 06:47:23 INFO - 2015-11-19 06:47:23,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 333258752 06:47:23 INFO - 2015-11-19 06:47:23,239 DEBUG : BROWSER_OUTPUT: 06:50:25 INFO - 2015-11-19 06:50:25,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50106/tests/dromaeo/cssquery-prototype.html) 06:50:25 INFO - 2015-11-19 06:50:25,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 321273856 06:50:25 INFO - 2015-11-19 06:50:25,891 DEBUG : BROWSER_OUTPUT: 06:53:28 INFO - 2015-11-19 06:53:28,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50106/tests/dromaeo/cssquery-yui.html) 06:53:29 INFO - 2015-11-19 06:53:29,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 322736128 06:53:29 INFO - 2015-11-19 06:53:29,430 DEBUG : BROWSER_OUTPUT: 06:56:31 INFO - 2015-11-19 06:56:31,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/dromaeo/cssquery-yui.html (next: http://localhost:50106/tests/dromaeo/cssquery-dojo.html) 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 361259008 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:56:32 INFO - 2015-11-19 06:56:32,034 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3420.828958552072;3481.4603736420863;3497.3005398920222;3498;3541.98229008855;5687.800926967557;5785.566082543815;5873.148393482942;5881.911771323428;5893.1454939033865;5838.474537291653;5911.88176236475;5921.644701317924;5990.940090599092;5995.640261584297;5315.920261196085;5332.626716129873;5368.570514358842;5424.213489044087;5436.755346009439;4537.70504917181;5307.310049693534;5376.381716102659;5437.157240627689;5480.725963701819;5417.133258678612;5492.038893193695;5499.890002199953;5501.669899806005;5503.147012213113;5285.392179899322;5397.190421436777;5460.426655201187;5476.835694929138;5497.917531237034;5357.544608708265;5368.597355198376;5371.75827087782;5382.8923421531745;5396.865078373033;5773.740181691834;5796.942030579682;5797.652140871562;5797.797077102281;5824.708764561798;6144.477719393857;6292.4966002719675;6313.463355614778;6380.138681278015;6416.037594360837;6274.121622972787;6341.746330146789;6356.459700925427;6366.522510811661;6378.107065010902;6006.429389208019;6034.306054803666;6042.486388656969;6047.425494578096;6056;6280.466160376328;6397.360263973565;6399.872002560016;6400.871982560323;6461.61230326182;6273.8745225095245;6282.371762823681;6296.653684047421;6298.149749783812;6301.873962520724;6287.056941458726;6344.777932772331;6420;6421;6436.903446448307;6402.039694045838;6433.420992110732;6439.420452159235;6440.903386449207;6449;6214.782482613087;6350.174477317919;6417.454516366068;6444.291127975919;6447.6131432114225;5003.849884503471;5005.149124648746;5005.3242812220615;5008.248762685554;5009.499050095034;4427.734335939789;4495.955040449619;4547.15877562652;4557.886052848639;4607.401037865123;5916.970415147896;5967.045272756425;5968.820935371946;5975.163477113208;5986.102084687332;5809.9419005809405;6094.268687757409;6382.936170638327;6384.680765961683;6398.712057957403;5726.0838265877255;5823.883522329615;5856.59003869725;5901.085331773582;5978.5814992950945;5527.972360138254;5531.308586426697;5560.471755183251;5581.5255703265675;5582.24639673647;6450.29128736016;6451;6458.967705161538;6491.8701625967215;6500.707468163944;6250.843728906813;6372.171617689671;6372.713227904663;6388.456981156468;6394.456471199814;6369.108324834619;6369.33122022181;6372.6495042773095;6435.581687190318;6436.066770318372;6400.359964003563;6418.101465794699;6419.133416988647;6419.582727122722;6431.83920401975;6241.812745617639;6267.843303917439;6385.680715964276;6407.615543067431;6409.134766806608;6139.058058263141;6203.100550420254;6221.440070393686;6264.530160238091;6295;6258.499320054294;6259.2488901332135;6263.561550691408;6271.9686401569525;6276.089966954674;5932.614380065282;6152.876942461216;6167.660778657217;6175.907361389673;6183.165272688129;6117.3707050999965;6174.8147555573405;6199;6251.937480625135;6286;6167.629942203482;6200.534959878118;6226.657533835682;6232.594881332699;6242.094896240111 06:56:32 INFO - 2015-11-19 06:56:32,036 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.6281544127676;556.9192467092274;565.3357305166428;582.2111039541419;619.7459041792864;31171;31546;39476.60523394769;40184.79907600465;40268.597314026854;42220.78889605555;42643.57356426435;42657.57342426575;42715;42772.358414623806;8712.477251364906;9722.562484688206;9892.604295828158;9934;9936.701898943043;8733.694320698776;8824.205821476098;8836.381453298272;11929.224600400947;12031.037516998664;11737.589184378548;11817.645470635895;11828.994535464495;11831.349275789828;11844.94077529611;8873.73378798637;11713.180077394543;11834.585789497412;11864.169508134433;11916.702082447922;8679.956600217021;11805.763884722342;11930.284182949052;11933.701657458632;11966.760664786743;39791.60208397937;40318.39522407137;40327.193456131004;40355.798221009;40443.39334909979;3256.674332566748;3320.169957510622;3321.3191295784304;3331.683490068464;3376.0547046826928;27996.720032799818;28266.858665706746;28421.873593904653;28532.144035678964;28672.71327286721;2200.966985495219;2670.359113812671;2672.997625890291;2679.9598006029923;2725.1184834123205;503450;508152;508680;508984.4550777259;509590;59084.70457647684;59822.70088649529;60008.699956499935;63608;64140.679296603215;72483;73245;73283;73435.63282183555;73462.63268683622;15985.44050958211;16349.673006539802;16364.754528682079;16374.263158157912;16383.59041023984;12346.197497162655;12465.750684986431;12486.625401237978;12497.375131243401;12509.061820363328;15721.528354149394;19273.28122268539;19429.61140777205;19429.947412673784;19555.92442415681;6296.496280297565;8074.232947869943;8293.295069919124;8311;8631.050584435707;923.89375221849;998.9950050249702;1001.9949900250452;1106.8616422947132;1198.766240583078;25662.871685641454;30195.849020754755;30996.380072398424;31108;31168;1066.8453074304182;1089.6894385100209;1105.4362275239525;1149.8390225368455;1158.9942050289694;14364.784528232085;14388.24487186529;14462.783058254134;14791.408343666348;14855.440178781288;510762;512628;517500;518553;519564;54648.45351546513;54656.45343546593;54752.726236368566;54896.725516372964;55097.724511377186;1476.8259233909068;1478.7633978563379;1497.4384605772834;1501.0018337805236;1620.8865379423562;28290.434191315646;28381;28847.711522885344;28897.711022889504;28962.855185723936;54417;55845.16232256438;55876.99999999837;55951.720241398536;55997;338729;371536;377129;377500.2249977465;377916;29012;32729.836350818092;33142.502862457564;33271.50092748562;33346.33307333888;40716.79641601773;41277.38083928683;41373.586264136975;41821.79089104657;41870.1625967485;35445.64554354423;36453;37090.25819483649;37209.6279037217;37392.62607373892;28992;29722.811087556256;34872;35542.822285888404;36393.818030910734;34331.970040898814;35081.473777893865;35107.824460877535;35260.82369588136;35313.64686353206;24483.755162448146;29823;32408.703651854605;32495.35009299848;34264.31471370509;24110;24119.91460384322;24409.145679901118;24684.889179986585;24747 06:56:32 INFO - 2015-11-19 06:56:32,037 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.96931760800317;362.15075647606363;367.52772687097087;368.4896418460431;371.6302279232163;10631.84052239217;11007.348897665353;12365.072619553535;12778.808317875228;19174.328898488555;10795.78408431831;10913.017828395443;12598.622041338751;12618;12627.295315132455;4274.422952901357;4746.24060150376;4843.78202980865;4859.343988561534;4863.36776219091;3650.7809531428065;3743.4010558310674;3753.4369844523267;4840.685355451902;5147.459516750743;5220.712860792655;5235.633505654606;5236.266922630834;5238.083335416306;5241.554467870235;5112.948870511284;5193.272941788153;5208.479152084799;5211.218317252424;5226.163813789794;4379.540148284448;4387.583179597933;4387.714798538085;4394.121175764828;4396.824127034914;13833.723325533432;13956.93021534896;14278.000539962206;14278.357473913595;14306.928465357607;1951.834094102003;2019.091408866016;2057.9794202058088;2149.548594795079;2170.696102545645;9816.901830981671;9983.600655973753;10323.48382580868;10359.223058270585;10381.169506439543;1538.4538488836527;1592.4585640882156;1595.5293188509418;1627.8372162783746;1646.6706658668195;87269;90472.54763726139;91229.54385228097;92224;92630;6836.897446538306;6874;6908.412784913338;6937.271586483447;6960.895586566206;7767;7780.377569794403;7787.493812902257;7788.299053085249;7796.415268854858;5707.6575405475805;5779.826605201851;5828.125781132864;5828.6211396259105;5837;6202.34875338083;6236.594621349598;6291.087792270187;6296.024116261987;6296.0555916612875;3024.848757562157;3063.1423201503617;3084.228942764309;3087.3979573983306;3089.9957513808104;1085.1427372375892;1088.1621151713136;1132.898039176478;1149.6148790155391;1173.3487914207697;441.8232706917195;444.97775111244306;449.2407830765995;468.4542507978167;495.91817350136824;11839.408029598486;12005.579804706793;12411.689707757378;12450.688732781571;12466.940310073745;426.8378016353766;481.79764498910544;486.7128394247411;513.1379282804924;521.6374619639314;5528.115501519737;6412.775552855627;6487.670027644322;6545.5090868184125;6652.600843949379;736196;748003;755134;775927;781321;103887;106028;109053;109198;113804.43097784457;531.3570579598652;532.6511135206446;534.6230907210407;534.8529154482549;537;11548.42257887119;11665.475053622777;11754.471048802654;11791.29252244868;12041.45813438415;39507;47713.52286477091;48480;48522.5147748518;48612.81242344032;62602.06096908459;63036;65581.68836623336;67549.66225168842;68322.65838670974;6267.561270711007;6485.805425837232;6583.275839657538;6623.4038936495945;6631.6684165792485;12223.816642750187;12519.436625351698;12557;12617.369131543202;12705.809412858629;10864.185186110915;11058.668239952814;11149.219554631423;11171.66485005451;11184.832227516432;10737.892621074001;10821.891781082404;10833.674989750005;10913.290636108628;10947.397893115955;7960.880586791087;8506.829863402822;8657.571500702314;10991.890081099407;11245.7750844981;6424.229092508929;6508.967455162694;6513.54405191632;6518.054882042172;6518.152640156749;10638.84041739359;10700.625478108228;11022.834657479983;11043.83434248503;11065.336079835235 06:56:32 INFO - 2015-11-19 06:56:32,042 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1613.4191690991245;1653.1486284563443;1921.8174273444026;1957.6769832977554;1967.2622766462578;7569.65936532856;8030.759077227685;8223.095459499458;8572.571371431419;8582.399232053758;8324.08435072143;8483.321334293258;8485.321174306056;8500.574971251428;8508.61711222995;2147.871127732333;2189.5730332585154;2369.609014512603;2388.677528533643;2404.5671779079757;2207.580559693661;2366.065404165354;2414.6498757680124;2416.4683769570665;2418.032786885251;2363.5745565798147;2393.8204634652384;2398.760123987605;2413.79482743967;2420.9273721788372;2089.8119169274764;2157.2018353209414;2380.1669415704364;2392.9710224603414;2429.854208747472;2390.4621460171325;2430.781229689319;2431.4043059450546;2431.4407686232266;2434.57394955882;8238.83522329556;8316;8375.37184711143;8376.748697539084;8397.076321604618;5104.923426148611;5156.613254005964;5182.807954170524;5227.555657769094;5237.13587258102;3510.1926556891804;3590.8025058621765;3594.2272411431404;3610.4042832932537;3638.7634803737674;1043.797587091237;1051.7265510967127;1086.706589220906;1094.3980810554162;1096.3038470571164;11110.777784444346;11175.497102630483;11179.83230251547;11189.832152517718;11199.328040317607;4599.9080018399445;4693.741844198534;4731.858044258678;4743.952560474351;4751.691140075884;9839;9850;9873.901260987443;9901.900980990098;9903.356281841658;5287.286216360742;5298.549623281987;5300.92048619271;5304.151335786333;5327.600429967691;4667.533246675305;4821.710697358169;4825.445073816486;4829.744266490738;4857.077155340474;3793.506844110303;3797.9430308545393;3802;3823.9044023899623;3838.673712734393;1246.6322434881731;1248.082659245454;1250.8686587908321;1258.4525731306728;1262.7775115796264;1149.1553708024596;1151.228676786555;1259.307380940479;1324.7615429222833;1362.420971087284;7823.452358334862;7861.882071768928;7875.684972601031;7906.723264685824;7931.5637639930355;464.44498823905786;468.3840749414577;493.5927859515914;498.8328909815253;502.28424495094345;6071.210742603434;6140.6929653517145;6203.16257305267;6214.316425193316;6215.974364229852;10071.496425178711;10314.948425257975;10319.122874555596;10335.74160645975;10338.328008679411;9909.752256193653;10077.344972576759;10118.747031324276;10161.644342448126;10180.6436774714;7824.178461261599;7940.325072368798;7981.04227492693;7981.48120372174;7981.640826162837;7505.174430812715;7553.546787192786;7586.3930885527925;7600.733974310872;7630;8858.936927568733;8998.550072496218;9040.367174297737;9040.367174297999;9103.49930753815;9197.448153110567;9442;9455.810883782424;9470.526473676151;9553.140217380469;7341.816454588678;7385;7408.333250007525;7412.592307423143;7422.70309187648;6405.487560995202;8006.799830004064;8026.117127116129;8027.919720802951;8047.718329858427;7531.736389226351;7538.321551060211;7538.962305188439;7654.349380302514;7675.194104618935;7383.8154046149275;7398.704051838082;7405.44459165554;7423.4803563752175;7550.7734767957045;6418.967905160444;6433.292337842927;7586.431017673586;7596.252861841697;7600.923990760021;6917.066196063467;6928.16861976566;6939.583624982517;6941.895871561829;6945.513814032969;5516.751746171512;6419.903701444576;6480.351964803671;6752.155980502437;6761.290064543349 06:56:32 INFO - 2015-11-19 06:56:32,042 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.5786888192184;318.306092717875;330.62474091905693;330.73210699333544;339.2637975592963;5600.355959064698;6688.531802773801;6940.548864323821;6975.651217439126;6987.7204911803465;6120.47975922046;6894.44844412447;6908.481863860218;6911.032455456228;6914.204866440361;4795.784189711454;4898.975505122469;4906.362172917534;5052.216906379517;5070.416902056256;4265.360195970598;4721.13515161511;4859.684120532172;4890.193118135503;5030.798768049273;4951.084049450845;4951.455339912607;4952.257161425779;4957.206846904496;4971.05549945511;4723.031778485402;4945.085159245551;4964.801407943678;4970.15507363749;4975.27858460523;3453.7582369234165;4053.27041132596;4167.9583204167875;4172.436721042651;4189.329707246857;6314.842128946767;6444.677766111722;6459.83850403739;6462.515311351621;6473.025727153216;5821.09772985188;5832.883342333172;5834.5915785895;5839.7664093436215;5841.269841269841;6163.3528479509905;6993.720251189946;7220.097487814023;7229.313215244543;7249.057622509093;4450.376947227391;4503.887402814923;4527.4114365132655;4538.341940418653;4664.020555683311;7338.889916651255;7426.628668566604;7468.103827540675;7536;7669;4608.907821843544;4673.883152921204;4684.906301873943;4690.273007683814;4739.715617062987;4463.977680111643;4618.35343051973;4760.785764640599;4771.570558649738;4777.617790576745;5670.716464176775;5685.971570142123;5698.116791897262;5699.857503562361;5703.344115426696;7131.786046418616;7137.10786151731;7137.644577289586;7142.250063743232;7143.1428228612895;1651.8678505719513;1675.9497215083568;1676.6898123847127;1677.3206851225273;1682.142107525171;1048.4286064095086;1069.235496619905;1077.5743581285349;1084.7993121272589;1093.6227001684406;6789.0834737310815;6791.830204244835;6807.727690892309;6811.4550835933005;6811.693473793691;7474.177840437547;7478.850422991619;7512.436567257478;7518.962405187939;7525.548467091992;5410.83767486976;6386.744530218833;6760.1549806274215;6777.220619628707;6781.62701051437;3528.1708798432346;4021.376686613521;4021.959780402217;4023.376376661622;4024.1750441159493;7836.216378362118;7947.9205207948335;7957;7958.08482024563;7963.681452741941;7701.618855483978;7840.41196910234;7884.250996155356;7895.407844411692;7914.366850651934;7899.368050555941;7908.565028923349;7912.960435197787;7917.683292668229;7930.206979302024;7202.7092211984545;7618.352440042659;7621.12357078943;7629.46593738433;7629.7329593463965;5992.250968628921;6852.6916288768125;7386.963065184855;7430.071241094864;7512.098548174254;7147.249538798351;7158.964205179149;7889.881651775113;7903.802404939923;7931.087924888711;4612.446506419251;4707.929381059218;4760.547747963938;4766.856994290177;4777.331173635764;6856.554323968926;6887.896681549681;7537.623118844145;7543.057117860268;7565.508241964475;7223.133224013152;7238.312360325761;7239.348458638748;7239.601821899846;7240.782776516713;7028.191757947697;7215.567065976058;7231;7257.963710181415;7260.927390726025;6657;7086.220515743161;7103.2541583133025;7103.644817758988;7116.288371162842;6325.703230837759;7043.225245222919;7246;7248.27517248292;7259.092613423322;5795.8551036224435;6462.901306777953;7074.752383666547;7097.574145551077;7109.431245500451 06:56:32 INFO - 2015-11-19 06:56:32,043 DEBUG : BROWSER_OUTPUT: |5;yui.html;738.2912404092071;801.3989507869098;820.4134044158429;827.6772058897031;877.4428238068832;14809.925950370247;15235.695286094271;15256.084634921912;15259.465918692847;15290.31193596288;13507.257100859473;13560.728785424286;13958.651033724136;14057.859421405783;14090.57728268151;967.7580604848788;982.8967958364376;989.5200827598609;992.9056739609725;993.1161266472845;954.4941181173989;971.7959228562011;974.7173319737268;975.4537459022935;976.4043933200742;1011.640867492037;1023.2070145637153;1023.9488025598728;1027.044848291089;1029.474967766437;1017.5115944346682;1021.9678125093635;1023.8566600675874;1024.2420608749546;1024.5287167902773;766.337118392592;771.4792515052374;774.4075782026754;776.9417293702995;778.3228591125757;13090.738185236338;13132.606021819362;13287.86712132876;13297.86702132976;13324.666883327898;10870.293430927044;10905.618303359424;11114.444277786159;11228.214025018171;11378.146639002025;9356.017618150065;9528.333016688835;9542.61829526825;9558.2831287653;9590.232781377543;3442.8794992175403;3480.129967508123;3484.61669216386;3484.9477257841154;3487.616362200156;54654.255319149146;58735.53161170962;65097;65122.674386628234;65305.693886122484;7120.1099862517185;7158.677859496335;7245.673944672502;7371.741989030465;7431.85136297271;11216.775664486664;12591.433385497674;12656.177348472504;12692.492300307884;12702.618921432371;6521.152250207538;6613.404793568506;6652.933470665328;6673.799786006428;6865.862682746317;4049.1294371710223;4140.254754144283;4155.314373128461;4179.1432756284885;4333.609975102256;3107.1610665120293;3114.5483904833673;3149.4960806270888;3154.069549482908;3187.7609179311644;419.56365380004456;512.4721536817084;519.0889988070987;519.581736701951;526.7418964707266;488.7849346287622;509.27428414509177;512.1140427061205;550.243415303957;606.9544784141119;8441.577921104043;8548.48709077445;8606.87089693655;8616.741497755078;8754.518501482353;513.1532970598468;518.5100080423963;608.9482393996472;635.9745610175542;645.0421124629921;4029.476168098187;4055.3916912463364;4074.796260186979;4110.157417729359;4190.937135942963;101191.49404253079;101700.49149754204;101742;103290.48354758178;104263.4786826061;79360;79982.20017799748;80275;82259.5887020561;82857.75713364304;44144;66967.66516167388;67135.32161695899;68293;73563.26436735564;8771.386002979985;8865.822683546421;8988.55057247122;9060.818783624423;9080.83943871849;49261.507384925695;49527.51417457482;50502;50579.24131137962;51218.74390628023;66515.33484665092;67973.32026679868;68291.65854170697;69389.95915061177;69547.95678064934;6804.319568043156;7687.192844751445;7785.883211751941;7828.334591559554;7894.763157105296;12027.699307517381;12101.576444824388;12173.634790956285;12251.203671761306;12627.305498197687;11272.323660580392;11363.37501437429;11497.770044599229;11564.94217528907;12085;11272.267302625303;11675;11705.765884682429;11966.880331196577;12324.753504929671;11023.559057637605;11321.830172547254;11354.886451135382;11387.601433949772;11665;9622.615095396386;9803.656872009446;9909.869378083748;9949.751256218653;10107.3430227035;9471;10029.899701003189;10030.699079027641;10036.297459177787;10255.846162307422 06:56:32 INFO - 2015-11-19 06:56:32,043 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:56:32 INFO - 2015-11-19 06:56:32,043 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1173 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: __startTimestamp1447944992030__endTimestamp 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,044 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5897.76 Median:6167.63 stddev:644.95 (10.5%) stddev-sans-first:616.96 06:56:32 INFO - 2015-11-19 06:56:32,045 DEBUG : BROWSER_OUTPUT: Values: 3420.8 3481.5 3497.3 3498.0 3542.0 5687.8 5785.6 5873.1 5881.9 5893.1 5838.5 5911.9 5921.6 5990.9 5995.6 5315.9 5332.6 5368.6 5424.2 5436.8 4537.7 5307.3 5376.4 5437.2 5480.7 5417.1 5492.0 5499.9 5501.7 5503.1 5285.4 5397.2 5460.4 5476.8 5497.9 5357.5 5368.6 5371.8 5382.9 5396.9 5773.7 5796.9 5797.7 5797.8 5824.7 6144.5 6292.5 6313.5 6380.1 6416.0 6274.1 6341.7 6356.5 6366.5 6378.1 6006.4 6034.3 6042.5 6047.4 6056.0 6280.5 6397.4 6399.9 6400.9 6461.6 6273.9 6282.4 6296.7 6298.1 6301.9 6287.1 6344.8 6420.0 6421.0 6436.9 6402.0 6433.4 6439.4 6440.9 6449.0 6214.8 6350.2 6417.5 6444.3 6447.6 5003.8 5005.1 5005.3 5008.2 5009.5 4427.7 4496.0 4547.2 4557.9 4607.4 5917.0 5967.0 5968.8 5975.2 5986.1 5809.9 6094.3 6382.9 6384.7 6398.7 5726.1 5823.9 5856.6 5901.1 5978.6 5528.0 5531.3 5560.5 5581.5 5582.2 6450.3 6451.0 6459.0 6491.9 6500.7 6250.8 6372.2 6372.7 6388.5 6394.5 6369.1 6369.3 6372.6 6435.6 6436.1 6400.4 6418.1 6419.1 6419.6 6431.8 6241.8 6267.8 6385.7 6407.6 6409.1 6139.1 6203.1 6221.4 6264.5 6295.0 6258.5 6259.2 6263.6 6272.0 6276.1 5932.6 6152.9 6167.7 6175.9 6183.2 6117.4 6174.8 6199.0 6251.9 6286.0 6167.6 6200.5 6226.7 6232.6 6242.1 06:56:32 INFO - 2015-11-19 06:56:32,045 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,046 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:61419.86 Median:171052.53 stddev:124660.79 (72.9%) stddev-sans-first:124926.71 06:56:32 INFO - 2015-11-19 06:56:32,047 DEBUG : BROWSER_OUTPUT: Values: 545.6 556.9 565.3 582.2 619.7 31171.0 31546.0 39476.6 40184.8 40268.6 42220.8 42643.6 42657.6 42715.0 42772.4 8712.5 9722.6 9892.6 9934.0 9936.7 8733.7 8824.2 8836.4 11929.2 12031.0 11737.6 11817.6 11829.0 11831.3 11844.9 8873.7 11713.2 11834.6 11864.2 11916.7 8680.0 11805.8 11930.3 11933.7 11966.8 39791.6 40318.4 40327.2 40355.8 40443.4 3256.7 3320.2 3321.3 3331.7 3376.1 27996.7 28266.9 28421.9 28532.1 28672.7 2201.0 2670.4 2673.0 2680.0 2725.1 503450.0 508152.0 508680.0 508984.5 509590.0 59084.7 59822.7 60008.7 63608.0 64140.7 72483.0 73245.0 73283.0 73435.6 73462.6 15985.4 16349.7 16364.8 16374.3 16383.6 12346.2 12465.8 12486.6 12497.4 12509.1 15721.5 19273.3 19429.6 19429.9 19555.9 6296.5 8074.2 8293.3 8311.0 8631.1 923.9 999.0 1002.0 1106.9 1198.8 25662.9 30195.8 30996.4 31108.0 31168.0 1066.8 1089.7 1105.4 1149.8 1159.0 14364.8 14388.2 14462.8 14791.4 14855.4 510762.0 512628.0 517500.0 518553.0 519564.0 54648.5 54656.5 54752.7 54896.7 55097.7 1476.8 1478.8 1497.4 1501.0 1620.9 28290.4 28381.0 28847.7 28897.7 28962.9 54417.0 55845.2 55877.0 55951.7 55997.0 338729.0 371536.0 377129.0 377500.2 377916.0 29012.0 32729.8 33142.5 33271.5 33346.3 40716.8 41277.4 41373.6 41821.8 41870.2 35445.6 36453.0 37090.3 37209.6 37392.6 28992.0 29722.8 34872.0 35542.8 36393.8 34332.0 35081.5 35107.8 35260.8 35313.6 24483.8 29823.0 32408.7 32495.4 34264.3 24110.0 24119.9 24409.1 24684.9 24747.0 06:56:32 INFO - 2015-11-19 06:56:32,047 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,047 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:35506.91 Median:2419.32 stddev:125058.07 (5169.1%) stddev-sans-first:125381.04 06:56:32 INFO - 2015-11-19 06:56:32,048 DEBUG : BROWSER_OUTPUT: Values: 361.0 362.2 367.5 368.5 371.6 10631.8 11007.3 12365.1 12778.8 19174.3 10795.8 10913.0 12598.6 12618.0 12627.3 4274.4 4746.2 4843.8 4859.3 4863.4 3650.8 3743.4 3753.4 4840.7 5147.5 5220.7 5235.6 5236.3 5238.1 5241.6 5112.9 5193.3 5208.5 5211.2 5226.2 4379.5 4387.6 4387.7 4394.1 4396.8 13833.7 13956.9 14278.0 14278.4 14306.9 1951.8 2019.1 2058.0 2149.5 2170.7 9816.9 9983.6 10323.5 10359.2 10381.2 1538.5 1592.5 1595.5 1627.8 1646.7 87269.0 90472.5 91229.5 92224.0 92630.0 6836.9 6874.0 6908.4 6937.3 6960.9 7767.0 7780.4 7787.5 7788.3 7796.4 5707.7 5779.8 5828.1 5828.6 5837.0 6202.3 6236.6 6291.1 6296.0 6296.1 3024.8 3063.1 3084.2 3087.4 3090.0 1085.1 1088.2 1132.9 1149.6 1173.3 441.8 445.0 449.2 468.5 495.9 11839.4 12005.6 12411.7 12450.7 12466.9 426.8 481.8 486.7 513.1 521.6 5528.1 6412.8 6487.7 6545.5 6652.6 736196.0 748003.0 755134.0 775927.0 781321.0 103887.0 106028.0 109053.0 109198.0 113804.4 531.4 532.7 534.6 534.9 537.0 11548.4 11665.5 11754.5 11791.3 12041.5 39507.0 47713.5 48480.0 48522.5 48612.8 62602.1 63036.0 65581.7 67549.7 68322.7 6267.6 6485.8 6583.3 6623.4 6631.7 12223.8 12519.4 12557.0 12617.4 12705.8 10864.2 11058.7 11149.2 11171.7 11184.8 10737.9 10821.9 10833.7 10913.3 10947.4 7960.9 8506.8 8657.6 10991.9 11245.8 6424.2 6509.0 6513.5 6518.1 6518.2 10638.8 10700.6 11022.8 11043.8 11065.3 06:56:32 INFO - 2015-11-19 06:56:32,049 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,049 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5833.94 Median:5299.74 stddev:3055.31 (57.7%) stddev-sans-first:3047.41 06:56:32 INFO - 2015-11-19 06:56:32,050 DEBUG : BROWSER_OUTPUT: Values: 1613.4 1653.1 1921.8 1957.7 1967.3 7569.7 8030.8 8223.1 8572.6 8582.4 8324.1 8483.3 8485.3 8500.6 8508.6 2147.9 2189.6 2369.6 2388.7 2404.6 2207.6 2366.1 2414.6 2416.5 2418.0 2363.6 2393.8 2398.8 2413.8 2420.9 2089.8 2157.2 2380.2 2393.0 2429.9 2390.5 2430.8 2431.4 2431.4 2434.6 8238.8 8316.0 8375.4 8376.7 8397.1 5104.9 5156.6 5182.8 5227.6 5237.1 3510.2 3590.8 3594.2 3610.4 3638.8 1043.8 1051.7 1086.7 1094.4 1096.3 11110.8 11175.5 11179.8 11189.8 11199.3 4599.9 4693.7 4731.9 4744.0 4751.7 9839.0 9850.0 9873.9 9901.9 9903.4 5287.3 5298.5 5300.9 5304.2 5327.6 4667.5 4821.7 4825.4 4829.7 4857.1 3793.5 3797.9 3802.0 3823.9 3838.7 1246.6 1248.1 1250.9 1258.5 1262.8 1149.2 1151.2 1259.3 1324.8 1362.4 7823.5 7861.9 7875.7 7906.7 7931.6 464.4 468.4 493.6 498.8 502.3 6071.2 6140.7 6203.2 6214.3 6216.0 10071.5 10314.9 10319.1 10335.7 10338.3 9909.8 10077.3 10118.7 10161.6 10180.6 7824.2 7940.3 7981.0 7981.5 7981.6 7505.2 7553.5 7586.4 7600.7 7630.0 8858.9 8998.6 9040.4 9040.4 9103.5 9197.4 9442.0 9455.8 9470.5 9553.1 7341.8 7385.0 7408.3 7412.6 7422.7 6405.5 8006.8 8026.1 8027.9 8047.7 7531.7 7538.3 7539.0 7654.3 7675.2 7383.8 7398.7 7405.4 7423.5 7550.8 6419.0 6433.3 7586.4 7596.3 7600.9 6917.1 6928.2 6939.6 6941.9 6945.5 5516.8 6419.9 6480.4 6752.2 6761.3 06:56:32 INFO - 2015-11-19 06:56:32,050 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,050 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5866.42 Median:6724.34 stddev:1905.85 (28.3%) stddev-sans-first:1864.39 06:56:32 INFO - 2015-11-19 06:56:32,050 DEBUG : BROWSER_OUTPUT: Values: 273.6 318.3 330.6 330.7 339.3 5600.4 6688.5 6940.5 6975.7 6987.7 6120.5 6894.4 6908.5 6911.0 6914.2 4795.8 4899.0 4906.4 5052.2 5070.4 4265.4 4721.1 4859.7 4890.2 5030.8 4951.1 4951.5 4952.3 4957.2 4971.1 4723.0 4945.1 4964.8 4970.2 4975.3 3453.8 4053.3 4168.0 4172.4 4189.3 6314.8 6444.7 6459.8 6462.5 6473.0 5821.1 5832.9 5834.6 5839.8 5841.3 6163.4 6993.7 7220.1 7229.3 7249.1 4450.4 4503.9 4527.4 4538.3 4664.0 7338.9 7426.6 7468.1 7536.0 7669.0 4608.9 4673.9 4684.9 4690.3 4739.7 4464.0 4618.4 4760.8 4771.6 4777.6 5670.7 5686.0 5698.1 5699.9 5703.3 7131.8 7137.1 7137.6 7142.3 7143.1 1651.9 1675.9 1676.7 1677.3 1682.1 1048.4 1069.2 1077.6 1084.8 1093.6 6789.1 6791.8 6807.7 6811.5 6811.7 7474.2 7478.9 7512.4 7519.0 7525.5 5410.8 6386.7 6760.2 6777.2 6781.6 3528.2 4021.4 4022.0 4023.4 4024.2 7836.2 7947.9 7957.0 7958.1 7963.7 7701.6 7840.4 7884.3 7895.4 7914.4 7899.4 7908.6 7913.0 7917.7 7930.2 7202.7 7618.4 7621.1 7629.5 7629.7 5992.3 6852.7 7387.0 7430.1 7512.1 7147.2 7159.0 7889.9 7903.8 7931.1 4612.4 4707.9 4760.5 4766.9 4777.3 6856.6 6887.9 7537.6 7543.1 7565.5 7223.1 7238.3 7239.3 7239.6 7240.8 7028.2 7215.6 7231.0 7258.0 7260.9 6657.0 7086.2 7103.3 7103.6 7116.3 6325.7 7043.2 7246.0 7248.3 7259.1 5795.9 6462.9 7074.8 7097.6 7109.4 06:56:32 INFO - 2015-11-19 06:56:32,050 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,050 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17525.27 Median:50540.62 stddev:25516.72 (50.5%) stddev-sans-first:25557.16 06:56:32 INFO - 2015-11-19 06:56:32,051 DEBUG : BROWSER_OUTPUT: Values: 738.3 801.4 820.4 827.7 877.4 14809.9 15235.7 15256.1 15259.5 15290.3 13507.3 13560.7 13958.7 14057.9 14090.6 967.8 982.9 989.5 992.9 993.1 954.5 971.8 974.7 975.5 976.4 1011.6 1023.2 1023.9 1027.0 1029.5 1017.5 1022.0 1023.9 1024.2 1024.5 766.3 771.5 774.4 776.9 778.3 13090.7 13132.6 13287.9 13297.9 13324.7 10870.3 10905.6 11114.4 11228.2 11378.1 9356.0 9528.3 9542.6 9558.3 9590.2 3442.9 3480.1 3484.6 3484.9 3487.6 54654.3 58735.5 65097.0 65122.7 65305.7 7120.1 7158.7 7245.7 7371.7 7431.9 11216.8 12591.4 12656.2 12692.5 12702.6 6521.2 6613.4 6652.9 6673.8 6865.9 4049.1 4140.3 4155.3 4179.1 4333.6 3107.2 3114.5 3149.5 3154.1 3187.8 419.6 512.5 519.1 519.6 526.7 488.8 509.3 512.1 550.2 607.0 8441.6 8548.5 8606.9 8616.7 8754.5 513.2 518.5 608.9 636.0 645.0 4029.5 4055.4 4074.8 4110.2 4190.9 101191.5 101700.5 101742.0 103290.5 104263.5 79360.0 79982.2 80275.0 82259.6 82857.8 44144.0 66967.7 67135.3 68293.0 73563.3 8771.4 8865.8 8988.6 9060.8 9080.8 49261.5 49527.5 50502.0 50579.2 51218.7 66515.3 67973.3 68291.7 69390.0 69548.0 6804.3 7687.2 7785.9 7828.3 7894.8 12027.7 12101.6 12173.6 12251.2 12627.3 11272.3 11363.4 11497.8 11564.9 12085.0 11272.3 11675.0 11705.8 11966.9 12324.8 11023.6 11321.8 11354.9 11387.6 11665.0 9622.6 9803.7 9909.9 9949.8 10107.3 9471.0 10029.9 10030.7 10036.3 10255.8 06:56:32 INFO - 2015-11-19 06:56:32,052 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:56:32 INFO - 2015-11-19 06:56:32,052 DEBUG : BROWSER_OUTPUT: 06:56:32 INFO - 2015-11-19 06:56:32,483 INFO : Browser exited with error code: 0 06:56:32 INFO - 2015-11-19 06:56:32,509 INFO : Completed test dromaeo_css (00:18:32) 06:56:32 INFO - 2015-11-19 06:56:32,509 INFO : Starting test kraken 06:56:32 INFO - 2015-11-19 06:56:32,509 DEBUG : operating with platform_type : mac_ 06:56:32 INFO - 2015-11-19 06:56:32,510 INFO : Initialising browser for kraken test... 06:56:32 INFO - 2015-11-19 06:56:32,522 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmp2dUFfd/profile http://localhost:50106/getInfo.html 06:56:34 INFO - 2015-11-19 06:56:34,504 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:56:34 INFO - 2015-11-19 06:56:34,504 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:56:34 INFO - 2015-11-19 06:56:34,504 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:56:34 INFO - 2015-11-19 06:56:34,504 DEBUG : BROWSER_OUTPUT: __metrics 06:56:34 INFO - 2015-11-19 06:56:34,519 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:34 INFO - 2015-11-19 06:56:34,797 DEBUG : BROWSER_OUTPUT: console.error: 06:56:34 INFO - 2015-11-19 06:56:34,800 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 06:56:34 INFO - 2015-11-19 06:56:34,800 DEBUG : BROWSER_OUTPUT: Stack: 06:56:34 INFO - 2015-11-19 06:56:34,800 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 06:56:34 INFO - 2015-11-19 06:56:34,800 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 06:56:34 INFO - 2015-11-19 06:56:34,800 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 06:56:34 INFO - 2015-11-19 06:56:34,800 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 06:56:34 INFO - 2015-11-19 06:56:34,801 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 06:56:34 INFO - 2015-11-19 06:56:34,801 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 06:56:34 INFO - 2015-11-19 06:56:34,801 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:56:34 INFO - 2015-11-19 06:56:34,801 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 06:56:34 INFO - 2015-11-19 06:56:34,801 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:56:34 INFO - 2015-11-19 06:56:34,801 DEBUG : BROWSER_OUTPUT: 06:56:35 INFO - 2015-11-19 06:56:35,368 INFO : Browser initialized. 06:56:35 INFO - 2015-11-19 06:56:35,369 INFO : Running cycle 1/1 for kraken test... 06:56:35 INFO - 2015-11-19 06:56:35,369 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmp2dUFfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:56:47 INFO - 2015-11-19 06:56:47,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 226467840 06:56:47 INFO - 2015-11-19 06:56:47,171 DEBUG : BROWSER_OUTPUT: 06:56:49 INFO - 2015-11-19 06:56:49,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50106/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:50 INFO - 2015-11-19 06:56:50,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 276746240 06:56:50 INFO - 2015-11-19 06:56:50,269 DEBUG : BROWSER_OUTPUT: 06:56:52 INFO - 2015-11-19 06:56:52,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50106/tests/kraken/driver.html?testName=audio-dft) 06:56:53 INFO - 2015-11-19 06:56:53,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 289169408 06:56:53 INFO - 2015-11-19 06:56:53,451 DEBUG : BROWSER_OUTPUT: 06:56:56 INFO - 2015-11-19 06:56:56,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50106/tests/kraken/driver.html?testName=audio-fft) 06:56:57 INFO - 2015-11-19 06:56:57,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 273915904 06:56:57 INFO - 2015-11-19 06:56:57,229 DEBUG : BROWSER_OUTPUT: 06:56:59 INFO - 2015-11-19 06:56:59,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50106/tests/kraken/driver.html?testName=audio-oscillator) 06:56:59 INFO - 2015-11-19 06:56:59,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 276774912 06:56:59 INFO - 2015-11-19 06:56:59,666 DEBUG : BROWSER_OUTPUT: 06:57:01 INFO - 2015-11-19 06:57:01,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:02 INFO - 2015-11-19 06:57:02,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 278540288 06:57:02 INFO - 2015-11-19 06:57:02,250 DEBUG : BROWSER_OUTPUT: 06:57:04 INFO - 2015-11-19 06:57:04,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50106/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:05 INFO - 2015-11-19 06:57:05,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 278896640 06:57:05 INFO - 2015-11-19 06:57:05,509 DEBUG : BROWSER_OUTPUT: 06:57:08 INFO - 2015-11-19 06:57:08,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50106/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:08 INFO - 2015-11-19 06:57:08,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 279728128 06:57:08 INFO - 2015-11-19 06:57:08,933 DEBUG : BROWSER_OUTPUT: 06:57:11 INFO - 2015-11-19 06:57:11,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50106/tests/kraken/driver.html?testName=json-parse-financial) 06:57:12 INFO - 2015-11-19 06:57:12,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 280256512 06:57:12 INFO - 2015-11-19 06:57:12,208 DEBUG : BROWSER_OUTPUT: 06:57:13 INFO - 2015-11-19 06:57:13,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:14 INFO - 2015-11-19 06:57:14,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 313827328 06:57:14 INFO - 2015-11-19 06:57:14,325 DEBUG : BROWSER_OUTPUT: 06:57:16 INFO - 2015-11-19 06:57:16,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:16 INFO - 2015-11-19 06:57:16,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 312905728 06:57:16 INFO - 2015-11-19 06:57:16,711 DEBUG : BROWSER_OUTPUT: 06:57:18 INFO - 2015-11-19 06:57:18,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:19 INFO - 2015-11-19 06:57:19,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 322887680 06:57:19 INFO - 2015-11-19 06:57:19,334 DEBUG : BROWSER_OUTPUT: 06:57:21 INFO - 2015-11-19 06:57:21,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:22 INFO - 2015-11-19 06:57:22,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 324571136 06:57:22 INFO - 2015-11-19 06:57:22,481 DEBUG : BROWSER_OUTPUT: 06:57:25 INFO - 2015-11-19 06:57:25,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:25 INFO - 2015-11-19 06:57:25,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 323264512 06:57:25 INFO - 2015-11-19 06:57:25,637 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50106/tests/kraken/driver.html?testName=ai-astar) 06:57:27 INFO - 2015-11-19 06:57:27,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 383430656 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;103;111;110;109;100;111;102;109 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;119;142;153;121;136;120;145;159;147 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;185;179;182;186;186;184;182;186;180 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;71;72;72;54;56;55;73;71;53 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;85;114;74;78;77;108;74;75;109 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;84;86;86;86;85;86;86;88;86 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;94;94;94;94;95;95;93;93;108 06:57:27 INFO - 2015-11-19 06:57:27,586 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;88;87;85;89;85;86;86;87;86;87 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;54;58;56;58;53;63;52;54 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;63;64;66;66;66;65;66;68 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;81;82;80;81;81;80;83;82 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;132;130;127;121;121;123;119;134;120 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;110;140;176;176;135;140;136;137;149 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;64;65;68;94;64;65;64;65 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1058 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945047583__endTimestamp 06:57:27 INFO - 2015-11-19 06:57:27,587 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:57:27 INFO - 2015-11-19 06:57:27,589 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:57:27 INFO - 2015-11-19 06:57:27,589 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,589 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:4.17 (3.8%) stddev-sans-first:4.39 06:57:27 INFO - 2015-11-19 06:57:27,589 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 103.0 111.0 110.0 109.0 100.0 111.0 102.0 109.0 06:57:27 INFO - 2015-11-19 06:57:27,589 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.10 Median:146.00 stddev:14.53 (9.9%) stddev-sans-first:14.96 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: Values: 149.0 119.0 142.0 153.0 121.0 136.0 120.0 145.0 159.0 147.0 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.30 Median:184.50 stddev:2.54 (1.4%) stddev-sans-first:2.69 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: Values: 183.0 185.0 179.0 182.0 186.0 186.0 184.0 182.0 186.0 180.0 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.30 Median:71.00 stddev:8.67 (12.2%) stddev-sans-first:9.17 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: Values: 66.0 71.0 72.0 72.0 54.0 56.0 55.0 73.0 71.0 53.0 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.20 Median:76.00 stddev:16.01 (21.1%) stddev-sans-first:16.98 06:57:27 INFO - 2015-11-19 06:57:27,590 DEBUG : BROWSER_OUTPUT: Values: 88.0 85.0 114.0 74.0 78.0 77.0 108.0 74.0 75.0 109.0 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 86.0 86.0 86.0 85.0 86.0 86.0 88.0 86.0 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.60 Median:94.00 stddev:4.45 (4.7%) stddev-sans-first:4.72 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 94.0 94.0 94.0 95.0 95.0 93.0 93.0 108.0 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.26 (1.5%) stddev-sans-first:1.24 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 85.0 89.0 85.0 86.0 86.0 87.0 86.0 87.0 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,591 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.50 stddev:3.23 (5.6%) stddev-sans-first:3.37 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 54.0 58.0 56.0 58.0 53.0 63.0 52.0 54.0 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:66.00 stddev:1.60 (2.4%) stddev-sans-first:1.64 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 64.0 66.0 66.0 66.0 65.0 66.0 68.0 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:1.03 (1.3%) stddev-sans-first:1.00 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 81.0 82.0 80.0 81.0 81.0 80.0 83.0 82.0 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:128.50 stddev:5.87 (4.6%) stddev-sans-first:5.65 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: Values: 133.0 132.0 130.0 127.0 121.0 121.0 123.0 119.0 134.0 120.0 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,592 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:140.00 stddev:19.77 (14.1%) stddev-sans-first:20.78 06:57:27 INFO - 2015-11-19 06:57:27,594 DEBUG : BROWSER_OUTPUT: Values: 136.0 110.0 140.0 176.0 176.0 135.0 140.0 136.0 137.0 149.0 06:57:27 INFO - 2015-11-19 06:57:27,594 DEBUG : BROWSER_OUTPUT: 06:57:27 INFO - 2015-11-19 06:57:27,594 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:65.00 stddev:9.28 (14.3%) stddev-sans-first:9.79 06:57:27 INFO - 2015-11-19 06:57:27,594 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 64.0 65.0 68.0 94.0 64.0 65.0 64.0 65.0 06:57:27 INFO - 2015-11-19 06:57:27,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:57:27 INFO - 2015-11-19 06:57:27,595 DEBUG : BROWSER_OUTPUT: 06:57:28 INFO - 2015-11-19 06:57:28,222 INFO : Browser exited with error code: 0 06:57:28 INFO - 2015-11-19 06:57:28,270 INFO : Completed test kraken (00:00:55) 06:57:28 INFO - 2015-11-19 06:57:28,270 INFO : Starting test v8_7 06:57:28 INFO - 2015-11-19 06:57:28,270 DEBUG : operating with platform_type : mac_ 06:57:28 INFO - 2015-11-19 06:57:28,270 INFO : Initialising browser for v8_7 test... 06:57:28 INFO - 2015-11-19 06:57:28,283 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmptkV2q8/profile http://localhost:50106/getInfo.html 06:57:30 INFO - 2015-11-19 06:57:30,268 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:57:30 INFO - 2015-11-19 06:57:30,268 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:57:30 INFO - 2015-11-19 06:57:30,268 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:57:30 INFO - 2015-11-19 06:57:30,268 DEBUG : BROWSER_OUTPUT: __metrics 06:57:30 INFO - 2015-11-19 06:57:30,283 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:30 INFO - 2015-11-19 06:57:30,541 DEBUG : BROWSER_OUTPUT: console.error: 06:57:30 INFO - 2015-11-19 06:57:30,542 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 06:57:30 INFO - 2015-11-19 06:57:30,542 DEBUG : BROWSER_OUTPUT: Stack: 06:57:30 INFO - 2015-11-19 06:57:30,542 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 06:57:30 INFO - 2015-11-19 06:57:30,542 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:57:30 INFO - 2015-11-19 06:57:30,543 DEBUG : BROWSER_OUTPUT: 06:57:30 INFO - 2015-11-19 06:57:30,940 INFO : Browser initialized. 06:57:30 INFO - 2015-11-19 06:57:30,940 INFO : Running cycle 1/1 for v8_7 test... 06:57:30 INFO - 2015-11-19 06:57:30,940 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmptkV2q8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:57:42 INFO - 2015-11-19 06:57:42,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 225570816 06:57:42 INFO - 2015-11-19 06:57:42,736 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50106/tests/v8_7/run.html (next: http://localhost:50106/tests/v8_7/run.html) 06:58:04 INFO - 2015-11-19 06:58:04,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 679337984 06:58:04 INFO - 2015-11-19 06:58:04,441 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,441 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:58:04 INFO - 2015-11-19 06:58:04,441 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |0;Richards;145.98540145985402 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.08247422680412 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4835.748792270531 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1731.833910034602 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |6;Boyer;15089.55223880597 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |7;RegExp;26815.78947368421 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |8;Splay;684.4626967830253 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4488.789237668161 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:58:04 INFO - 2015-11-19 06:58:04,442 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945084436__endTimestamp 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:145.99 Median:145.99 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: Values: 146.0 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.08 Median:161.08 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: Values: 161.1 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: Values: 278.3 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,443 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1731.83 Median:1731.83 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: Values: 1731.8 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: Values: 796.2 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15089.55 Median:15089.55 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: Values: 15089.6 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26815.79 Median:26815.79 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: Values: 26815.8 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,444 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:684.46 Median:684.46 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,445 DEBUG : BROWSER_OUTPUT: Values: 684.5 06:58:04 INFO - 2015-11-19 06:58:04,445 DEBUG : BROWSER_OUTPUT: 06:58:04 INFO - 2015-11-19 06:58:04,445 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4488.79 Median:4488.79 stddev:0.00 (0.0%) 06:58:04 INFO - 2015-11-19 06:58:04,445 DEBUG : BROWSER_OUTPUT: Values: 4488.8 06:58:04 INFO - 2015-11-19 06:58:04,445 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:58:04 INFO - 2015-11-19 06:58:04,445 DEBUG : BROWSER_OUTPUT: 06:58:05 INFO - 2015-11-19 06:58:05,098 INFO : Browser exited with error code: 0 06:58:05 INFO - 2015-11-19 06:58:05,116 INFO : Completed test v8_7 (00:00:36) 06:58:05 INFO - 2015-11-19 06:58:05,466 INFO : Completed test suite (00:20:05) 06:58:05 INFO - 2015-11-19 06:58:05,466 DEBUG : Working with test: dromaeo_css 06:58:05 INFO - 2015-11-19 06:58:05,466 DEBUG : Generating results file: dromaeo_css 06:58:05 INFO - 2015-11-19 06:58:05,467 DEBUG : Working with test: kraken 06:58:05 INFO - 2015-11-19 06:58:05,467 DEBUG : Generating results file: kraken 06:58:05 INFO - 2015-11-19 06:58:05,467 INFO : javascript benchmark 06:58:05 INFO - 2015-11-19 06:58:05,467 DEBUG : Working with test: v8_7 06:58:05 INFO - 2015-11-19 06:58:05,467 DEBUG : Generating results file: v8_7 06:58:05 INFO - 2015-11-19 06:58:05,468 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:58:05 INFO - 2015-11-19 06:58:05,870 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 06:58:05 INFO - 2015-11-19 06:58:05,870 DEBUG : process_Request line: dromaeo_css 7171.04 graph.html#tests=[[72,64,59]] 06:58:05 INFO - 2015-11-19 06:58:05,870 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:58:05 INFO - 2015-11-19 06:58:05,915 DEBUG : process_Request line: kraken 1390.40 graph.html#tests=[[232,64,59]] 06:58:05 INFO - 2015-11-19 06:58:05,915 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:58:05 INFO - 2015-11-19 06:58:05,950 DEBUG : process_Request line: v8_7 20236.68 graph.html#tests=[[230,64,59]] 06:58:05 INFO - 2015-11-19 06:58:05,951 INFO : javascript benchmark 06:58:06 INFO - 2015-11-19 06:58:05,953 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3420.828958552072, 3481.4603736420863, 3497.3005398920222, 3498.0, 3541.98229008855, 5687.800926967557, 5785.566082543815, 5873.148393482942, 5881.911771323428, 5893.1454939033865, 5838.474537291653, 5911.88176236475, 5921.644701317924, 5990.940090599092, 5995.640261584297, 5315.920261196085, 5332.626716129873, 5368.570514358842, 5424.213489044087, 5436.755346009439, 4537.70504917181, 5307.310049693534, 5376.381716102659, 5437.157240627689, 5480.725963701819, 5417.133258678612, 5492.038893193695, 5499.890002199953, 5501.669899806005, 5503.147012213113, 5285.392179899322, 5397.190421436777, 5460.426655201187, 5476.835694929138, 5497.917531237034, 5357.544608708265, 5368.597355198376, 5371.75827087782, 5382.8923421531745, 5396.865078373033, 5773.740181691834, 5796.942030579682, 5797.652140871562, 5797.797077102281, 5824.708764561798, 6144.477719393857, 6292.4966002719675, 6313.463355614778, 6380.138681278015, 6416.037594360837, 6274.121622972787, 6341.746330146789, 6356.459700925427, 6366.522510811661, 6378.107065010902, 6006.429389208019, 6034.306054803666, 6042.486388656969, 6047.425494578096, 6056.0, 6280.466160376328, 6397.360263973565, 6399.872002560016, 6400.871982560323, 6461.61230326182, 6273.8745225095245, 6282.371762823681, 6296.653684047421, 6298.149749783812, 6301.873962520724, 6287.056941458726, 6344.777932772331, 6420.0, 6421.0, 6436.903446448307, 6402.039694045838, 6433.420992110732, 6439.420452159235, 6440.903386449207, 6449.0, 6214.782482613087, 6350.174477317919, 6417.454516366068, 6444.291127975919, 6447.6131432114225, 5003.849884503471, 5005.149124648746, 5005.3242812220615, 5008.248762685554, 5009.499050095034, 4427.734335939789, 4495.955040449619, 4547.15877562652, 4557.886052848639, 4607.401037865123, 5916.970415147896, 5967.045272756425, 5968.820935371946, 5975.163477113208, 5986.102084687332, 5809.9419005809405, 6094.268687757409, 6382.936170638327, 6384.680765961683, 6398.712057957403, 5726.0838265877255, 5823.883522329615, 5856.59003869725, 5901.085331773582, 5978.5814992950945, 5527.972360138254, 5531.308586426697, 5560.471755183251, 5581.5255703265675, 5582.24639673647, 6450.29128736016, 6451.0, 6458.967705161538, 6491.8701625967215, 6500.707468163944, 6250.843728906813, 6372.171617689671, 6372.713227904663, 6388.456981156468, 6394.456471199814, 6369.108324834619, 6369.33122022181, 6372.6495042773095, 6435.581687190318, 6436.066770318372, 6400.359964003563, 6418.101465794699, 6419.133416988647, 6419.582727122722, 6431.83920401975, 6241.812745617639, 6267.843303917439, 6385.680715964276, 6407.615543067431, 6409.134766806608, 6139.058058263141, 6203.100550420254, 6221.440070393686, 6264.530160238091, 6295.0, 6258.499320054294, 6259.2488901332135, 6263.561550691408, 6271.9686401569525, 6276.089966954674, 5932.614380065282, 6152.876942461216, 6167.660778657217, 6175.907361389673, 6183.165272688129, 6117.3707050999965, 6174.8147555573405, 6199.0, 6251.937480625135, 6286.0, 6167.629942203482, 6200.534959878118, 6226.657533835682, 6232.594881332699, 6242.094896240111], "unit": "ms", "name": "dojo.html", "value": 5856.631801598232}, {"lowerIsBetter": false, "replicates": [545.6281544127676, 556.9192467092274, 565.3357305166428, 582.2111039541419, 619.7459041792864, 31171.0, 31546.0, 39476.60523394769, 40184.79907600465, 40268.597314026854, 42220.78889605555, 42643.57356426435, 42657.57342426575, 42715.0, 42772.358414623806, 8712.477251364906, 9722.562484688206, 9892.604295828158, 9934.0, 9936.701898943043, 8733.694320698776, 8824.205821476098, 8836.381453298272, 11929.224600400947, 12031.037516998664, 11737.589184378548, 11817.645470635895, 11828.994535464495, 11831.349275789828, 11844.94077529611, 8873.73378798637, 11713.180077394543, 11834.585789497412, 11864.169508134433, 11916.702082447922, 8679.956600217021, 11805.763884722342, 11930.284182949052, 11933.701657458632, 11966.760664786743, 39791.60208397937, 40318.39522407137, 40327.193456131004, 40355.798221009, 40443.39334909979, 3256.674332566748, 3320.169957510622, 3321.3191295784304, 3331.683490068464, 3376.0547046826928, 27996.720032799818, 28266.858665706746, 28421.873593904653, 28532.144035678964, 28672.71327286721, 2200.966985495219, 2670.359113812671, 2672.997625890291, 2679.9598006029923, 2725.1184834123205, 503450.0, 508152.0, 508680.0, 508984.4550777259, 509590.0, 59084.70457647684, 59822.70088649529, 60008.699956499935, 63608.0, 64140.679296603215, 72483.0, 73245.0, 73283.0, 73435.63282183555, 73462.63268683622, 15985.44050958211, 16349.673006539802, 16364.754528682079, 16374.263158157912, 16383.59041023984, 12346.197497162655, 12465.750684986431, 12486.625401237978, 12497.375131243401, 12509.061820363328, 15721.528354149394, 19273.28122268539, 19429.61140777205, 19429.947412673784, 19555.92442415681, 6296.496280297565, 8074.232947869943, 8293.295069919124, 8311.0, 8631.050584435707, 923.89375221849, 998.9950050249702, 1001.9949900250452, 1106.8616422947132, 1198.766240583078, 25662.871685641454, 30195.849020754755, 30996.380072398424, 31108.0, 31168.0, 1066.8453074304182, 1089.6894385100209, 1105.4362275239525, 1149.8390225368455, 1158.9942050289694, 14364.784528232085, 14388.24487186529, 14462.783058254134, 14791.408343666348, 14855.440178781288, 510762.0, 512628.0, 517500.0, 518553.0, 519564.0, 54648.45351546513, 54656.45343546593, 54752.726236368566, 54896.725516372964, 55097.724511377186, 1476.8259233909068, 1478.7633978563379, 1497.4384605772834, 1501.0018337805236, 1620.8865379423562, 28290.434191315646, 28381.0, 28847.711522885344, 28897.711022889504, 28962.855185723936, 54417.0, 55845.16232256438, 55876.99999999837, 55951.720241398536, 55997.0, 338729.0, 371536.0, 377129.0, 377500.2249977465, 377916.0, 29012.0, 32729.836350818092, 33142.502862457564, 33271.50092748562, 33346.33307333888, 40716.79641601773, 41277.38083928683, 41373.586264136975, 41821.79089104657, 41870.1625967485, 35445.64554354423, 36453.0, 37090.25819483649, 37209.6279037217, 37392.62607373892, 28992.0, 29722.811087556256, 34872.0, 35542.822285888404, 36393.818030910734, 34331.970040898814, 35081.473777893865, 35107.824460877535, 35260.82369588136, 35313.64686353206, 24483.755162448146, 29823.0, 32408.703651854605, 32495.35009299848, 34264.31471370509, 24110.0, 24119.91460384322, 24409.145679901118, 24684.889179986585, 24747.0], "unit": "ms", "name": "ext.html", "value": 19797.985178747647}, {"lowerIsBetter": false, "replicates": [360.96931760800317, 362.15075647606363, 367.52772687097087, 368.4896418460431, 371.6302279232163, 10631.84052239217, 11007.348897665353, 12365.072619553535, 12778.808317875228, 19174.328898488555, 10795.78408431831, 10913.017828395443, 12598.622041338751, 12618.0, 12627.295315132455, 4274.422952901357, 4746.24060150376, 4843.78202980865, 4859.343988561534, 4863.36776219091, 3650.7809531428065, 3743.4010558310674, 3753.4369844523267, 4840.685355451902, 5147.459516750743, 5220.712860792655, 5235.633505654606, 5236.266922630834, 5238.083335416306, 5241.554467870235, 5112.948870511284, 5193.272941788153, 5208.479152084799, 5211.218317252424, 5226.163813789794, 4379.540148284448, 4387.583179597933, 4387.714798538085, 4394.121175764828, 4396.824127034914, 13833.723325533432, 13956.93021534896, 14278.000539962206, 14278.357473913595, 14306.928465357607, 1951.834094102003, 2019.091408866016, 2057.9794202058088, 2149.548594795079, 2170.696102545645, 9816.901830981671, 9983.600655973753, 10323.48382580868, 10359.223058270585, 10381.169506439543, 1538.4538488836527, 1592.4585640882156, 1595.5293188509418, 1627.8372162783746, 1646.6706658668195, 87269.0, 90472.54763726139, 91229.54385228097, 92224.0, 92630.0, 6836.897446538306, 6874.0, 6908.412784913338, 6937.271586483447, 6960.895586566206, 7767.0, 7780.377569794403, 7787.493812902257, 7788.299053085249, 7796.415268854858, 5707.6575405475805, 5779.826605201851, 5828.125781132864, 5828.6211396259105, 5837.0, 6202.34875338083, 6236.594621349598, 6291.087792270187, 6296.024116261987, 6296.0555916612875, 3024.848757562157, 3063.1423201503617, 3084.228942764309, 3087.3979573983306, 3089.9957513808104, 1085.1427372375892, 1088.1621151713136, 1132.898039176478, 1149.6148790155391, 1173.3487914207697, 441.8232706917195, 444.97775111244306, 449.2407830765995, 468.4542507978167, 495.91817350136824, 11839.408029598486, 12005.579804706793, 12411.689707757378, 12450.688732781571, 12466.940310073745, 426.8378016353766, 481.79764498910544, 486.7128394247411, 513.1379282804924, 521.6374619639314, 5528.115501519737, 6412.775552855627, 6487.670027644322, 6545.5090868184125, 6652.600843949379, 736196.0, 748003.0, 755134.0, 775927.0, 781321.0, 103887.0, 106028.0, 109053.0, 109198.0, 113804.43097784457, 531.3570579598652, 532.6511135206446, 534.6230907210407, 534.8529154482549, 537.0, 11548.42257887119, 11665.475053622777, 11754.471048802654, 11791.29252244868, 12041.45813438415, 39507.0, 47713.52286477091, 48480.0, 48522.5147748518, 48612.81242344032, 62602.06096908459, 63036.0, 65581.68836623336, 67549.66225168842, 68322.65838670974, 6267.561270711007, 6485.805425837232, 6583.275839657538, 6623.4038936495945, 6631.6684165792485, 12223.816642750187, 12519.436625351698, 12557.0, 12617.369131543202, 12705.809412858629, 10864.185186110915, 11058.668239952814, 11149.219554631423, 11171.66485005451, 11184.832227516432, 10737.892621074001, 10821.891781082404, 10833.674989750005, 10913.290636108628, 10947.397893115955, 7960.880586791087, 8506.829863402822, 8657.571500702314, 10991.890081099407, 11245.7750844981, 6424.229092508929, 6508.967455162694, 6513.54405191632, 6518.054882042172, 6518.152640156749, 10638.84041739359, 10700.625478108228, 11022.834657479983, 11043.83434248503, 11065.336079835235], "unit": "ms", "name": "jquery.html", "value": 7197.511987304342}, {"lowerIsBetter": false, "replicates": [1613.4191690991245, 1653.1486284563443, 1921.8174273444026, 1957.6769832977554, 1967.2622766462578, 7569.65936532856, 8030.759077227685, 8223.095459499458, 8572.571371431419, 8582.399232053758, 8324.08435072143, 8483.321334293258, 8485.321174306056, 8500.574971251428, 8508.61711222995, 2147.871127732333, 2189.5730332585154, 2369.609014512603, 2388.677528533643, 2404.5671779079757, 2207.580559693661, 2366.065404165354, 2414.6498757680124, 2416.4683769570665, 2418.032786885251, 2363.5745565798147, 2393.8204634652384, 2398.760123987605, 2413.79482743967, 2420.9273721788372, 2089.8119169274764, 2157.2018353209414, 2380.1669415704364, 2392.9710224603414, 2429.854208747472, 2390.4621460171325, 2430.781229689319, 2431.4043059450546, 2431.4407686232266, 2434.57394955882, 8238.83522329556, 8316.0, 8375.37184711143, 8376.748697539084, 8397.076321604618, 5104.923426148611, 5156.613254005964, 5182.807954170524, 5227.555657769094, 5237.13587258102, 3510.1926556891804, 3590.8025058621765, 3594.2272411431404, 3610.4042832932537, 3638.7634803737674, 1043.797587091237, 1051.7265510967127, 1086.706589220906, 1094.3980810554162, 1096.3038470571164, 11110.777784444346, 11175.497102630483, 11179.83230251547, 11189.832152517718, 11199.328040317607, 4599.9080018399445, 4693.741844198534, 4731.858044258678, 4743.952560474351, 4751.691140075884, 9839.0, 9850.0, 9873.901260987443, 9901.900980990098, 9903.356281841658, 5287.286216360742, 5298.549623281987, 5300.92048619271, 5304.151335786333, 5327.600429967691, 4667.533246675305, 4821.710697358169, 4825.445073816486, 4829.744266490738, 4857.077155340474, 3793.506844110303, 3797.9430308545393, 3802.0, 3823.9044023899623, 3838.673712734393, 1246.6322434881731, 1248.082659245454, 1250.8686587908321, 1258.4525731306728, 1262.7775115796264, 1149.1553708024596, 1151.228676786555, 1259.307380940479, 1324.7615429222833, 1362.420971087284, 7823.452358334862, 7861.882071768928, 7875.684972601031, 7906.723264685824, 7931.5637639930355, 464.44498823905786, 468.3840749414577, 493.5927859515914, 498.8328909815253, 502.28424495094345, 6071.210742603434, 6140.6929653517145, 6203.16257305267, 6214.316425193316, 6215.974364229852, 10071.496425178711, 10314.948425257975, 10319.122874555596, 10335.74160645975, 10338.328008679411, 9909.752256193653, 10077.344972576759, 10118.747031324276, 10161.644342448126, 10180.6436774714, 7824.178461261599, 7940.325072368798, 7981.04227492693, 7981.48120372174, 7981.640826162837, 7505.174430812715, 7553.546787192786, 7586.3930885527925, 7600.733974310872, 7630.0, 8858.936927568733, 8998.550072496218, 9040.367174297737, 9040.367174297999, 9103.49930753815, 9197.448153110567, 9442.0, 9455.810883782424, 9470.526473676151, 9553.140217380469, 7341.816454588678, 7385.0, 7408.333250007525, 7412.592307423143, 7422.70309187648, 6405.487560995202, 8006.799830004064, 8026.117127116129, 8027.919720802951, 8047.718329858427, 7531.736389226351, 7538.321551060211, 7538.962305188439, 7654.349380302514, 7675.194104618935, 7383.8154046149275, 7398.704051838082, 7405.44459165554, 7423.4803563752175, 7550.7734767957045, 6418.967905160444, 6433.292337842927, 7586.431017673586, 7596.252861841697, 7600.923990760021, 6917.066196063467, 6928.16861976566, 6939.583624982517, 6941.895871561829, 6945.513814032969, 5516.751746171512, 6419.903701444576, 6480.351964803671, 6752.155980502437, 6761.290064543349], "unit": "ms", "name": "mootools.html", "value": 4696.6083607069195}, {"lowerIsBetter": false, "replicates": [273.5786888192184, 318.306092717875, 330.62474091905693, 330.73210699333544, 339.2637975592963, 5600.355959064698, 6688.531802773801, 6940.548864323821, 6975.651217439126, 6987.7204911803465, 6120.47975922046, 6894.44844412447, 6908.481863860218, 6911.032455456228, 6914.204866440361, 4795.784189711454, 4898.975505122469, 4906.362172917534, 5052.216906379517, 5070.416902056256, 4265.360195970598, 4721.13515161511, 4859.684120532172, 4890.193118135503, 5030.798768049273, 4951.084049450845, 4951.455339912607, 4952.257161425779, 4957.206846904496, 4971.05549945511, 4723.031778485402, 4945.085159245551, 4964.801407943678, 4970.15507363749, 4975.27858460523, 3453.7582369234165, 4053.27041132596, 4167.9583204167875, 4172.436721042651, 4189.329707246857, 6314.842128946767, 6444.677766111722, 6459.83850403739, 6462.515311351621, 6473.025727153216, 5821.09772985188, 5832.883342333172, 5834.5915785895, 5839.7664093436215, 5841.269841269841, 6163.3528479509905, 6993.720251189946, 7220.097487814023, 7229.313215244543, 7249.057622509093, 4450.376947227391, 4503.887402814923, 4527.4114365132655, 4538.341940418653, 4664.020555683311, 7338.889916651255, 7426.628668566604, 7468.103827540675, 7536.0, 7669.0, 4608.907821843544, 4673.883152921204, 4684.906301873943, 4690.273007683814, 4739.715617062987, 4463.977680111643, 4618.35343051973, 4760.785764640599, 4771.570558649738, 4777.617790576745, 5670.716464176775, 5685.971570142123, 5698.116791897262, 5699.857503562361, 5703.344115426696, 7131.786046418616, 7137.10786151731, 7137.644577289586, 7142.250063743232, 7143.1428228612895, 1651.8678505719513, 1675.9497215083568, 1676.6898123847127, 1677.3206851225273, 1682.142107525171, 1048.4286064095086, 1069.235496619905, 1077.5743581285349, 1084.7993121272589, 1093.6227001684406, 6789.0834737310815, 6791.830204244835, 6807.727690892309, 6811.4550835933005, 6811.693473793691, 7474.177840437547, 7478.850422991619, 7512.436567257478, 7518.962405187939, 7525.548467091992, 5410.83767486976, 6386.744530218833, 6760.1549806274215, 6777.220619628707, 6781.62701051437, 3528.1708798432346, 4021.376686613521, 4021.959780402217, 4023.376376661622, 4024.1750441159493, 7836.216378362118, 7947.9205207948335, 7957.0, 7958.08482024563, 7963.681452741941, 7701.618855483978, 7840.41196910234, 7884.250996155356, 7895.407844411692, 7914.366850651934, 7899.368050555941, 7908.565028923349, 7912.960435197787, 7917.683292668229, 7930.206979302024, 7202.7092211984545, 7618.352440042659, 7621.12357078943, 7629.46593738433, 7629.7329593463965, 5992.250968628921, 6852.6916288768125, 7386.963065184855, 7430.071241094864, 7512.098548174254, 7147.249538798351, 7158.964205179149, 7889.881651775113, 7903.802404939923, 7931.087924888711, 4612.446506419251, 4707.929381059218, 4760.547747963938, 4766.856994290177, 4777.331173635764, 6856.554323968926, 6887.896681549681, 7537.623118844145, 7543.057117860268, 7565.508241964475, 7223.133224013152, 7238.312360325761, 7239.348458638748, 7239.601821899846, 7240.782776516713, 7028.191757947697, 7215.567065976058, 7231.0, 7257.963710181415, 7260.927390726025, 6657.0, 7086.220515743161, 7103.2541583133025, 7103.644817758988, 7116.288371162842, 6325.703230837759, 7043.225245222919, 7246.0, 7248.27517248292, 7259.092613423322, 5795.8551036224435, 6462.901306777953, 7074.752383666547, 7097.574145551077, 7109.431245500451], "unit": "ms", "name": "prototype.html", "value": 5224.339229552443}, {"lowerIsBetter": false, "replicates": [738.2912404092071, 801.3989507869098, 820.4134044158429, 827.6772058897031, 877.4428238068832, 14809.925950370247, 15235.695286094271, 15256.084634921912, 15259.465918692847, 15290.31193596288, 13507.257100859473, 13560.728785424286, 13958.651033724136, 14057.859421405783, 14090.57728268151, 967.7580604848788, 982.8967958364376, 989.5200827598609, 992.9056739609725, 993.1161266472845, 954.4941181173989, 971.7959228562011, 974.7173319737268, 975.4537459022935, 976.4043933200742, 1011.640867492037, 1023.2070145637153, 1023.9488025598728, 1027.044848291089, 1029.474967766437, 1017.5115944346682, 1021.9678125093635, 1023.8566600675874, 1024.2420608749546, 1024.5287167902773, 766.337118392592, 771.4792515052374, 774.4075782026754, 776.9417293702995, 778.3228591125757, 13090.738185236338, 13132.606021819362, 13287.86712132876, 13297.86702132976, 13324.666883327898, 10870.293430927044, 10905.618303359424, 11114.444277786159, 11228.214025018171, 11378.146639002025, 9356.017618150065, 9528.333016688835, 9542.61829526825, 9558.2831287653, 9590.232781377543, 3442.8794992175403, 3480.129967508123, 3484.61669216386, 3484.9477257841154, 3487.616362200156, 54654.255319149146, 58735.53161170962, 65097.0, 65122.674386628234, 65305.693886122484, 7120.1099862517185, 7158.677859496335, 7245.673944672502, 7371.741989030465, 7431.85136297271, 11216.775664486664, 12591.433385497674, 12656.177348472504, 12692.492300307884, 12702.618921432371, 6521.152250207538, 6613.404793568506, 6652.933470665328, 6673.799786006428, 6865.862682746317, 4049.1294371710223, 4140.254754144283, 4155.314373128461, 4179.1432756284885, 4333.609975102256, 3107.1610665120293, 3114.5483904833673, 3149.4960806270888, 3154.069549482908, 3187.7609179311644, 419.56365380004456, 512.4721536817084, 519.0889988070987, 519.581736701951, 526.7418964707266, 488.7849346287622, 509.27428414509177, 512.1140427061205, 550.243415303957, 606.9544784141119, 8441.577921104043, 8548.48709077445, 8606.87089693655, 8616.741497755078, 8754.518501482353, 513.1532970598468, 518.5100080423963, 608.9482393996472, 635.9745610175542, 645.0421124629921, 4029.476168098187, 4055.3916912463364, 4074.796260186979, 4110.157417729359, 4190.937135942963, 101191.49404253079, 101700.49149754204, 101742.0, 103290.48354758178, 104263.4786826061, 79360.0, 79982.20017799748, 80275.0, 82259.5887020561, 82857.75713364304, 44144.0, 66967.66516167388, 67135.32161695899, 68293.0, 73563.26436735564, 8771.386002979985, 8865.822683546421, 8988.55057247122, 9060.818783624423, 9080.83943871849, 49261.507384925695, 49527.51417457482, 50502.0, 50579.24131137962, 51218.74390628023, 66515.33484665092, 67973.32026679868, 68291.65854170697, 69389.95915061177, 69547.95678064934, 6804.319568043156, 7687.192844751445, 7785.883211751941, 7828.334591559554, 7894.763157105296, 12027.699307517381, 12101.576444824388, 12173.634790956285, 12251.203671761306, 12627.305498197687, 11272.323660580392, 11363.37501437429, 11497.770044599229, 11564.94217528907, 12085.0, 11272.267302625303, 11675.0, 11705.765884682429, 11966.880331196577, 12324.753504929671, 11023.559057637605, 11321.830172547254, 11354.886451135382, 11387.601433949772, 11665.0, 9622.615095396386, 9803.656872009446, 9909.869378083748, 9949.751256218653, 10107.3430227035, 9471.0, 10029.899701003189, 10030.699079027641, 10036.297459177787, 10255.846162307422], "unit": "ms", "name": "yui.html", "value": 6640.376616926353}], "name": "dromaeo_css", "value": 7171.042530941815}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 111.0, 110.0, 109.0, 100.0, 111.0, 102.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [149.0, 119.0, 142.0, 153.0, 121.0, 136.0, 120.0, 145.0, 159.0, 147.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.1}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 179.0, 182.0, 186.0, 186.0, 184.0, 182.0, 186.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 72.0, 72.0, 54.0, 56.0, 55.0, 73.0, 71.0, 53.0], "unit": "ms", "name": "audio-fft", "value": 64.3}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 114.0, 74.0, 78.0, 77.0, 108.0, 74.0, 75.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 88.2}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 86.0, 86.0, 85.0, 86.0, 86.0, 88.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.9}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 93.0, 93.0, 108.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.6}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 85.0, 89.0, 85.0, 86.0, 86.0, 87.0, 86.0, 87.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 54.0, 58.0, 56.0, 58.0, 53.0, 63.0, 52.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 64.0, 66.0, 66.0, 66.0, 65.0, 66.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 82.0, 80.0, 81.0, 81.0, 80.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [133.0, 132.0, 130.0, 127.0, 121.0, 121.0, 123.0, 119.0, 134.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [136.0, 110.0, 140.0, 176.0, 176.0, 135.0, 140.0, 136.0, 137.0, 149.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 68.0, 94.0, 64.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1390.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [145.98540145985402], "unit": "score", "name": "Richards", "value": 241.81869999999995}, {"lowerIsBetter": false, "replicates": [161.08247422680412], "unit": "score", "name": "DeltaBlue", "value": 410.460544}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "Decrypt", "value": 55.0444225774226}, {"lowerIsBetter": false, "replicates": [1731.833910034602], "unit": "score", "name": "RayTrace", "value": 427.2863556443558}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [15089.55223880597], "unit": "score", "name": "Boyer", "value": 44.16718199802176}, {"lowerIsBetter": false, "replicates": [26815.78947368421], "unit": "score", "name": "RegExp", "value": 33.97196270853777}, {"lowerIsBetter": false, "replicates": [684.4626967830253], "unit": "score", "name": "Splay", "value": 119.05835100000004}, {"lowerIsBetter": false, "replicates": [4488.789237668161], "unit": "score", "name": "NavierStokes", "value": 330.6013986013988}], "name": "v8_7", "value": 20236.682199456158}]} 06:58:06 INFO - RETURN: dromaeo_css: 7171.04 06:58:06 INFO - RETURN: kraken: 1390.40 06:58:06 INFO - RETURN: v8_7: 20236.68 06:58:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20236.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1390.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7171.04"}}} 06:58:06 INFO - Return code: 0 06:58:06 INFO - # TBPL SUCCESS # 06:58:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:58:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:58:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:58:06 INFO - 2015-11-19 06:58:06.059 screenresolution[2153:14817] starting screenresolution argv=screenresolution get 06:58:06 INFO - 2015-11-19 06:58:06.061 screenresolution[2153:14817] Display 0: 1600x1200x32@60 06:58:06 INFO - 2015-11-19 06:58:06.067 screenresolution[2154:14820] starting screenresolution argv=screenresolution list 06:58:06 INFO - Available Modes on Display 0 06:58:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:58:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:58:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:58:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:58:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:58:06 INFO - Intel Iris: 06:58:06 INFO - Chipset Model: Intel Iris 06:58:06 INFO - Type: GPU 06:58:06 INFO - Bus: Built-In 06:58:06 INFO - VRAM (Dynamic, Max): 1536 MB 06:58:06 INFO - Vendor: Intel (0x8086) 06:58:06 INFO - Device ID: 0x0a2e 06:58:06 INFO - Revision ID: 0x0009 06:58:06 INFO - Displays: 06:58:06 INFO - Display: 06:58:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:58:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:58:06 INFO - Display Serial Number: 1600x1200 60 06:58:06 INFO - Main Display: Yes 06:58:06 INFO - Mirror: Off 06:58:06 INFO - Online: Yes 06:58:06 INFO - Rotation: Supported 06:58:06 INFO - Return code: 0 06:58:06 INFO - Running post-action listener: _resource_record_post_action 06:58:06 INFO - Running post-run listener: _resource_record_post_run 06:58:07 INFO - Total resource usage - Wall time: 1236s; CPU: 53.0%; Read bytes: 2674688; Write bytes: 687284736; Read time: 42; Write time: 2077 06:58:07 INFO - install - Wall time: 30s; CPU: 55.0%; Read bytes: 337154560; Write bytes: 335652352; Read time: 25948; Write time: 600 06:58:07 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 2658304; Write bytes: 340265984; Read time: 41; Write time: 1435 06:58:07 INFO - Running post-run listener: _upload_blobber_files 06:58:07 INFO - Blob upload gear active. 06:58:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:58:07 INFO - Copying logs to upload dir... 06:58:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1294.766003 ========= master_lag: 23.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-19 06:58:31.169851) ========= ========= Started set props: build_url (results: 0, elapsed: 42 secs) (at 2015-11-19 06:58:31.174684) ========= 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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009502 build_url: 'https://queue.taskcluster.net/v1/task/8QpLV3dpQW6bfw4cRL7oIg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 42.22 ========= ========= Finished set props: build_url (results: 0, elapsed: 42 secs) (at 2015-11-19 06:59:13.407612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 28 secs) (at 2015-11-19 06:59:13.407938) ========= 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.xbG1pLTf6X/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.3YkJhHDRSM/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/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.005558 ========= master_lag: 28.92 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 28 secs) (at 2015-11-19 06:59:42.335086) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-19 06:59:42.335523) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-19 06:59:45.396085) ========= ========= Total master_lag: 95.47 =========