builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0025 starttime: 1447695189.48 results: success (0) buildid: 20151116080932 builduid: 6b5e6c06efe149aaba8de4e08c9e499e revision: a8608fc16c09c13e018c6007b9d7c211872bd202 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.483131) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.483540) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.483901) ========= 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.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006267 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.513587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.513951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.543015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.543459) ========= 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.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005546 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.593882) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.594234) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.594639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:09.594922) ========= 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.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False --2015-11-16 09:33:09-- 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.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% 9.85M=0.001s 2015-11-16 09:33:10 (9.85 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.435512 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:10.181235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:10.181728) ========= 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.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.020621 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:10.314215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2015-11-16 09:33:10.314914) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a8608fc16c09c13e018c6007b9d7c211872bd202 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a8608fc16c09c13e018c6007b9d7c211872bd202 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False 2015-11-16 09:33:10,393 truncating revision to first 12 chars 2015-11-16 09:33:10,394 Setting DEBUG logging. 2015-11-16 09:33:10,394 attempt 1/10 2015-11-16 09:33:10,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a8608fc16c09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 09:33:10,653 unpacking tar archive at: mozilla-aurora-a8608fc16c09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521063 ========= master_lag: 9.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2015-11-16 09:33:20.036247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 13 secs) (at 2015-11-16 09:33:20.036745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 13 secs) (at 2015-11-16 09:33:33.790726) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:33.791037) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 09:33:33.791477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-16 09:33:33.791843) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False 09:33:34 INFO - MultiFileLogger online at 20151116 09:33:34 in /builds/slave/test 09:33:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:33:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:34 INFO - {'append_to_log': False, 09:33:34 INFO - 'base_work_dir': '/builds/slave/test', 09:33:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:33:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:34 INFO - 'branch': 'Mozilla-Aurora', 09:33:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:34 INFO - 'config_files': ('talos/mac_config.py',), 09:33:34 INFO - 'default_actions': ('clobber', 09:33:34 INFO - 'read-buildbot-config', 09:33:34 INFO - 'download-and-extract', 09:33:34 INFO - 'populate-webroot', 09:33:34 INFO - 'create-virtualenv', 09:33:34 INFO - 'install', 09:33:34 INFO - 'run-tests'), 09:33:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:34 INFO - 'download_minidump_stackwalk': True, 09:33:34 INFO - 'download_symbols': 'ondemand', 09:33:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:34 INFO - 'installer_path': 'installer.exe', 09:33:34 INFO - 'log_level': 'info', 09:33:34 INFO - 'log_name': 'talos', 09:33:34 INFO - 'log_to_console': True, 09:33:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:33:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:33:34 INFO - 'opt_config_files': (), 09:33:34 INFO - 'pip_index': False, 09:33:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:34 INFO - 'cmd': ('bash', 09:33:34 INFO - '-c', 09:33:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:34 INFO - 'enabled': True, 09:33:34 INFO - 'halt_on_failure': False, 09:33:34 INFO - 'name': 'check_screen_resolution'},), 09:33:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:34 INFO - 'cmd': ('bash', 09:33:34 INFO - '-c', 09:33:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:34 INFO - 'enabled': True, 09:33:34 INFO - 'halt_on_failure': False, 09:33:34 INFO - 'name': 'check_screen_resolution'},), 09:33:34 INFO - 'run_cmd_checks_enabled': True, 09:33:34 INFO - 'sps_profile': False, 09:33:34 INFO - 'sps_profile_interval': 0, 09:33:34 INFO - 'suite': 'dromaeojs', 09:33:34 INFO - 'system_bits': '64', 09:33:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:34 INFO - 'title': 't-yosemite-r5-0025', 09:33:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:34 INFO - 'use_talos_json': True, 09:33:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:34 INFO - 'work_dir': 'build'} 09:33:34 INFO - ##### 09:33:34 INFO - ##### Running clobber step. 09:33:34 INFO - ##### 09:33:34 INFO - Running pre-action listener: _resource_record_pre_action 09:33:34 INFO - Running main action method: clobber 09:33:34 INFO - rmtree: /builds/slave/test/build 09:33:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:35 INFO - Running post-action listener: _resource_record_post_action 09:33:35 INFO - ##### 09:33:35 INFO - ##### Running read-buildbot-config step. 09:33:35 INFO - ##### 09:33:35 INFO - Running pre-action listener: _resource_record_pre_action 09:33:35 INFO - Running main action method: read_buildbot_config 09:33:35 INFO - Using buildbot properties: 09:33:35 INFO - { 09:33:35 INFO - "properties": { 09:33:35 INFO - "buildnumber": 262, 09:33:35 INFO - "product": "firefox", 09:33:35 INFO - "script_repo_revision": "production", 09:33:35 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 09:33:35 INFO - "repository": "", 09:33:35 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 09:33:35 INFO - "buildid": "20151116080932", 09:33:35 INFO - "slavename": "t-yosemite-r5-0025", 09:33:35 INFO - "pgo_build": "False", 09:33:35 INFO - "basedir": "/builds/slave/test", 09:33:35 INFO - "project": "", 09:33:35 INFO - "platform": "yosemite", 09:33:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:33:35 INFO - "slavebuilddir": "test", 09:33:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:33:35 INFO - "branch": "mozilla-aurora", 09:33:35 INFO - "repo_path": "releases/mozilla-aurora", 09:33:35 INFO - "stage_platform": "macosx64", 09:33:35 INFO - "builduid": "6b5e6c06efe149aaba8de4e08c9e499e", 09:33:35 INFO - "revision": "a8608fc16c09c13e018c6007b9d7c211872bd202" 09:33:35 INFO - }, 09:33:35 INFO - "sourcestamp": { 09:33:35 INFO - "repository": "", 09:33:35 INFO - "hasPatch": false, 09:33:35 INFO - "project": "", 09:33:35 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:33:35 INFO - "changes": [ 09:33:35 INFO - { 09:33:35 INFO - "category": null, 09:33:35 INFO - "files": [ 09:33:35 INFO - { 09:33:35 INFO - "url": null, 09:33:35 INFO - "name": "https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 09:33:35 INFO - } 09:33:35 INFO - ], 09:33:35 INFO - "repository": "", 09:33:35 INFO - "rev": "a8608fc16c09c13e018c6007b9d7c211872bd202", 09:33:35 INFO - "who": "cbook@mozilla.com", 09:33:35 INFO - "when": 1447695032, 09:33:35 INFO - "number": 6666830, 09:33:35 INFO - "comments": "Bug 1221228 - Work around busted OpenSL causing hangs/reboots on Android. r=padenot, a=sylvestre", 09:33:35 INFO - "project": "", 09:33:35 INFO - "at": "Mon 16 Nov 2015 09:30:32", 09:33:35 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:33:35 INFO - "revlink": "", 09:33:35 INFO - "properties": [ 09:33:35 INFO - [ 09:33:35 INFO - "buildid", 09:33:35 INFO - "20151116080932", 09:33:35 INFO - "Change" 09:33:35 INFO - ], 09:33:35 INFO - [ 09:33:35 INFO - "builduid", 09:33:35 INFO - "6b5e6c06efe149aaba8de4e08c9e499e", 09:33:35 INFO - "Change" 09:33:35 INFO - ], 09:33:35 INFO - [ 09:33:35 INFO - "pgo_build", 09:33:35 INFO - "False", 09:33:35 INFO - "Change" 09:33:35 INFO - ] 09:33:35 INFO - ], 09:33:35 INFO - "revision": "a8608fc16c09c13e018c6007b9d7c211872bd202" 09:33:35 INFO - } 09:33:35 INFO - ], 09:33:35 INFO - "revision": "a8608fc16c09c13e018c6007b9d7c211872bd202" 09:33:35 INFO - } 09:33:35 INFO - } 09:33:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 09:33:35 INFO - Running post-action listener: _resource_record_post_action 09:33:35 INFO - ##### 09:33:35 INFO - ##### Running download-and-extract step. 09:33:35 INFO - ##### 09:33:35 INFO - Running pre-action listener: _resource_record_pre_action 09:33:35 INFO - Running main action method: download_and_extract 09:33:35 INFO - mkdir: /builds/slave/test/build/tests 09:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:35 INFO - https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/test_packages.json 09:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/test_packages.json 09:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:33:36 INFO - Downloaded 1149 bytes. 09:33:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:33:36 INFO - Using the following test package requirements: 09:33:36 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:33:36 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 09:33:36 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'jsshell-mac.zip'], 09:33:36 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 09:33:36 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:33:36 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 09:33:36 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 09:33:36 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 09:33:36 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:33:36 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:33:36 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 09:33:36 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:36 INFO - https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:33:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:33:38 INFO - Downloaded 17447617 bytes. 09:33:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:33:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:33:44 INFO - Return code: 0 09:33:44 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:44 INFO - https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:33:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:33:45 INFO - Downloaded 17447617 bytes. 09:33:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:33:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:33:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:33:53 INFO - Return code: 0 09:33:53 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')]} 09:33:53 INFO - https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:33:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:33:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:33:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:33:54 INFO - Downloaded 11131307 bytes. 09:33:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 09:33:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:33:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:33:55 INFO - Return code: 0 09:33:55 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')]} 09:33:55 INFO - https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:33:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:33:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:33:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 09:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 09:34:00 INFO - Downloaded 107701313 bytes. 09:34:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:34:00 INFO - mkdir: /builds/slave/test/properties 09:34:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:34:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:34:00 INFO - Contents: 09:34:00 INFO - build_url:https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:34:00 INFO - Running post-action listener: _resource_record_post_action 09:34:00 INFO - Running post-action listener: set_extra_try_arguments 09:34:00 INFO - ##### 09:34:00 INFO - ##### Running populate-webroot step. 09:34:00 INFO - ##### 09:34:00 INFO - Running pre-action listener: _resource_record_pre_action 09:34:00 INFO - Running main action method: populate_webroot 09:34:00 INFO - Guessing talos json url... 09:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:00 INFO - https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 09:34:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:34:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:34:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 09:34:00 INFO - Downloaded 107 bytes. 09:34:00 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:34:00 INFO - Contents: 09:34:00 INFO - 20151116080932 09:34:00 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/a8608fc16c09c13e018c6007b9d7c211872bd202 09:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:00 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/a8608fc16c/testing/talos/talos.json 09:34:00 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/a8608fc16c/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/a8608fc16c/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:34:01 INFO - Downloaded 4264 bytes. 09:34:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:34:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:34:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:34:01 INFO - '../fennec_ids.txt'], 09:34:01 INFO - 'tests': ['tcheck2']}, 09:34:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:34:01 INFO - '--tppagecycles', 09:34:01 INFO - '7'], 09:34:01 INFO - 'tests': ['tsvgm']}}, 09:34:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:34:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:34:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:34:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:34:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:34:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:34:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'tests': ['damp', 'tps']}, 09:34:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['damp', 'tps']}, 09:34:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:34:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:34:01 INFO - 'other': {'tests': ['a11yr', 09:34:01 INFO - 'ts_paint', 09:34:01 INFO - 'tpaint', 09:34:01 INFO - 'sessionrestore', 09:34:01 INFO - 'sessionrestore_no_auto_restore']}, 09:34:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['a11yr', 09:34:01 INFO - 'ts_paint', 09:34:01 INFO - 'tpaint', 09:34:01 INFO - 'sessionrestore', 09:34:01 INFO - 'sessionrestore_no_auto_restore']}, 09:34:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['a11yr', 09:34:01 INFO - 'ts_paint', 09:34:01 INFO - 'tpaint', 09:34:01 INFO - 'sessionrestore', 09:34:01 INFO - 'sessionrestore_no_auto_restore']}, 09:34:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['a11yr', 09:34:01 INFO - 'ts_paint', 09:34:01 INFO - 'tpaint', 09:34:01 INFO - 'sessionrestore', 09:34:01 INFO - 'sessionrestore_no_auto_restore']}, 09:34:01 INFO - 'other_l64': {'tests': ['a11yr', 09:34:01 INFO - 'ts_paint', 09:34:01 INFO - 'tpaint', 09:34:01 INFO - 'sessionrestore', 09:34:01 INFO - 'sessionrestore_no_auto_restore']}, 09:34:01 INFO - 'other_nol64': {'tests': ['a11yr', 09:34:01 INFO - 'ts_paint', 09:34:01 INFO - 'tpaint', 09:34:01 INFO - 'sessionrestore', 09:34:01 INFO - 'sessionrestore_no_auto_restore']}, 09:34:01 INFO - 'svgr': {'tests': ['tsvgx', 09:34:01 INFO - 'tsvgr_opacity', 09:34:01 INFO - 'tart', 09:34:01 INFO - 'tscrollx', 09:34:01 INFO - 'cart']}, 09:34:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['tsvgx', 09:34:01 INFO - 'tsvgr_opacity', 09:34:01 INFO - 'tart', 09:34:01 INFO - 'tscrollx', 09:34:01 INFO - 'cart']}, 09:34:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'tests': ['tp5o']}, 09:34:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'talos_options': ['--e10s'], 09:34:01 INFO - 'tests': ['tp5o']}, 09:34:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'talos_options': ['--xperf_path', 09:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:34:01 INFO - 'tests': ['tp5n']}, 09:34:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:01 INFO - 'talos_options': ['--e10s', 09:34:01 INFO - '--xperf_path', 09:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:34:01 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:34:01 INFO - 'tests': ['tp5n']}}, 09:34:01 INFO - 'talos.zip': {'path': '', 09:34:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:34:01 INFO - Running post-action listener: _resource_record_post_action 09:34:01 INFO - ##### 09:34:01 INFO - ##### Running create-virtualenv step. 09:34:01 INFO - ##### 09:34:01 INFO - Running pre-action listener: _resource_record_pre_action 09:34:01 INFO - Running main action method: create_virtualenv 09:34:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:34:01 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 09:34:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:34:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:34:01 INFO - Using real prefix '/tools/python27' 09:34:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:34:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:34:06 INFO - Installing pip.................done. 09:34:06 INFO - Return code: 0 09:34:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:34:06 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')]} 09:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:06 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')]} 09:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:06 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 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:06 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 09:34:06 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 09:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:06 INFO - 'HOME': '/Users/cltbld', 09:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:06 INFO - 'LOGNAME': 'cltbld', 09:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:06 INFO - 'MOZ_NO_REMOTE': '1', 09:34:06 INFO - 'NO_EM_RESTART': '1', 09:34:06 INFO - 'PAGER': '/bin/cat', 09:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:06 INFO - 'PWD': '/builds/slave/test', 09:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:06 INFO - 'SHELL': '/bin/bash', 09:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:06 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:06 INFO - 'USER': 'cltbld', 09:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:06 INFO - 'XPC_FLAGS': '0x0', 09:34:06 INFO - 'XPC_SERVICE_NAME': '0', 09:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:06 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 09:34:06 INFO - Cleaning up... 09:34:06 INFO - Return code: 0 09:34:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:34:06 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')]} 09:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:06 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')]} 09:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:06 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 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:06 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 09:34:06 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 09:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:06 INFO - 'HOME': '/Users/cltbld', 09:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:06 INFO - 'LOGNAME': 'cltbld', 09:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:06 INFO - 'MOZ_NO_REMOTE': '1', 09:34:06 INFO - 'NO_EM_RESTART': '1', 09:34:06 INFO - 'PAGER': '/bin/cat', 09:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:06 INFO - 'PWD': '/builds/slave/test', 09:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:06 INFO - 'SHELL': '/bin/bash', 09:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:06 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:06 INFO - 'USER': 'cltbld', 09:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:06 INFO - 'XPC_FLAGS': '0x0', 09:34:06 INFO - 'XPC_SERVICE_NAME': '0', 09:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:06 INFO - Downloading/unpacking psutil>=0.7.1 09:34:06 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 09:34:06 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 09:34:06 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 09:34:06 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 09:34:06 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 09:34:06 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 09:34:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:34:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:34:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:34:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:34:09 INFO - Installing collected packages: psutil 09:34:09 INFO - Running setup.py install for psutil 09:34:09 INFO - building 'psutil._psutil_osx' extension 09:34:09 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 09:34:10 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 09:34:10 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 09:34:10 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 09:34:10 INFO - building 'psutil._psutil_posix' extension 09:34:10 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 09:34:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:34:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:34:10 INFO - ^ 09:34:10 INFO - 1 warning generated. 09:34:10 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 09:34:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:34:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:34:10 INFO - Successfully installed psutil 09:34:10 INFO - Cleaning up... 09:34:10 INFO - Return code: 0 09:34:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:10 INFO - 'HOME': '/Users/cltbld', 09:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:10 INFO - 'LOGNAME': 'cltbld', 09:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:10 INFO - 'MOZ_NO_REMOTE': '1', 09:34:10 INFO - 'NO_EM_RESTART': '1', 09:34:10 INFO - 'PAGER': '/bin/cat', 09:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:10 INFO - 'PWD': '/builds/slave/test', 09:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:10 INFO - 'SHELL': '/bin/bash', 09:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:10 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:10 INFO - 'USER': 'cltbld', 09:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:10 INFO - 'XPC_FLAGS': '0x0', 09:34:10 INFO - 'XPC_SERVICE_NAME': '0', 09:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:34:11 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 09:34:11 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 09:34:11 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 09:34:11 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 09:34:11 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 09:34:11 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 09:34:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:34:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:34:13 INFO - Installing collected packages: mozsystemmonitor 09:34:13 INFO - Running setup.py install for mozsystemmonitor 09:34:14 INFO - Successfully installed mozsystemmonitor 09:34:14 INFO - Cleaning up... 09:34:14 INFO - Return code: 0 09:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:34: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')]} 09:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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')]} 09:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34: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 09:34: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 09:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:14 INFO - 'HOME': '/Users/cltbld', 09:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:14 INFO - 'LOGNAME': 'cltbld', 09:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:14 INFO - 'MOZ_NO_REMOTE': '1', 09:34:14 INFO - 'NO_EM_RESTART': '1', 09:34:14 INFO - 'PAGER': '/bin/cat', 09:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:14 INFO - 'PWD': '/builds/slave/test', 09:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:14 INFO - 'SHELL': '/bin/bash', 09:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:14 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:14 INFO - 'USER': 'cltbld', 09:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:14 INFO - 'XPC_FLAGS': '0x0', 09:34:14 INFO - 'XPC_SERVICE_NAME': '0', 09:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:34:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34:18 INFO - Downloading docopt-0.6.1.tar.gz 09:34:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:34:18 INFO - Running setup.py install for blobuploader 09:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:34:18 INFO - Running setup.py install for requests 09:34:19 INFO - Running setup.py install for docopt 09:34:19 INFO - Successfully installed blobuploader requests docopt 09:34:19 INFO - Cleaning up... 09:34:19 INFO - Return code: 0 09:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34: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')]} 09:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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')]} 09:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34: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 09:34: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 09:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:19 INFO - 'HOME': '/Users/cltbld', 09:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:19 INFO - 'LOGNAME': 'cltbld', 09:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:19 INFO - 'MOZ_NO_REMOTE': '1', 09:34:19 INFO - 'NO_EM_RESTART': '1', 09:34:19 INFO - 'PAGER': '/bin/cat', 09:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:19 INFO - 'PWD': '/builds/slave/test', 09:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:19 INFO - 'SHELL': '/bin/bash', 09:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:19 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:19 INFO - 'USER': 'cltbld', 09:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:19 INFO - 'XPC_FLAGS': '0x0', 09:34:19 INFO - 'XPC_SERVICE_NAME': '0', 09:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:19 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-03CCBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-OcdBAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-7F8_S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-qlEuFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-XMe9mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-Z0hcYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-xobbsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:20 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-8VJXG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-74UnTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-EkVTeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-73uy3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-UdYfY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-gJFICK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-YBHu49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-b6h4fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:21 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-vu7P7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:22 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-pZfcVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:34:22 INFO - Running setup.py install for manifestparser 09:34:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:34:22 INFO - Running setup.py install for mozcrash 09:34:22 INFO - Running setup.py install for mozdebug 09:34:22 INFO - Running setup.py install for mozdevice 09:34:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:34:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:34:22 INFO - Running setup.py install for mozfile 09:34:23 INFO - Running setup.py install for mozhttpd 09:34:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:34:23 INFO - Running setup.py install for mozinfo 09:34:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:34:23 INFO - Running setup.py install for mozInstall 09:34:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:34:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:34:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:34:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:34:23 INFO - Running setup.py install for mozleak 09:34:23 INFO - Running setup.py install for mozlog 09:34:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for moznetwork 09:34:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozprocess 09:34:24 INFO - Running setup.py install for mozprofile 09:34:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozrunner 09:34:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozscreenshot 09:34:25 INFO - Running setup.py install for moztest 09:34:25 INFO - Running setup.py install for mozversion 09:34:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:34:25 INFO - Cleaning up... 09:34:25 INFO - Return code: 0 09:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:25 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 09:34:25 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 09:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:25 INFO - 'HOME': '/Users/cltbld', 09:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:25 INFO - 'LOGNAME': 'cltbld', 09:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:25 INFO - 'MOZ_NO_REMOTE': '1', 09:34:25 INFO - 'NO_EM_RESTART': '1', 09:34:25 INFO - 'PAGER': '/bin/cat', 09:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:25 INFO - 'PWD': '/builds/slave/test', 09:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:25 INFO - 'SHELL': '/bin/bash', 09:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:25 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:25 INFO - 'USER': 'cltbld', 09:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:25 INFO - 'XPC_FLAGS': '0x0', 09:34:25 INFO - 'XPC_SERVICE_NAME': '0', 09:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:25 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-QcP6Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:25 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)) 09:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:25 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-TAlsbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:26 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-gqqXaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:26 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-KFJcGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-ayrNmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:26 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-62ceNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:26 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-0ZiyW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-1_kUmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:26 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)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:26 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-sQZSd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-QiawEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-MEJVYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-wrzVLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-pKcth0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-unhj2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-TfLbsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:27 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)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:27 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-jaDM_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:28 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-9a4reB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:28 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)) 09:34:28 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)) 09:34: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:28 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)) 09:34:28 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:28 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - Downloading blessings-1.5.1.tar.gz 09:34:30 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 09:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:34:30 INFO - Installing collected packages: blessings 09:34:30 INFO - Running setup.py install for blessings 09:34:31 INFO - Successfully installed blessings 09:34:31 INFO - Cleaning up... 09:34:31 INFO - Return code: 0 09:34:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:31 INFO - Reading from file tmpfile_stdout 09:34:31 INFO - Current package versions: 09:34:31 INFO - blessings == 1.5.1 09:34:31 INFO - blobuploader == 1.2.4 09:34:31 INFO - docopt == 0.6.1 09:34:31 INFO - manifestparser == 1.1 09:34:31 INFO - mozInstall == 1.12 09:34:31 INFO - mozcrash == 0.16 09:34:31 INFO - mozdebug == 0.1 09:34:31 INFO - mozdevice == 0.46 09:34:31 INFO - mozfile == 1.2 09:34:31 INFO - mozhttpd == 0.7 09:34:31 INFO - mozinfo == 0.8 09:34:31 INFO - mozleak == 0.1 09:34:31 INFO - mozlog == 3.0 09:34:31 INFO - moznetwork == 0.27 09:34:31 INFO - mozprocess == 0.22 09:34:31 INFO - mozprofile == 0.27 09:34:31 INFO - mozrunner == 6.11 09:34:31 INFO - mozscreenshot == 0.1 09:34:31 INFO - mozsystemmonitor == 0.0 09:34:31 INFO - moztest == 0.7 09:34:31 INFO - mozversion == 1.4 09:34:31 INFO - psutil == 3.1.1 09:34:31 INFO - requests == 1.2.3 09:34:31 INFO - wsgiref == 0.1.2 09:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1028d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10293e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe52b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:34:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:31 INFO - 'HOME': '/Users/cltbld', 09:34:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:31 INFO - 'LOGNAME': 'cltbld', 09:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:31 INFO - 'MOZ_NO_REMOTE': '1', 09:34:31 INFO - 'NO_EM_RESTART': '1', 09:34:31 INFO - 'PAGER': '/bin/cat', 09:34:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:31 INFO - 'PWD': '/builds/slave/test', 09:34:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:31 INFO - 'SHELL': '/bin/bash', 09:34:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:34:31 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:34:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:31 INFO - 'USER': 'cltbld', 09:34:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:31 INFO - 'XPC_FLAGS': '0x0', 09:34:31 INFO - 'XPC_SERVICE_NAME': '0', 09:34:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 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)) 09:34:31 INFO - Cleaning up... 09:34:31 INFO - Return code: 0 09:34:31 INFO - Running post-action listener: _resource_record_post_action 09:34:31 INFO - Running post-action listener: _start_resource_monitoring 09:34:31 INFO - Starting resource monitoring. 09:34:31 INFO - ##### 09:34:31 INFO - ##### Running install step. 09:34:31 INFO - ##### 09:34:31 INFO - Running pre-action listener: _resource_record_pre_action 09:34:31 INFO - Running main action method: install 09:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:32 INFO - Reading from file tmpfile_stdout 09:34:32 INFO - Detecting whether we're running mozinstall >=1.0... 09:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:34:32 INFO - Reading from file tmpfile_stdout 09:34:32 INFO - Output received: 09:34:32 INFO - Usage: mozinstall [options] installer 09:34:32 INFO - Options: 09:34:32 INFO - -h, --help show this help message and exit 09:34:32 INFO - -d DEST, --destination=DEST 09:34:32 INFO - Directory to install application into. [default: 09:34:32 INFO - "/builds/slave/test"] 09:34:32 INFO - --app=APP Application being installed. [default: firefox] 09:34:32 INFO - mkdir: /builds/slave/test/build/application 09:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:35:12 INFO - Reading from file tmpfile_stdout 09:35:12 INFO - Output received: 09:35:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:35:12 INFO - Running post-action listener: _resource_record_post_action 09:35:12 INFO - ##### 09:35:12 INFO - ##### Running run-tests step. 09:35:12 INFO - ##### 09:35:12 INFO - Running pre-action listener: _resource_record_pre_action 09:35:12 INFO - Running main action method: run_tests 09:35:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:35:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:35:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:35:12 INFO - 2015-11-16 09:35:12.759 screenresolution[1923:10895] starting screenresolution argv=screenresolution get 09:35:12 INFO - 2015-11-16 09:35:12.763 screenresolution[1923:10895] Display 0: 1600x1200x32@60 09:35:12 INFO - 2015-11-16 09:35:12.770 screenresolution[1924:10897] starting screenresolution argv=screenresolution list 09:35:12 INFO - Available Modes on Display 0 09:35:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:35:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:35:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:35:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:35:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:35:13 INFO - Intel HD Graphics 3000: 09:35:13 INFO - Chipset Model: Intel HD Graphics 3000 09:35:13 INFO - Type: GPU 09:35:13 INFO - Bus: Built-In 09:35:13 INFO - VRAM (Total): 512 MB 09:35:13 INFO - VRAM (Dynamic, Max): 10 09:35:13 INFO - Vendor: Intel (0x8086) 09:35:13 INFO - Device ID: 0x0116 09:35:13 INFO - Revision ID: 0x0009 09:35:13 INFO - Displays: 09:35:13 INFO - Display: 09:35:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:35:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:35:13 INFO - Display Serial Number: 1600x1200 60 09:35:13 INFO - Main Display: Yes 09:35:13 INFO - Mirror: Off 09:35:13 INFO - Online: Yes 09:35:13 INFO - Rotation: Supported 09:35:13 INFO - Return code: 0 09:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:35:13 INFO - Python 2.7.3 09:35:13 INFO - Return code: 0 09:35:13 INFO - grabbing minidump binary from tooltool 09:35:13 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')]} 09:35:13 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 0x1028869f0>, '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 0x1025e5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102850990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:35:13 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 09:35:13 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 09:35:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:35:13 INFO - Return code: 0 09:35:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:35:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:35:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:35:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:35:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0025', '--webServer', 'localhost'] in /builds/slave/test/build 09:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0025 --webServer localhost 09:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UoKQJ3O4r4/Render', 09:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:13 INFO - 'HOME': '/Users/cltbld', 09:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:13 INFO - 'LOGNAME': 'cltbld', 09:35:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:35:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:13 INFO - 'MOZ_NO_REMOTE': '1', 09:35:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:35:13 INFO - 'NO_EM_RESTART': '1', 09:35:13 INFO - 'PAGER': '/bin/cat', 09:35:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:13 INFO - 'PWD': '/builds/slave/test', 09:35:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:13 INFO - 'SHELL': '/bin/bash', 09:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZLGi1IWCR/Listeners', 09:35:13 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 09:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:13 INFO - 'USER': 'cltbld', 09:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:13 INFO - 'XPC_FLAGS': '0x0', 09:35:13 INFO - 'XPC_SERVICE_NAME': '0', 09:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:35:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0025', '--webServer', 'localhost'] with output_timeout 3600 09:35:13 INFO - mozversion INFO | application_buildid: 20151116080932 09:35:13 INFO - mozversion INFO | application_changeset: a8608fc16c09c13e018c6007b9d7c211872bd202 09:35:13 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:35:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:35:13 INFO - mozversion INFO | application_name: Firefox 09:35:13 INFO - mozversion INFO | application_remotingname: firefox-dev 09:35:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:35:13 INFO - mozversion INFO | application_vendor: Mozilla 09:35:13 INFO - mozversion INFO | application_version: 44.0a2 09:35:13 INFO - mozversion INFO | platform_buildid: 20151116080932 09:35:13 INFO - mozversion INFO | platform_changeset: a8608fc16c09c13e018c6007b9d7c211872bd202 09:35:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:35:13 INFO - mozversion INFO | platform_version: 44.0a2 09:35:13 INFO - 2015-11-16 09:35:13,437 DEBUG : using testdate: 1447695313 09:35:13 INFO - 2015-11-16 09:35:13,437 DEBUG : actual date: 1447695313 09:35:13 INFO - 2015-11-16 09:35:13,523 INFO : starting webserver on 'localhost:49656' 09:35:13 INFO - 2015-11-16 09:35:13,524 INFO : Starting test suite t-yosemite-r5-0025 09:35:13 INFO - 2015-11-16 09:35:13,524 INFO : Starting test dromaeo_css 09:35:13 INFO - 2015-11-16 09:35:13,524 DEBUG : operating with platform_type : mac_ 09:35:13 INFO - 2015-11-16 09:35:13,525 INFO : Initialising browser for dromaeo_css test... 09:35:13 INFO - 2015-11-16 09:35:13,540 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpMur2p5/profile http://localhost:49656/getInfo.html 09:35:16 INFO - 2015-11-16 09:35:16,245 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:35:16 INFO - 2015-11-16 09:35:16,245 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:35:16 INFO - 2015-11-16 09:35:16,246 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:35:16 INFO - 2015-11-16 09:35:16,246 DEBUG : BROWSER_OUTPUT: __metrics 09:35:16 INFO - 2015-11-16 09:35:16,262 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:17 INFO - 2015-11-16 09:35:17,010 INFO : Browser initialized. 09:35:17 INFO - 2015-11-16 09:35:17,011 INFO : Running cycle 1/1 for dromaeo_css test... 09:35:17 INFO - 2015-11-16 09:35:17,011 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpMur2p5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:35:29 INFO - 2015-11-16 09:35:29,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 199585792 09:35:29 INFO - 2015-11-16 09:35:29,062 DEBUG : BROWSER_OUTPUT: 09:36:20 INFO - 2015-11-16 09:36:20,715 DEBUG : BROWSER_OUTPUT: 1447695380713 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] 09:38:31 INFO - 2015-11-16 09:38:31,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49656/tests/dromaeo/cssquery-ext.html) 09:38:32 INFO - 2015-11-16 09:38:32,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 322756608 09:38:32 INFO - 2015-11-16 09:38:32,575 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-11-16 09:41:35,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-ext.html (next: http://localhost:49656/tests/dromaeo/cssquery-jquery.html) 09:41:35 INFO - 2015-11-16 09:41:35,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 346157056 09:41:35 INFO - 2015-11-16 09:41:35,944 DEBUG : BROWSER_OUTPUT: 09:44:38 INFO - 2015-11-16 09:44:38,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49656/tests/dromaeo/cssquery-mootools.html) 09:44:38 INFO - 2015-11-16 09:44:38,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 308736000 09:44:38 INFO - 2015-11-16 09:44:38,690 DEBUG : BROWSER_OUTPUT: 09:47:40 INFO - 2015-11-16 09:47:40,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49656/tests/dromaeo/cssquery-prototype.html) 09:47:41 INFO - 2015-11-16 09:47:41,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 301334528 09:47:41 INFO - 2015-11-16 09:47:41,366 DEBUG : BROWSER_OUTPUT: 09:50:44 INFO - 2015-11-16 09:50:44,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49656/tests/dromaeo/cssquery-yui.html) 09:50:45 INFO - 2015-11-16 09:50:45,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 307310592 09:50:45 INFO - 2015-11-16 09:50:45,247 DEBUG : BROWSER_OUTPUT: 09:53:47 INFO - 2015-11-16 09:53:47,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-yui.html (next: http://localhost:49656/tests/dromaeo/cssquery-dojo.html) 09:53:48 INFO - 2015-11-16 09:53:48,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 347967488 09:53:48 INFO - 2015-11-16 09:53:48,162 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,164 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:53:48 INFO - 2015-11-16 09:53:48,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:53:48 INFO - 2015-11-16 09:53:48,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:53:48 INFO - 2015-11-16 09:53:48,164 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:53:48 INFO - 2015-11-16 09:53:48,165 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2770.9168724938254;2854.9857250713744;2887.8700458479366;2951.6310461192343;2952.527595584707;4874.390701162355;4897.240927656215;4943.678660887049;4980.3027576139275;4987.476314986929;4888.437829649592;4914.508549145093;4920.114379411704;4972.32873562069;4979.576735977437;4403.845865394712;4544.091181763644;4587.128445595343;4595.58639722425;4642.907141857161;4486.685931984763;4507.571780680846;4585.082983403316;4589.2886602576655;4604.102200070987;4447.977760111195;4483.574060464251;4507.030988337507;4562.201614717428;4616.422947131608;4436.955630443703;4545.681802273843;4552;4577.633789296849;4664.836730714409;4465.173942820588;4499;4505.098980203972;4529.6376289896725;4552.908941821145;4547.136044151601;4578.931316030262;4613.884652883671;4675.4155730533685;4774;5072.82245121419;5075.314832497603;5107.668001579886;5152.58779297659;5229.764660590283;5123.974380128113;5162.664426812283;5189.610779191576;5218.60860435465;5255.737213139328;4626.21354369758;4712.575868171881;4713.835015774432;4777.235642297216;4871.951280487186;5259.894802103937;5324.547413469899;5353.946460535422;5397.676139431568;5427.864303392446;5065.265536497187;5094.312267843868;5117.616178786606;5125.1287281162295;5154.9484505155215;4757.476677565465;4946.258061290835;5018.397792264952;5077.568406685473;5235.476452354734;5064.518870707277;5104.872378190501;5109.029284435946;5124.231365295235;5169.327987361619;5117.565006974449;5135.15269980449;5146.716930568855;5175.223716442564;5197.272381866466;3811.4282857571584;3895.7857317847793;3918.490596222473;3985.900352491211;4064.918701625951;3497.3180229855443;3602.7838329700303;3613.0786649404236;3630.745847790682;3633.4368172933237;4784.928226076611;4801.159797035505;4821.276808478756;4884.633652476078;4911.926321105187;5009.373828271466;5103.234514822806;5144.61415393847;5153.896922061538;5163.922541161885;4816.686915350491;4817.13291607507;4828.903421931542;4840;4850;4483.14820184164;4533.523979982055;4540.341650460665;4559.4072770539615;4595.172868883633;4855.101806165871;4964.8758781030765;5051.797928082982;5111.923321150111;5227.320448341691;5169.276301317894;5184.559312458332;5200.60995425337;5207.088759467154;5255.0540902637895;5208.609354298518;5217.869553261199;5219.399769026611;5313.760880760297;5332.813351532678;4868.90262194747;4898.118338699069;5084.796608135781;5122.078025955364;5128.153854613947;5045.974770126126;5062.746862656779;5155.175171972466;5156.355455568054;5211.140161873249;4819.7108173509705;4929.728864912321;4980.775865086008;4994;5005.924911126263;4833.830815921426;4880.243562247857;4935.827246046371;4960.379952505937;4976.601871850316;4942.925856112233;5030.144875371268;5036.899262014813;5061.139606267017;5090.898182036412;5123.948760512347;5163.561097306771;5174.197999309962;5179;5179.449409797608;4709.0817290628;4787.54518320759;4837.05677392905;4862.294967229661;5013.949860501349 09:53:48 INFO - 2015-11-16 09:53:48,169 DEBUG : BROWSER_OUTPUT: |1;ext.html;498.9401271847379;502.6958689992554;502.90193412284617;514.9433562308146;532.2388983753236;28450.43099138016;29990;36133.45799813002;36913.630863691425;37220;39208.60791392085;39647.80176099123;39742;39780.204395912064;39871.40192897109;7538.434617403689;7979.640916158758;8174.182581741838;8227;8235.21765432286;7511.774646760578;9169.403988740743;9726.90273097267;9873.950630246874;9876.753081172956;9498.620055197784;9634.373765705242;9733.124018838304;9767.267454940873;9779.315447918649;7299.124105107368;7656.425768067417;9462.384944978554;9529.380590261611;9531.428114313163;9429.104235097655;9501.00239474852;9518.85721714168;9543;9621.567029483691;35882.282354353025;35964.28071438583;36030.63969360299;36571.63428365709;36663.63336366629;2542.8220024598286;2567.7817385522253;2617.7251388604304;2730.9726902730918;3014.231371000381;24721.381965450826;25882.6117608236;26468.86765566179;26594.734052659613;27579;2030.1270453704901;2043.9897800510903;2052.1893851928403;2056.0542150610736;2072.554400803819;257862;259272;259284;259463;259740.9999999981;57358.7132064337;58191.4180858186;58227;58232.4176758227;58405.20366176185;58574.41425585775;60162.699186503785;61496;68263.3173668257;69588.65205674041;15720;15938;15955.840441595436;16223.26995285215;16231;11915.88084119165;11972.102092342935;11982.52069917211;11993.100517461226;12129.87870121305;18039.639207215783;18927.24291028371;18957.52606184829;19045.428637140907;19181.61636767257;7585.962070189724;7822.569758663328;7851.332636725828;7888.7633370998965;7901.960490197513;730.7551970090079;735.1729304532402;840.315143158324;903.5662881816764;971.6890595009529;25445.23664290074;25451.87274063618;25507.36231594225;25543.36141596475;25617.8719106407;806.3670019035029;885.3315746611268;898.196114477552;920.7974245665943;926.1433174313732;12333.814992775115;12664.936675316565;12694.746105077847;12714.364281785874;12878.806817897552;667511;668125;678789;682791;687315;50064.499355006716;50577.24134137991;51670.74164629153;51809.48190518122;52065.47934520682;1264.462603393554;1267.4423253768311;1279.7568461992191;1285.5950375631646;1300.2848433361423;22250.554988900454;26004.73995260099;26598.335041624116;27013.1896043119;27824.860875695493;46209.537904621866;46368.072638546364;46525.53474465212;46659.300110497694;46781.766091169324;278356;279751;279948;283512;284283;28652.570211447262;29029;40070.398944016444;41859;42284;38983.610163897996;39082.80458597689;39152.21695566016;39339.80330098446;40167;33150.83424582861;33163.83418082894;33337.49993750047;33437.498437523944;33629.49555756715;32218.35563288768;32918.34163316768;33236.1690957728;33303.33393332071;33388.83305583554;32824.179395515304;33162.17094572655;33408;33436.164095897795;33683.66316336805;27978.58032129479;28253.428923021704;32105.197370065936;32539.51190732188;32890.83554582212;22168.224112156644;22248;22540;22558.097676092773;23102.653460197773 09:53:48 INFO - 2015-11-16 09:53:48,170 DEBUG : BROWSER_OUTPUT: |2;jquery.html;302.2217789192829;308.59882153200834;310.5062949909643;317.2686956565116;317.6569305150437;15458.072515649055;15729.056256624595;15873.206339683013;17180.914095429536;17281.654366912655;16139.354425822952;16214.432494862682;16633.085180315076;16638.16809159543;16686.49940501787;4593.3110033494995;4718.57532822046;4737.73942433166;4774.1645212087915;4792.257200133968;3893.5717071122153;4731.124741922756;4752.16837053516;4869.026194761044;4884.242942343943;4705.647076469261;4736.2895565665085;4742.4309082910095;4762.809487620491;4777.211760059586;4591.173588754023;4635.374224479686;4647.744374059425;4758.214894542396;4774.06905653396;4146.523149837777;4156.521999969982;4180.331147016463;4184.497860256789;4190.476190476191;18801.435956921316;18808.153633086546;18846.62306753871;18906.905465472584;18986.81013189864;1735.670222657691;1763.2682436788718;1784.643071385728;1895.7440745499318;1918.2806447582157;11643.126765492538;11680.824787628193;11894;11995;12141.635750927486;1440.387835170059;1485.8885583581166;1487.5983484459243;1506.9397224111021;1538.830728619851;41631.375529367084;42958.35562466565;43509.34735978963;52076.479235207924;52671.73664131655;8203.466774659628;8228.547429891294;8443.155684431631;8517.23344898962;8728;9841.901580984098;10075.193984481224;10212.540435680412;10530.420826854443;10588.4705764713;6836.418904393083;6849.554778939353;6862.759803406857;6877.346652068046;6891.793246202622;6755.864882702318;6850.588964662136;6851.657417129124;6870.244273129952;6877.89683154753;5018.949810501848;5026.371703537058;5177.8446646599905;5214.97392513035;5248.265242866002;1502.9549113526612;1503.361071544589;1503.6090616439803;1520.5666385080199;1551.3251735495096;831.463705909697;933.8179055084194;939.3049143633662;946.1153821177221;978.0072976691347;15067.321970511353;15879.841201588068;16657.3337066516;16943.91528042352;17108.315667373416;821.0762891746784;842.8819965204876;892.638481415028;905.2395987370509;937.7139972308375;7349.081364829396;7998.880016799752;9655.275854310954;9732.70801875945;9743.805123897482;498657;499979;505490;512560;519272;50501.242481362075;52507.73746131245;60652;62846.37153628405;63381.415464613754;365.2366553902357;365.5722804318953;366.62054773309495;901.0538934119148;924.3437159616612;8733.388662793543;8846.955765221133;8880.111988801327;9016.729498115066;9063.093690630883;30755.384892302478;31381.686183137877;31466.685333147292;31507.212319691273;31972.36055278835;39460.802695986335;42760.35859462173;43082;44176.33735493906;44227.33658995182;4847.903041939212;5031.119554078095;5036.445990940921;5058.266551350107;5060.721660308571;9064.365494415328;9223.400478968846;9250.398724082914;9302.348835581444;9373.765655858386;7694.307512323918;8027.317677997436;8063.758087257392;8066.314363279187;8097.068837083811;7734.845303094019;7833.1383547808555;7840.176781437867;7859.17478664732;8067.354611631173;7858.646360913658;8057.194280571896;8181.590920454072;8295.004599448104;8310.70912518059;4899.11815873132;4918.458969513422;4934.407871055496;4961.50384961501;4984.077945580079;7927;7995.560244186626;7998.600069996361;8030.156833532628;8099.554524501209 09:53:48 INFO - 2015-11-16 09:53:48,173 DEBUG : BROWSER_OUTPUT: |3;mootools.html;740.9925900740991;1216.1912328301678;1270.3902126979049;1286.4725462560352;1288.6778305423645;6219.160413344197;6496.252930912947;6667.166604174484;6797.864042719155;6827.351401616838;6804;6858.965705171479;6873.175218973718;6877.243503214655;6901.378875901168;1879.8966056866832;1887.9150438230245;1892.9905350473298;1903.3528600275904;1907.5612609099915;1911.426572028393;1918.788933217345;1936.1771247219945;1942.9514262143418;1974.3583335415976;1854.8887066776037;1859.1076283383984;1859.832615064644;1892.924283028677;1893.2710906301036;1868.1780016792636;1871.3637363296477;1887.6696578098915;1889.5559543507334;1892.4890279624424;1869.2896699254331;1870.4575673054799;1902.5338791995912;1908.6850669639493;1936.9830838809596;6088.238970128734;6744.224414192382;6839.316068393171;6844.486663500257;6928.272531384233;3604.27914417115;3861.4787003754413;3962.346212874872;3993.8402463901407;4036.777977211252;2386.8567885926727;2455.312512496486;2476.1828596563273;2511.2215213283757;2514.3085651445817;596.6092209602717;741.4513260187476;746.2462912458402;748.5957582905224;751.5227830327726;8922.687705930326;8944.284457243404;8969.192772650427;9029.729108126832;9150.588223529958;3523.295340931824;3577.731670124751;3623.2572322673786;3665.890023299305;3666;7785.1436342002335;7800.843983120306;7805.063392392835;7868.409869259828;7872.803179920434;4081.2041651878194;4089.345704687236;4108.137291168888;4122.443470131554;4155.501339839238;3731.4962480065387;3757.0043938356357;3775.6601905828607;3786.413105968579;3796.2217745362136;3210.06907996683;3246.3831871944253;3248.6751324867323;3258.0714496368896;3291.8518666660057;1023.4013102335217;1033.4419413516766;1040.5785656809005;1052.5421441672897;1059.5814653212092;1131.2759833706434;1131.3155540897803;1147.6729132197283;1190.3096204201543;1198.6583823610229;6523.902141467882;6590.9670451647435;6600.900986485207;6609.6695165241545;6616.371444712745;355.6532380928626;356.4261538922333;357.7370632585048;359.10582649203815;361.358588505405;5171.4828517148735;5192.299039629602;5201.921971170435;5241.292425522582;5255.737213139328;7944.126146123922;7978.680852765824;8084.1107478177355;8148.144444833207;8152.388570857091;8107.635156417975;8123.593820308961;8147.9185208147155;8164.591770411455;8170.550619715973;5858.384869588717;5969.76120955157;6097.2683278006925;6431.839204019843;6467.676616169173;6416.807495775134;6502.6748662567625;6528.21661400635;6540.149780528501;6587.209534855848;7282.4902256841515;7358.926410736039;7363.116426028911;7367.2264412235945;7368.0421545200925;6565.967170164118;6932.341427564374;6959.4432445405255;6997.755078572225;7496.437767167376;6030.819075427744;6121;6132.693365331626;6180.969095154495;6194.225721784777;6239.251289845248;6430.3891130342545;6483.027545868157;6496.610203387811;6508.8047358579315;5794.4205579443405;6035.456808887221;6163.38366163398;6264.2796078451565;6320.241571011508;5954.493868021266;6042.123892035718;6042.939570604238;6146.0166373381835;6201.937980620317;6098.847528811815;6145.66198859067;6185.659788711664;6253.030780229072;6298.212723409574;5545.861353466034;5568.638038527482;5664.235328230636;5664.263645726194;5691.288588926384;5673.205751194753;5712.200291959046;5773.971130144322;5809.622374545641;5823.912641310469 09:53:48 INFO - 2015-11-16 09:53:48,174 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.6196448900517;281.87456581821084;283.4048498153877;290.29458416049005;291.45934291888557;5151.484851514847;5164.6384753067205;5325.627206095575;5371.570274378045;5426.918596221055;5322.494363035516;5355.678659280446;5372.382176049756;5388.7305634718205;5444.373897001846;4053.918921621566;4104.569020252883;4131.277026520362;4132.628063474287;4160.521540022906;3977.582353852847;4162.979185104085;4173.833046678129;4176.7076304658685;4176.728512646669;4062.6546743526837;4125.2780763366445;4147.751134931914;4152.97923510382;4230.51349094855;4112.3420252759415;4116.567760385176;4150.190712810988;4154.771487568198;4169.2703776838935;3513.508108864761;3567.571891373052;3588.067102553329;3613.33153366628;3616.0959760059986;5127.666701664417;5129.717865517395;5182.714950677711;5224.4775522447835;5250.05499010178;4619.538046195387;4638.141943740419;4675.392199014141;4677.88305292367;4687.578117969365;5556.138798486241;5572.721363931828;5583.720813959327;5627.774889004435;5644.604877658566;3821.9235615287816;3834.8466061357512;3862.6523612874976;3863.613638636114;3888.494495715539;5488.945110548923;5835.066389377679;5835.562332825055;5879.500242479395;5892.675902825343;3256.661921530403;3775.037365471842;3785.6403641653997;3806.3719486284454;3850.403187505941;3854.3640299350855;3857.7106716996336;3934.8622798201927;3935.822887970048;3940.014996250937;4504.527024662363;4512.9774351128035;4538.704984176018;4541.137183935041;4542.954570454319;5391.29913111293;5570.108782594765;5585.329760428694;5607.074832652648;5609.4390560943575;1368.9520866769615;1374.2853716067789;1386.2652794018984;1394.1844021247684;1400.8108905297654;887.494128346849;912.3020889019905;927.7077720518015;930.7719608695913;939.3143005605946;5397.136458166675;5450.182472629058;5453.590980676465;5482.698451585121;5488.313960754906;5857.58996870215;5903.881922361615;5908.586398952032;5938.732757025944;5940.732667029994;5353.57171426285;5393.78424863009;5416.674999500043;5449.04641687711;5484.8354549363585;3150.7164355207683;3229.2088438332758;3248;3248.13924310058;3278.0493656839726;5895.35151133375;5958.314793798769;5967;5973.37279585646;5986.132010858489;5991.910121348184;6005.879882402415;6020.789272375533;6032.909506357408;6039.909401358896;5598.86002849932;5751.396103409082;5873.3832947539895;5944.019236825875;5976.551758618121;5838.241028666246;5838.532917366685;5888.911666325094;5916.852078698067;5929.940700592939;5736.483716465538;5759.884802304015;5760.827175184583;5771.509421699203;5813.273340832396;5881.206037184926;5942.970285148546;5979.431953964367;6022.48808851235;6052.213212282375;3699.3711069118854;3761.153740408386;3762.698984081212;3854.5181852268465;3863.265979463893;5748.856278593069;5780.768769249183;5783.652980821164;5824.825255242349;5835.095560188178;5604.243427137284;5610.102383618601;5631.887362252814;5654.321481422091;5664.065429204135;5564.721763911869;5610.775568977195;5612.242347283228;5644.971775141098;5658.377578466448;5537.418571050143;5539.279893613804;5542.7782888684005;5586.636868603528;5592.468715472024;5650.124230744241;5658.547316214611;5688.914666280092;5696.772129114789;5715.31416230055;5537.944620553743;5538.639988400902;5590.580706446952;5601.80393686219;5612.635178713371 09:53:48 INFO - 2015-11-16 09:53:48,178 DEBUG : BROWSER_OUTPUT: |5;yui.html;520.1183993131643;613.7514306705783;660.2769966886261;670.842352047269;674.1909708349979;12138.15032947694;12195;12473.501059957602;12513.249205047692;12619;11812.350320732356;11856.288622682623;11963.641090767269;11973.580924667638;11983.700407489818;665.933406659335;670.8691805098008;813.6785969542027;824.2128767027474;832.4838600067936;802.1176705623797;809.522381794741;811.0996793559144;815.7267315449332;824.3652387661497;791.3471386106456;853.185208126241;853.9146085391442;867.6876324523198;871.5075982070142;697.6372286411063;698.7100353353378;828.0725587342155;834.1575009240711;835.9623816928192;619.6963487890946;621.0776996160698;625.8716963022615;629.8173529676388;630.2562975688686;11942.761144777143;12129.818052729217;12152.270863748203;12256.325902075472;12306;10355.275130740776;10645.414502202375;10696;10851.348919064802;11015.779684406267;8457.830843383159;8553.828923421559;8608.870866937;8805;8880.24517915978;2878.208492664513;2943.5495920867843;2998;3024.3497648005564;3156.526521021865;42888.57111428908;43241.13517729659;43359.132817343474;43582;44275.557244427466;7351.482201674729;7884.960575197088;7898.091719452336;7944.761657150295;7990.081140668781;16712.91643541799;16721.331146753993;16730.49808505747;16830.91584542094;16862.494125176265;6146.907796383058;6409.839754006187;6513.381228783258;6623.271440141581;6650.102236198148;3298.340331933623;3407.182276253731;3424.8116353600294;3453.240287136826;3589.4795254687924;2666.71999440056;2678.7990900682526;2683.1413947536603;2692.8653567321558;2701.9324516887236;340.40429248814576;356.1967762695158;358.4855732024553;358.5607630652482;362.21580278696854;434.9195398851223;442.54417949512055;484.428374518065;500.7671432783773;532.7256462921598;6366.490680745529;6996.650167491605;7051.153861536648;7108.431325493948;7421.925780742124;407.3807812125612;410.386472224021;431.784107946027;446.9441319835021;470.2123942396472;3065.524843649238;3396.541466901986;3397.6262611112757;3496.4056110461283;3524.4713293006253;53753.46246537485;54480.45519544833;54666;54881.72559137179;55452;47520.28719569209;48204.51795482;48307.27539086917;48326.75836620865;48470.75764621155;42809;43322.07537690957;43551.34672979908;43676.781616091714;43991.78004109959;6923.688434020582;6964.79105626832;7120.038794762848;7132.572045677069;7155.677994490365;31034.379312414076;31903.840480797448;32239;32709.345813083128;32980;39266.607333926295;39340.409893852186;40559;43866.56133438625;43942;5924.46679798803;5975.25309336333;6108.144859719554;6158.815235542941;6171.783987560414;9124.954375228346;9353.532323383668;9433;9572.521373931415;9740.805183896424;8608.09614990417;8711.651533938571;8788.516631585324;8915.108489151033;8915.554222288989;8728.301735860989;8877.422967507091;8918.10818918103;8925.018247992586;8946.194842464209;7929.960350198212;8439.493630382196;8772.38593298463;8800.647974081221;8806.647734090564;7226.096737907762;7230.950667626146;7748.92251077482;7795.4543181976715;7911.8813217800625;7321;7580.62096895142;7609;7634.490330208703;7665.731699390494 09:53:48 INFO - 2015-11-16 09:53:48,178 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:53:48 INFO - 2015-11-16 09:53:48,178 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:53:48 INFO - 2015-11-16 09:53:48,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1003 09:53:48 INFO - 2015-11-16 09:53:48,178 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:53:48 INFO - 2015-11-16 09:53:48,179 DEBUG : BROWSER_OUTPUT: __startTimestamp1447696428162__endTimestamp 09:53:48 INFO - 2015-11-16 09:53:48,179 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,179 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:53:48 INFO - 2015-11-16 09:53:48,179 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:53:48 INFO - 2015-11-16 09:53:48,179 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,179 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4797.02 Median:4935.83 stddev:504.12 (10.2%) stddev-sans-first:479.96 09:53:48 INFO - 2015-11-16 09:53:48,180 DEBUG : BROWSER_OUTPUT: Values: 2770.9 2855.0 2887.9 2951.6 2952.5 4874.4 4897.2 4943.7 4980.3 4987.5 4888.4 4914.5 4920.1 4972.3 4979.6 4403.8 4544.1 4587.1 4595.6 4642.9 4486.7 4507.6 4585.1 4589.3 4604.1 4448.0 4483.6 4507.0 4562.2 4616.4 4437.0 4545.7 4552.0 4577.6 4664.8 4465.2 4499.0 4505.1 4529.6 4552.9 4547.1 4578.9 4613.9 4675.4 4774.0 5072.8 5075.3 5107.7 5152.6 5229.8 5124.0 5162.7 5189.6 5218.6 5255.7 4626.2 4712.6 4713.8 4777.2 4872.0 5259.9 5324.5 5353.9 5397.7 5427.9 5065.3 5094.3 5117.6 5125.1 5154.9 4757.5 4946.3 5018.4 5077.6 5235.5 5064.5 5104.9 5109.0 5124.2 5169.3 5117.6 5135.2 5146.7 5175.2 5197.3 3811.4 3895.8 3918.5 3985.9 4064.9 3497.3 3602.8 3613.1 3630.7 3633.4 4784.9 4801.2 4821.3 4884.6 4911.9 5009.4 5103.2 5144.6 5153.9 5163.9 4816.7 4817.1 4828.9 4840.0 4850.0 4483.1 4533.5 4540.3 4559.4 4595.2 4855.1 4964.9 5051.8 5111.9 5227.3 5169.3 5184.6 5200.6 5207.1 5255.1 5208.6 5217.9 5219.4 5313.8 5332.8 4868.9 4898.1 5084.8 5122.1 5128.2 5046.0 5062.7 5155.2 5156.4 5211.1 4819.7 4929.7 4980.8 4994.0 5005.9 4833.8 4880.2 4935.8 4960.4 4976.6 4942.9 5030.1 5036.9 5061.1 5090.9 5123.9 5163.6 5174.2 5179.0 5179.4 4709.1 4787.5 4837.1 4862.3 5013.9 09:53:48 INFO - 2015-11-16 09:53:48,180 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,180 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54815.42 Median:35997.46 stddev:120944.58 (336.0%) stddev-sans-first:121215.11 09:53:48 INFO - 2015-11-16 09:53:48,180 DEBUG : BROWSER_OUTPUT: Values: 498.9 502.7 502.9 514.9 532.2 28450.4 29990.0 36133.5 36913.6 37220.0 39208.6 39647.8 39742.0 39780.2 39871.4 7538.4 7979.6 8174.2 8227.0 8235.2 7511.8 9169.4 9726.9 9874.0 9876.8 9498.6 9634.4 9733.1 9767.3 9779.3 7299.1 7656.4 9462.4 9529.4 9531.4 9429.1 9501.0 9518.9 9543.0 9621.6 35882.3 35964.3 36030.6 36571.6 36663.6 2542.8 2567.8 2617.7 2731.0 3014.2 24721.4 25882.6 26468.9 26594.7 27579.0 2030.1 2044.0 2052.2 2056.1 2072.6 257862.0 259272.0 259284.0 259463.0 259741.0 57358.7 58191.4 58227.0 58232.4 58405.2 58574.4 60162.7 61496.0 68263.3 69588.7 15720.0 15938.0 15955.8 16223.3 16231.0 11915.9 11972.1 11982.5 11993.1 12129.9 18039.6 18927.2 18957.5 19045.4 19181.6 7586.0 7822.6 7851.3 7888.8 7902.0 730.8 735.2 840.3 903.6 971.7 25445.2 25451.9 25507.4 25543.4 25617.9 806.4 885.3 898.2 920.8 926.1 12333.8 12664.9 12694.7 12714.4 12878.8 667511.0 668125.0 678789.0 682791.0 687315.0 50064.5 50577.2 51670.7 51809.5 52065.5 1264.5 1267.4 1279.8 1285.6 1300.3 22250.6 26004.7 26598.3 27013.2 27824.9 46209.5 46368.1 46525.5 46659.3 46781.8 278356.0 279751.0 279948.0 283512.0 284283.0 28652.6 29029.0 40070.4 41859.0 42284.0 38983.6 39082.8 39152.2 39339.8 40167.0 33150.8 33163.8 33337.5 33437.5 33629.5 32218.4 32918.3 33236.2 33303.3 33388.8 32824.2 33162.2 33408.0 33436.2 33683.7 27978.6 28253.4 32105.2 32539.5 32890.8 22168.2 22248.0 22540.0 22558.1 23102.7 09:53:48 INFO - 2015-11-16 09:53:48,180 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,182 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25075.81 Median:4891.68 stddev:82781.77 (1692.3%) stddev-sans-first:82993.09 09:53:48 INFO - 2015-11-16 09:53:48,182 DEBUG : BROWSER_OUTPUT: Values: 302.2 308.6 310.5 317.3 317.7 15458.1 15729.1 15873.2 17180.9 17281.7 16139.4 16214.4 16633.1 16638.2 16686.5 4593.3 4718.6 4737.7 4774.2 4792.3 3893.6 4731.1 4752.2 4869.0 4884.2 4705.6 4736.3 4742.4 4762.8 4777.2 4591.2 4635.4 4647.7 4758.2 4774.1 4146.5 4156.5 4180.3 4184.5 4190.5 18801.4 18808.2 18846.6 18906.9 18986.8 1735.7 1763.3 1784.6 1895.7 1918.3 11643.1 11680.8 11894.0 11995.0 12141.6 1440.4 1485.9 1487.6 1506.9 1538.8 41631.4 42958.4 43509.3 52076.5 52671.7 8203.5 8228.5 8443.2 8517.2 8728.0 9841.9 10075.2 10212.5 10530.4 10588.5 6836.4 6849.6 6862.8 6877.3 6891.8 6755.9 6850.6 6851.7 6870.2 6877.9 5018.9 5026.4 5177.8 5215.0 5248.3 1503.0 1503.4 1503.6 1520.6 1551.3 831.5 933.8 939.3 946.1 978.0 15067.3 15879.8 16657.3 16943.9 17108.3 821.1 842.9 892.6 905.2 937.7 7349.1 7998.9 9655.3 9732.7 9743.8 498657.0 499979.0 505490.0 512560.0 519272.0 50501.2 52507.7 60652.0 62846.4 63381.4 365.2 365.6 366.6 901.1 924.3 8733.4 8847.0 8880.1 9016.7 9063.1 30755.4 31381.7 31466.7 31507.2 31972.4 39460.8 42760.4 43082.0 44176.3 44227.3 4847.9 5031.1 5036.4 5058.3 5060.7 9064.4 9223.4 9250.4 9302.3 9373.8 7694.3 8027.3 8063.8 8066.3 8097.1 7734.8 7833.1 7840.2 7859.2 8067.4 7858.6 8057.2 8181.6 8295.0 8310.7 4899.1 4918.5 4934.4 4961.5 4984.1 7927.0 7995.6 7998.6 8030.2 8099.6 09:53:48 INFO - 2015-11-16 09:53:48,182 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,182 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4704.68 Median:5906.44 stddev:2487.09 (42.1%) stddev-sans-first:2476.21 09:53:48 INFO - 2015-11-16 09:53:48,184 DEBUG : BROWSER_OUTPUT: Values: 741.0 1216.2 1270.4 1286.5 1288.7 6219.2 6496.3 6667.2 6797.9 6827.4 6804.0 6859.0 6873.2 6877.2 6901.4 1879.9 1887.9 1893.0 1903.4 1907.6 1911.4 1918.8 1936.2 1943.0 1974.4 1854.9 1859.1 1859.8 1892.9 1893.3 1868.2 1871.4 1887.7 1889.6 1892.5 1869.3 1870.5 1902.5 1908.7 1937.0 6088.2 6744.2 6839.3 6844.5 6928.3 3604.3 3861.5 3962.3 3993.8 4036.8 2386.9 2455.3 2476.2 2511.2 2514.3 596.6 741.5 746.2 748.6 751.5 8922.7 8944.3 8969.2 9029.7 9150.6 3523.3 3577.7 3623.3 3665.9 3666.0 7785.1 7800.8 7805.1 7868.4 7872.8 4081.2 4089.3 4108.1 4122.4 4155.5 3731.5 3757.0 3775.7 3786.4 3796.2 3210.1 3246.4 3248.7 3258.1 3291.9 1023.4 1033.4 1040.6 1052.5 1059.6 1131.3 1131.3 1147.7 1190.3 1198.7 6523.9 6591.0 6600.9 6609.7 6616.4 355.7 356.4 357.7 359.1 361.4 5171.5 5192.3 5201.9 5241.3 5255.7 7944.1 7978.7 8084.1 8148.1 8152.4 8107.6 8123.6 8147.9 8164.6 8170.6 5858.4 5969.8 6097.3 6431.8 6467.7 6416.8 6502.7 6528.2 6540.1 6587.2 7282.5 7358.9 7363.1 7367.2 7368.0 6566.0 6932.3 6959.4 6997.8 7496.4 6030.8 6121.0 6132.7 6181.0 6194.2 6239.3 6430.4 6483.0 6496.6 6508.8 5794.4 6035.5 6163.4 6264.3 6320.2 5954.5 6042.1 6042.9 6146.0 6201.9 6098.8 6145.7 6185.7 6253.0 6298.2 5545.9 5568.6 5664.2 5664.3 5691.3 5673.2 5712.2 5774.0 5809.6 5823.9 09:53:48 INFO - 2015-11-16 09:53:48,184 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,184 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4700.69 Median:5449.61 stddev:1430.78 (26.3%) stddev-sans-first:1395.71 09:53:48 INFO - 2015-11-16 09:53:48,185 DEBUG : BROWSER_OUTPUT: Values: 275.6 281.9 283.4 290.3 291.5 5151.5 5164.6 5325.6 5371.6 5426.9 5322.5 5355.7 5372.4 5388.7 5444.4 4053.9 4104.6 4131.3 4132.6 4160.5 3977.6 4163.0 4173.8 4176.7 4176.7 4062.7 4125.3 4147.8 4153.0 4230.5 4112.3 4116.6 4150.2 4154.8 4169.3 3513.5 3567.6 3588.1 3613.3 3616.1 5127.7 5129.7 5182.7 5224.5 5250.1 4619.5 4638.1 4675.4 4677.9 4687.6 5556.1 5572.7 5583.7 5627.8 5644.6 3821.9 3834.8 3862.7 3863.6 3888.5 5488.9 5835.1 5835.6 5879.5 5892.7 3256.7 3775.0 3785.6 3806.4 3850.4 3854.4 3857.7 3934.9 3935.8 3940.0 4504.5 4513.0 4538.7 4541.1 4543.0 5391.3 5570.1 5585.3 5607.1 5609.4 1369.0 1374.3 1386.3 1394.2 1400.8 887.5 912.3 927.7 930.8 939.3 5397.1 5450.2 5453.6 5482.7 5488.3 5857.6 5903.9 5908.6 5938.7 5940.7 5353.6 5393.8 5416.7 5449.0 5484.8 3150.7 3229.2 3248.0 3248.1 3278.0 5895.4 5958.3 5967.0 5973.4 5986.1 5991.9 6005.9 6020.8 6032.9 6039.9 5598.9 5751.4 5873.4 5944.0 5976.6 5838.2 5838.5 5888.9 5916.9 5929.9 5736.5 5759.9 5760.8 5771.5 5813.3 5881.2 5943.0 5979.4 6022.5 6052.2 3699.4 3761.2 3762.7 3854.5 3863.3 5748.9 5780.8 5783.7 5824.8 5835.1 5604.2 5610.1 5631.9 5654.3 5664.1 5564.7 5610.8 5612.2 5645.0 5658.4 5537.4 5539.3 5542.8 5586.6 5592.5 5650.1 5658.5 5688.9 5696.8 5715.3 5537.9 5538.6 5590.6 5601.8 5612.6 09:53:48 INFO - 2015-11-16 09:53:48,185 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,187 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12204.19 Median:30688.23 stddev:15048.96 (49.0%) stddev-sans-first:15065.60 09:53:48 INFO - 2015-11-16 09:53:48,187 DEBUG : BROWSER_OUTPUT: Values: 520.1 613.8 660.3 670.8 674.2 12138.2 12195.0 12473.5 12513.2 12619.0 11812.4 11856.3 11963.6 11973.6 11983.7 665.9 670.9 813.7 824.2 832.5 802.1 809.5 811.1 815.7 824.4 791.3 853.2 853.9 867.7 871.5 697.6 698.7 828.1 834.2 836.0 619.7 621.1 625.9 629.8 630.3 11942.8 12129.8 12152.3 12256.3 12306.0 10355.3 10645.4 10696.0 10851.3 11015.8 8457.8 8553.8 8608.9 8805.0 8880.2 2878.2 2943.5 2998.0 3024.3 3156.5 42888.6 43241.1 43359.1 43582.0 44275.6 7351.5 7885.0 7898.1 7944.8 7990.1 16712.9 16721.3 16730.5 16830.9 16862.5 6146.9 6409.8 6513.4 6623.3 6650.1 3298.3 3407.2 3424.8 3453.2 3589.5 2666.7 2678.8 2683.1 2692.9 2701.9 340.4 356.2 358.5 358.6 362.2 434.9 442.5 484.4 500.8 532.7 6366.5 6996.7 7051.2 7108.4 7421.9 407.4 410.4 431.8 446.9 470.2 3065.5 3396.5 3397.6 3496.4 3524.5 53753.5 54480.5 54666.0 54881.7 55452.0 47520.3 48204.5 48307.3 48326.8 48470.8 42809.0 43322.1 43551.3 43676.8 43991.8 6923.7 6964.8 7120.0 7132.6 7155.7 31034.4 31903.8 32239.0 32709.3 32980.0 39266.6 39340.4 40559.0 43866.6 43942.0 5924.5 5975.3 6108.1 6158.8 6171.8 9125.0 9353.5 9433.0 9572.5 9740.8 8608.1 8711.7 8788.5 8915.1 8915.6 8728.3 8877.4 8918.1 8925.0 8946.2 7930.0 8439.5 8772.4 8800.6 8806.6 7226.1 7231.0 7748.9 7795.5 7911.9 7321.0 7580.6 7609.0 7634.5 7665.7 09:53:48 INFO - 2015-11-16 09:53:48,187 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:53:48 INFO - 2015-11-16 09:53:48,187 DEBUG : BROWSER_OUTPUT: 09:53:48 INFO - 2015-11-16 09:53:48,850 INFO : Browser exited with error code: 0 09:53:48 INFO - 2015-11-16 09:53:48,883 INFO : Completed test dromaeo_css (00:18:35) 09:53:48 INFO - 2015-11-16 09:53:48,883 INFO : Starting test kraken 09:53:48 INFO - 2015-11-16 09:53:48,883 DEBUG : operating with platform_type : mac_ 09:53:48 INFO - 2015-11-16 09:53:48,883 INFO : Initialising browser for kraken test... 09:53:48 INFO - 2015-11-16 09:53:48,899 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpmHiwQw/profile http://localhost:49656/getInfo.html 09:53:51 INFO - 2015-11-16 09:53:51,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:53:51 INFO - 2015-11-16 09:53:51,661 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:53:51 INFO - 2015-11-16 09:53:51,662 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:53:51 INFO - 2015-11-16 09:53:51,662 DEBUG : BROWSER_OUTPUT: __metrics 09:53:51 INFO - 2015-11-16 09:53:51,677 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:52 INFO - 2015-11-16 09:53:52,411 INFO : Browser initialized. 09:53:52 INFO - 2015-11-16 09:53:52,412 INFO : Running cycle 1/1 for kraken test... 09:53:52 INFO - 2015-11-16 09:53:52,412 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpmHiwQw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:54:04 INFO - 2015-11-16 09:54:04,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 198828032 09:54:04 INFO - 2015-11-16 09:54:04,459 DEBUG : BROWSER_OUTPUT: 09:54:07 INFO - 2015-11-16 09:54:07,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-beat-detection) 09:54:07 INFO - 2015-11-16 09:54:07,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 264720384 09:54:07 INFO - 2015-11-16 09:54:07,878 DEBUG : BROWSER_OUTPUT: 09:54:10 INFO - 2015-11-16 09:54:10,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-dft) 09:54:11 INFO - 2015-11-16 09:54:11,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 278114304 09:54:11 INFO - 2015-11-16 09:54:11,431 DEBUG : BROWSER_OUTPUT: 09:54:14 INFO - 2015-11-16 09:54:14,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-fft) 09:54:15 INFO - 2015-11-16 09:54:15,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 266072064 09:54:15 INFO - 2015-11-16 09:54:15,169 DEBUG : BROWSER_OUTPUT: 09:54:17 INFO - 2015-11-16 09:54:17,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-oscillator) 09:54:18 INFO - 2015-11-16 09:54:18,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 267116544 09:54:18 INFO - 2015-11-16 09:54:18,003 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-16 09:54:20,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:54:21 INFO - 2015-11-16 09:54:21,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 267227136 09:54:21 INFO - 2015-11-16 09:54:21,020 DEBUG : BROWSER_OUTPUT: 09:54:24 INFO - 2015-11-16 09:54:24,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49656/tests/kraken/driver.html?testName=imaging-darkroom) 09:54:25 INFO - 2015-11-16 09:54:25,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 267436032 09:54:25 INFO - 2015-11-16 09:54:25,021 DEBUG : BROWSER_OUTPUT: 09:54:28 INFO - 2015-11-16 09:54:28,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49656/tests/kraken/driver.html?testName=imaging-desaturate) 09:54:29 INFO - 2015-11-16 09:54:29,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 265474048 09:54:29 INFO - 2015-11-16 09:54:29,109 DEBUG : BROWSER_OUTPUT: 09:54:32 INFO - 2015-11-16 09:54:32,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49656/tests/kraken/driver.html?testName=json-parse-financial) 09:54:32 INFO - 2015-11-16 09:54:32,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 264802304 09:54:32 INFO - 2015-11-16 09:54:32,934 DEBUG : BROWSER_OUTPUT: 09:54:34 INFO - 2015-11-16 09:54:34,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:54:35 INFO - 2015-11-16 09:54:35,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 298782720 09:54:35 INFO - 2015-11-16 09:54:35,236 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-16 09:54:37,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:54:37 INFO - 2015-11-16 09:54:37,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 299249664 09:54:37 INFO - 2015-11-16 09:54:37,820 DEBUG : BROWSER_OUTPUT: 09:54:40 INFO - 2015-11-16 09:54:40,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:40 INFO - 2015-11-16 09:54:40,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 306061312 09:54:40 INFO - 2015-11-16 09:54:40,681 DEBUG : BROWSER_OUTPUT: 09:54:43 INFO - 2015-11-16 09:54:43,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:44 INFO - 2015-11-16 09:54:44,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 308342784 09:54:44 INFO - 2015-11-16 09:54:44,113 DEBUG : BROWSER_OUTPUT: 09:54:46 INFO - 2015-11-16 09:54:46,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:54:47 INFO - 2015-11-16 09:54:47,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 307486720 09:54:47 INFO - 2015-11-16 09:54:47,535 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49656/tests/kraken/driver.html?testName=ai-astar) 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 365711360 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:54:49 INFO - 2015-11-16 09:54:49,654 DEBUG : BROWSER_OUTPUT: |0;ai-astar;119;129;120;126;128;125;112;125;125;112 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;149;193;186;148;174;148;183;180;151 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;188;189;187;187;180;185;189;188;188 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |3;audio-fft;91;89;90;143;79;81;81;82;142;96 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;115;159;105;104;105;149;103;103;152 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;136;142;136;136;136;141;138;135;141 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;147;147;146;146;147;146 09:54:49 INFO - 2015-11-16 09:54:49,655 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;119;123;122;118;118;118;118;117;125 09:54:49 INFO - 2015-11-16 09:54:49,656 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;66;70;69;72;73;73;82;66;66 09:54:49 INFO - 2015-11-16 09:54:49,656 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;72;75;76;76;77;78;77;77;77 09:54:49 INFO - 2015-11-16 09:54:49,656 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;95;95;96;96;95;96;102;102;103 09:54:49 INFO - 2015-11-16 09:54:49,656 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;141;145;149;146;140;138;143;155;145 09:54:49 INFO - 2015-11-16 09:54:49,656 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;170;167;168;174;168;171;168;170;155 09:54:49 INFO - 2015-11-16 09:54:49,656 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;76;76;81;81;80;80;82;85;80 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: __startTimestamp1447696489651__endTimestamp 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,657 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:54:49 INFO - 2015-11-16 09:54:49,658 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:54:49 INFO - 2015-11-16 09:54:49,658 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,658 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.10 Median:125.00 stddev:6.15 (4.9%) stddev-sans-first:6.42 09:54:49 INFO - 2015-11-16 09:54:49,659 DEBUG : BROWSER_OUTPUT: Values: 119.0 129.0 120.0 126.0 128.0 125.0 112.0 125.0 125.0 112.0 09:54:49 INFO - 2015-11-16 09:54:49,659 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,660 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:169.00 Median:179.00 stddev:17.93 (10.0%) stddev-sans-first:18.72 09:54:49 INFO - 2015-11-16 09:54:49,660 DEBUG : BROWSER_OUTPUT: Values: 178.0 149.0 193.0 186.0 148.0 174.0 148.0 183.0 180.0 151.0 09:54:49 INFO - 2015-11-16 09:54:49,660 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,660 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:186.40 Median:188.00 stddev:2.91 (1.5%) stddev-sans-first:2.82 09:54:49 INFO - 2015-11-16 09:54:49,660 DEBUG : BROWSER_OUTPUT: Values: 183.0 188.0 189.0 187.0 187.0 180.0 185.0 189.0 188.0 188.0 09:54:49 INFO - 2015-11-16 09:54:49,660 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.40 Median:85.50 stddev:24.38 (28.5%) stddev-sans-first:25.75 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: Values: 91.0 89.0 90.0 143.0 79.0 81.0 81.0 82.0 142.0 96.0 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.60 Median:113.00 stddev:23.03 (20.4%) stddev-sans-first:24.16 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 159.0 105.0 104.0 105.0 149.0 103.0 103.0 152.0 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,661 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.60 Median:137.00 stddev:2.72 (2.0%) stddev-sans-first:2.71 09:54:49 INFO - 2015-11-16 09:54:49,662 DEBUG : BROWSER_OUTPUT: Values: 135.0 136.0 142.0 136.0 136.0 136.0 141.0 138.0 135.0 141.0 09:54:49 INFO - 2015-11-16 09:54:49,662 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,662 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:54:49 INFO - 2015-11-16 09:54:49,662 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 09:54:49 INFO - 2015-11-16 09:54:49,663 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,663 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.70 Median:119.00 stddev:2.67 (2.2%) stddev-sans-first:2.82 09:54:49 INFO - 2015-11-16 09:54:49,663 DEBUG : BROWSER_OUTPUT: Values: 119.0 119.0 123.0 122.0 118.0 118.0 118.0 118.0 117.0 125.0 09:54:49 INFO - 2015-11-16 09:54:49,663 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,663 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.90 Median:71.00 stddev:5.57 (7.8%) stddev-sans-first:5.12 09:54:49 INFO - 2015-11-16 09:54:49,663 DEBUG : BROWSER_OUTPUT: Values: 62.0 66.0 70.0 69.0 72.0 73.0 73.0 82.0 66.0 66.0 09:54:49 INFO - 2015-11-16 09:54:49,664 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,664 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:77.00 stddev:3.33 (4.3%) stddev-sans-first:1.76 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: Values: 67.0 72.0 75.0 76.0 76.0 77.0 78.0 77.0 77.0 77.0 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:95.00 stddev:3.90 (4.1%) stddev-sans-first:3.46 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 95.0 96.0 96.0 95.0 96.0 102.0 102.0 103.0 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:145.00 stddev:4.86 (3.4%) stddev-sans-first:5.12 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: Values: 143.0 141.0 145.0 149.0 146.0 140.0 138.0 143.0 155.0 145.0 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:169.00 stddev:5.31 (3.1%) stddev-sans-first:5.28 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: Values: 162.0 170.0 167.0 168.0 174.0 168.0 171.0 168.0 170.0 155.0 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: 09:54:49 INFO - 2015-11-16 09:54:49,666 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.50 Median:80.50 stddev:3.27 (4.1%) stddev-sans-first:2.80 09:54:49 INFO - 2015-11-16 09:54:49,667 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 76.0 81.0 81.0 80.0 80.0 82.0 85.0 80.0 09:54:49 INFO - 2015-11-16 09:54:49,667 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:54:49 INFO - 2015-11-16 09:54:49,667 DEBUG : BROWSER_OUTPUT: 09:54:50 INFO - 2015-11-16 09:54:50,418 INFO : Browser exited with error code: 0 09:54:50 INFO - 2015-11-16 09:54:50,473 INFO : Completed test kraken (00:01:01) 09:54:50 INFO - 2015-11-16 09:54:50,474 INFO : Starting test v8_7 09:54:50 INFO - 2015-11-16 09:54:50,474 DEBUG : operating with platform_type : mac_ 09:54:50 INFO - 2015-11-16 09:54:50,474 INFO : Initialising browser for v8_7 test... 09:54:50 INFO - 2015-11-16 09:54:50,489 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmplD6uAY/profile http://localhost:49656/getInfo.html 09:54:52 INFO - 2015-11-16 09:54:52,968 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:54:52 INFO - 2015-11-16 09:54:52,968 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:54:52 INFO - 2015-11-16 09:54:52,968 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:54:52 INFO - 2015-11-16 09:54:52,968 DEBUG : BROWSER_OUTPUT: __metrics 09:54:52 INFO - 2015-11-16 09:54:52,984 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:54:53 INFO - 2015-11-16 09:54:53,734 INFO : Browser initialized. 09:54:53 INFO - 2015-11-16 09:54:53,735 INFO : Running cycle 1/1 for v8_7 test... 09:54:53 INFO - 2015-11-16 09:54:53,735 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmplD6uAY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:55:05 INFO - 2015-11-16 09:55:05,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 198885376 09:55:05 INFO - 2015-11-16 09:55:05,735 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/v8_7/run.html (next: http://localhost:49656/tests/v8_7/run.html) 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 517062656 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:55:28 INFO - 2015-11-16 09:55:28,586 DEBUG : BROWSER_OUTPUT: |0;Richards;188.64365214110546 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.42779167614282 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |2;Encrypt;365.4970760233918 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6635.761589403974 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1200.4801920768307 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |6;Boyer;14779.411764705883 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |7;RegExp;33716.666666666664 09:55:28 INFO - 2015-11-16 09:55:28,587 DEBUG : BROWSER_OUTPUT: |8;Splay;663.8044914134742 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6666.666666666667 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: __startTimestamp1447696528584__endTimestamp 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,588 DEBUG : BROWSER_OUTPUT: Values: 188.6 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.43 Median:227.43 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: Values: 227.4 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:365.50 Median:365.50 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: Values: 365.5 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,589 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6635.76 Median:6635.76 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: Values: 6635.8 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1200.48 Median:1200.48 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: Values: 1200.5 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: Values: 794.3 09:55:28 INFO - 2015-11-16 09:55:28,590 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14779.41 Median:14779.41 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: Values: 14779.4 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33716.67 Median:33716.67 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: Values: 33716.7 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:663.80 Median:663.80 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,591 DEBUG : BROWSER_OUTPUT: Values: 663.8 09:55:28 INFO - 2015-11-16 09:55:28,592 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-16 09:55:28,592 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6666.67 Median:6666.67 stddev:0.00 (0.0%) 09:55:28 INFO - 2015-11-16 09:55:28,592 DEBUG : BROWSER_OUTPUT: Values: 6666.7 09:55:28 INFO - 2015-11-16 09:55:28,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:55:28 INFO - 2015-11-16 09:55:28,592 DEBUG : BROWSER_OUTPUT: 09:55:29 INFO - 2015-11-16 09:55:29,259 INFO : Browser exited with error code: 0 09:55:29 INFO - 2015-11-16 09:55:29,282 INFO : Completed test v8_7 (00:00:38) 09:55:29 INFO - 2015-11-16 09:55:29,568 INFO : Completed test suite (00:20:16) 09:55:29 INFO - 2015-11-16 09:55:29,568 DEBUG : Working with test: dromaeo_css 09:55:29 INFO - 2015-11-16 09:55:29,569 DEBUG : Generating results file: dromaeo_css 09:55:29 INFO - 2015-11-16 09:55:29,569 DEBUG : Working with test: kraken 09:55:29 INFO - 2015-11-16 09:55:29,569 DEBUG : Generating results file: kraken 09:55:29 INFO - 2015-11-16 09:55:29,569 INFO : javascript benchmark 09:55:29 INFO - 2015-11-16 09:55:29,570 DEBUG : Working with test: v8_7 09:55:29 INFO - 2015-11-16 09:55:29,570 DEBUG : Generating results file: v8_7 09:55:29 INFO - 2015-11-16 09:55:29,570 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:55:29 INFO - 2015-11-16 09:55:29,635 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:55:29 INFO - 2015-11-16 09:55:29,635 DEBUG : process_Request line: dromaeo_css 6064.59 graph.html#tests=[[72,52,55]] 09:55:29 INFO - 2015-11-16 09:55:29,635 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:55:29 INFO - 2015-11-16 09:55:29,690 DEBUG : process_Request line: kraken 1732.70 graph.html#tests=[[232,52,55]] 09:55:29 INFO - 2015-11-16 09:55:29,690 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:55:29 INFO - 2015-11-16 09:55:29,875 DEBUG : process_Request line: v8_7 17618.87 graph.html#tests=[[230,52,55]] 09:55:29 INFO - 2015-11-16 09:55:29,876 INFO : javascript benchmark 09:55:29 INFO - 2015-11-16 09:55:29,878 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [302.2217789192829, 308.59882153200834, 310.5062949909643, 317.2686956565116, 317.6569305150437, 15458.072515649055, 15729.056256624595, 15873.206339683013, 17180.914095429536, 17281.654366912655, 16139.354425822952, 16214.432494862682, 16633.085180315076, 16638.16809159543, 16686.49940501787, 4593.3110033494995, 4718.57532822046, 4737.73942433166, 4774.1645212087915, 4792.257200133968, 3893.5717071122153, 4731.124741922756, 4752.16837053516, 4869.026194761044, 4884.242942343943, 4705.647076469261, 4736.2895565665085, 4742.4309082910095, 4762.809487620491, 4777.211760059586, 4591.173588754023, 4635.374224479686, 4647.744374059425, 4758.214894542396, 4774.06905653396, 4146.523149837777, 4156.521999969982, 4180.331147016463, 4184.497860256789, 4190.476190476191, 18801.435956921316, 18808.153633086546, 18846.62306753871, 18906.905465472584, 18986.81013189864, 1735.670222657691, 1763.2682436788718, 1784.643071385728, 1895.7440745499318, 1918.2806447582157, 11643.126765492538, 11680.824787628193, 11894.0, 11995.0, 12141.635750927486, 1440.387835170059, 1485.8885583581166, 1487.5983484459243, 1506.9397224111021, 1538.830728619851, 41631.375529367084, 42958.35562466565, 43509.34735978963, 52076.479235207924, 52671.73664131655, 8203.466774659628, 8228.547429891294, 8443.155684431631, 8517.23344898962, 8728.0, 9841.901580984098, 10075.193984481224, 10212.540435680412, 10530.420826854443, 10588.4705764713, 6836.418904393083, 6849.554778939353, 6862.759803406857, 6877.346652068046, 6891.793246202622, 6755.864882702318, 6850.588964662136, 6851.657417129124, 6870.244273129952, 6877.89683154753, 5018.949810501848, 5026.371703537058, 5177.8446646599905, 5214.97392513035, 5248.265242866002, 1502.9549113526612, 1503.361071544589, 1503.6090616439803, 1520.5666385080199, 1551.3251735495096, 831.463705909697, 933.8179055084194, 939.3049143633662, 946.1153821177221, 978.0072976691347, 15067.321970511353, 15879.841201588068, 16657.3337066516, 16943.91528042352, 17108.315667373416, 821.0762891746784, 842.8819965204876, 892.638481415028, 905.2395987370509, 937.7139972308375, 7349.081364829396, 7998.880016799752, 9655.275854310954, 9732.70801875945, 9743.805123897482, 498657.0, 499979.0, 505490.0, 512560.0, 519272.0, 50501.242481362075, 52507.73746131245, 60652.0, 62846.37153628405, 63381.415464613754, 365.2366553902357, 365.5722804318953, 366.62054773309495, 901.0538934119148, 924.3437159616612, 8733.388662793543, 8846.955765221133, 8880.111988801327, 9016.729498115066, 9063.093690630883, 30755.384892302478, 31381.686183137877, 31466.685333147292, 31507.212319691273, 31972.36055278835, 39460.802695986335, 42760.35859462173, 43082.0, 44176.33735493906, 44227.33658995182, 4847.903041939212, 5031.119554078095, 5036.445990940921, 5058.266551350107, 5060.721660308571, 9064.365494415328, 9223.400478968846, 9250.398724082914, 9302.348835581444, 9373.765655858386, 7694.307512323918, 8027.317677997436, 8063.758087257392, 8066.314363279187, 8097.068837083811, 7734.845303094019, 7833.1383547808555, 7840.176781437867, 7859.17478664732, 8067.354611631173, 7858.646360913658, 8057.194280571896, 8181.590920454072, 8295.004599448104, 8310.70912518059, 4899.11815873132, 4918.458969513422, 4934.407871055496, 4961.50384961501, 4984.077945580079, 7927.0, 7995.560244186626, 7998.600069996361, 8030.156833532628, 8099.554524501209], "dojo.html": [2770.9168724938254, 2854.9857250713744, 2887.8700458479366, 2951.6310461192343, 2952.527595584707, 4874.390701162355, 4897.240927656215, 4943.678660887049, 4980.3027576139275, 4987.476314986929, 4888.437829649592, 4914.508549145093, 4920.114379411704, 4972.32873562069, 4979.576735977437, 4403.845865394712, 4544.091181763644, 4587.128445595343, 4595.58639722425, 4642.907141857161, 4486.685931984763, 4507.571780680846, 4585.082983403316, 4589.2886602576655, 4604.102200070987, 4447.977760111195, 4483.574060464251, 4507.030988337507, 4562.201614717428, 4616.422947131608, 4436.955630443703, 4545.681802273843, 4552.0, 4577.633789296849, 4664.836730714409, 4465.173942820588, 4499.0, 4505.098980203972, 4529.6376289896725, 4552.908941821145, 4547.136044151601, 4578.931316030262, 4613.884652883671, 4675.4155730533685, 4774.0, 5072.82245121419, 5075.314832497603, 5107.668001579886, 5152.58779297659, 5229.764660590283, 5123.974380128113, 5162.664426812283, 5189.610779191576, 5218.60860435465, 5255.737213139328, 4626.21354369758, 4712.575868171881, 4713.835015774432, 4777.235642297216, 4871.951280487186, 5259.894802103937, 5324.547413469899, 5353.946460535422, 5397.676139431568, 5427.864303392446, 5065.265536497187, 5094.312267843868, 5117.616178786606, 5125.1287281162295, 5154.9484505155215, 4757.476677565465, 4946.258061290835, 5018.397792264952, 5077.568406685473, 5235.476452354734, 5064.518870707277, 5104.872378190501, 5109.029284435946, 5124.231365295235, 5169.327987361619, 5117.565006974449, 5135.15269980449, 5146.716930568855, 5175.223716442564, 5197.272381866466, 3811.4282857571584, 3895.7857317847793, 3918.490596222473, 3985.900352491211, 4064.918701625951, 3497.3180229855443, 3602.7838329700303, 3613.0786649404236, 3630.745847790682, 3633.4368172933237, 4784.928226076611, 4801.159797035505, 4821.276808478756, 4884.633652476078, 4911.926321105187, 5009.373828271466, 5103.234514822806, 5144.61415393847, 5153.896922061538, 5163.922541161885, 4816.686915350491, 4817.13291607507, 4828.903421931542, 4840.0, 4850.0, 4483.14820184164, 4533.523979982055, 4540.341650460665, 4559.4072770539615, 4595.172868883633, 4855.101806165871, 4964.8758781030765, 5051.797928082982, 5111.923321150111, 5227.320448341691, 5169.276301317894, 5184.559312458332, 5200.60995425337, 5207.088759467154, 5255.0540902637895, 5208.609354298518, 5217.869553261199, 5219.399769026611, 5313.760880760297, 5332.813351532678, 4868.90262194747, 4898.118338699069, 5084.796608135781, 5122.078025955364, 5128.153854613947, 5045.974770126126, 5062.746862656779, 5155.175171972466, 5156.355455568054, 5211.140161873249, 4819.7108173509705, 4929.728864912321, 4980.775865086008, 4994.0, 5005.924911126263, 4833.830815921426, 4880.243562247857, 4935.827246046371, 4960.379952505937, 4976.601871850316, 4942.925856112233, 5030.144875371268, 5036.899262014813, 5061.139606267017, 5090.898182036412, 5123.948760512347, 5163.561097306771, 5174.197999309962, 5179.0, 5179.449409797608, 4709.0817290628, 4787.54518320759, 4837.05677392905, 4862.294967229661, 5013.949860501349], "mootools.html": [740.9925900740991, 1216.1912328301678, 1270.3902126979049, 1286.4725462560352, 1288.6778305423645, 6219.160413344197, 6496.252930912947, 6667.166604174484, 6797.864042719155, 6827.351401616838, 6804.0, 6858.965705171479, 6873.175218973718, 6877.243503214655, 6901.378875901168, 1879.8966056866832, 1887.9150438230245, 1892.9905350473298, 1903.3528600275904, 1907.5612609099915, 1911.426572028393, 1918.788933217345, 1936.1771247219945, 1942.9514262143418, 1974.3583335415976, 1854.8887066776037, 1859.1076283383984, 1859.832615064644, 1892.924283028677, 1893.2710906301036, 1868.1780016792636, 1871.3637363296477, 1887.6696578098915, 1889.5559543507334, 1892.4890279624424, 1869.2896699254331, 1870.4575673054799, 1902.5338791995912, 1908.6850669639493, 1936.9830838809596, 6088.238970128734, 6744.224414192382, 6839.316068393171, 6844.486663500257, 6928.272531384233, 3604.27914417115, 3861.4787003754413, 3962.346212874872, 3993.8402463901407, 4036.777977211252, 2386.8567885926727, 2455.312512496486, 2476.1828596563273, 2511.2215213283757, 2514.3085651445817, 596.6092209602717, 741.4513260187476, 746.2462912458402, 748.5957582905224, 751.5227830327726, 8922.687705930326, 8944.284457243404, 8969.192772650427, 9029.729108126832, 9150.588223529958, 3523.295340931824, 3577.731670124751, 3623.2572322673786, 3665.890023299305, 3666.0, 7785.1436342002335, 7800.843983120306, 7805.063392392835, 7868.409869259828, 7872.803179920434, 4081.2041651878194, 4089.345704687236, 4108.137291168888, 4122.443470131554, 4155.501339839238, 3731.4962480065387, 3757.0043938356357, 3775.6601905828607, 3786.413105968579, 3796.2217745362136, 3210.06907996683, 3246.3831871944253, 3248.6751324867323, 3258.0714496368896, 3291.8518666660057, 1023.4013102335217, 1033.4419413516766, 1040.5785656809005, 1052.5421441672897, 1059.5814653212092, 1131.2759833706434, 1131.3155540897803, 1147.6729132197283, 1190.3096204201543, 1198.6583823610229, 6523.902141467882, 6590.9670451647435, 6600.900986485207, 6609.6695165241545, 6616.371444712745, 355.6532380928626, 356.4261538922333, 357.7370632585048, 359.10582649203815, 361.358588505405, 5171.4828517148735, 5192.299039629602, 5201.921971170435, 5241.292425522582, 5255.737213139328, 7944.126146123922, 7978.680852765824, 8084.1107478177355, 8148.144444833207, 8152.388570857091, 8107.635156417975, 8123.593820308961, 8147.9185208147155, 8164.591770411455, 8170.550619715973, 5858.384869588717, 5969.76120955157, 6097.2683278006925, 6431.839204019843, 6467.676616169173, 6416.807495775134, 6502.6748662567625, 6528.21661400635, 6540.149780528501, 6587.209534855848, 7282.4902256841515, 7358.926410736039, 7363.116426028911, 7367.2264412235945, 7368.0421545200925, 6565.967170164118, 6932.341427564374, 6959.4432445405255, 6997.755078572225, 7496.437767167376, 6030.819075427744, 6121.0, 6132.693365331626, 6180.969095154495, 6194.225721784777, 6239.251289845248, 6430.3891130342545, 6483.027545868157, 6496.610203387811, 6508.8047358579315, 5794.4205579443405, 6035.456808887221, 6163.38366163398, 6264.2796078451565, 6320.241571011508, 5954.493868021266, 6042.123892035718, 6042.939570604238, 6146.0166373381835, 6201.937980620317, 6098.847528811815, 6145.66198859067, 6185.659788711664, 6253.030780229072, 6298.212723409574, 5545.861353466034, 5568.638038527482, 5664.235328230636, 5664.263645726194, 5691.288588926384, 5673.205751194753, 5712.200291959046, 5773.971130144322, 5809.622374545641, 5823.912641310469], "ext.html": [498.9401271847379, 502.6958689992554, 502.90193412284617, 514.9433562308146, 532.2388983753236, 28450.43099138016, 29990.0, 36133.45799813002, 36913.630863691425, 37220.0, 39208.60791392085, 39647.80176099123, 39742.0, 39780.204395912064, 39871.40192897109, 7538.434617403689, 7979.640916158758, 8174.182581741838, 8227.0, 8235.21765432286, 7511.774646760578, 9169.403988740743, 9726.90273097267, 9873.950630246874, 9876.753081172956, 9498.620055197784, 9634.373765705242, 9733.124018838304, 9767.267454940873, 9779.315447918649, 7299.124105107368, 7656.425768067417, 9462.384944978554, 9529.380590261611, 9531.428114313163, 9429.104235097655, 9501.00239474852, 9518.85721714168, 9543.0, 9621.567029483691, 35882.282354353025, 35964.28071438583, 36030.63969360299, 36571.63428365709, 36663.63336366629, 2542.8220024598286, 2567.7817385522253, 2617.7251388604304, 2730.9726902730918, 3014.231371000381, 24721.381965450826, 25882.6117608236, 26468.86765566179, 26594.734052659613, 27579.0, 2030.1270453704901, 2043.9897800510903, 2052.1893851928403, 2056.0542150610736, 2072.554400803819, 257862.0, 259272.0, 259284.0, 259463.0, 259740.9999999981, 57358.7132064337, 58191.4180858186, 58227.0, 58232.4176758227, 58405.20366176185, 58574.41425585775, 60162.699186503785, 61496.0, 68263.3173668257, 69588.65205674041, 15720.0, 15938.0, 15955.840441595436, 16223.26995285215, 16231.0, 11915.88084119165, 11972.102092342935, 11982.52069917211, 11993.100517461226, 12129.87870121305, 18039.639207215783, 18927.24291028371, 18957.52606184829, 19045.428637140907, 19181.61636767257, 7585.962070189724, 7822.569758663328, 7851.332636725828, 7888.7633370998965, 7901.960490197513, 730.7551970090079, 735.1729304532402, 840.315143158324, 903.5662881816764, 971.6890595009529, 25445.23664290074, 25451.87274063618, 25507.36231594225, 25543.36141596475, 25617.8719106407, 806.3670019035029, 885.3315746611268, 898.196114477552, 920.7974245665943, 926.1433174313732, 12333.814992775115, 12664.936675316565, 12694.746105077847, 12714.364281785874, 12878.806817897552, 667511.0, 668125.0, 678789.0, 682791.0, 687315.0, 50064.499355006716, 50577.24134137991, 51670.74164629153, 51809.48190518122, 52065.47934520682, 1264.462603393554, 1267.4423253768311, 1279.7568461992191, 1285.5950375631646, 1300.2848433361423, 22250.554988900454, 26004.73995260099, 26598.335041624116, 27013.1896043119, 27824.860875695493, 46209.537904621866, 46368.072638546364, 46525.53474465212, 46659.300110497694, 46781.766091169324, 278356.0, 279751.0, 279948.0, 283512.0, 284283.0, 28652.570211447262, 29029.0, 40070.398944016444, 41859.0, 42284.0, 38983.610163897996, 39082.80458597689, 39152.21695566016, 39339.80330098446, 40167.0, 33150.83424582861, 33163.83418082894, 33337.49993750047, 33437.498437523944, 33629.49555756715, 32218.35563288768, 32918.34163316768, 33236.1690957728, 33303.33393332071, 33388.83305583554, 32824.179395515304, 33162.17094572655, 33408.0, 33436.164095897795, 33683.66316336805, 27978.58032129479, 28253.428923021704, 32105.197370065936, 32539.51190732188, 32890.83554582212, 22168.224112156644, 22248.0, 22540.0, 22558.097676092773, 23102.653460197773], "prototype.html": [275.6196448900517, 281.87456581821084, 283.4048498153877, 290.29458416049005, 291.45934291888557, 5151.484851514847, 5164.6384753067205, 5325.627206095575, 5371.570274378045, 5426.918596221055, 5322.494363035516, 5355.678659280446, 5372.382176049756, 5388.7305634718205, 5444.373897001846, 4053.918921621566, 4104.569020252883, 4131.277026520362, 4132.628063474287, 4160.521540022906, 3977.582353852847, 4162.979185104085, 4173.833046678129, 4176.7076304658685, 4176.728512646669, 4062.6546743526837, 4125.2780763366445, 4147.751134931914, 4152.97923510382, 4230.51349094855, 4112.3420252759415, 4116.567760385176, 4150.190712810988, 4154.771487568198, 4169.2703776838935, 3513.508108864761, 3567.571891373052, 3588.067102553329, 3613.33153366628, 3616.0959760059986, 5127.666701664417, 5129.717865517395, 5182.714950677711, 5224.4775522447835, 5250.05499010178, 4619.538046195387, 4638.141943740419, 4675.392199014141, 4677.88305292367, 4687.578117969365, 5556.138798486241, 5572.721363931828, 5583.720813959327, 5627.774889004435, 5644.604877658566, 3821.9235615287816, 3834.8466061357512, 3862.6523612874976, 3863.613638636114, 3888.494495715539, 5488.945110548923, 5835.066389377679, 5835.562332825055, 5879.500242479395, 5892.675902825343, 3256.661921530403, 3775.037365471842, 3785.6403641653997, 3806.3719486284454, 3850.403187505941, 3854.3640299350855, 3857.7106716996336, 3934.8622798201927, 3935.822887970048, 3940.014996250937, 4504.527024662363, 4512.9774351128035, 4538.704984176018, 4541.137183935041, 4542.954570454319, 5391.29913111293, 5570.108782594765, 5585.329760428694, 5607.074832652648, 5609.4390560943575, 1368.9520866769615, 1374.2853716067789, 1386.2652794018984, 1394.1844021247684, 1400.8108905297654, 887.494128346849, 912.3020889019905, 927.7077720518015, 930.7719608695913, 939.3143005605946, 5397.136458166675, 5450.182472629058, 5453.590980676465, 5482.698451585121, 5488.313960754906, 5857.58996870215, 5903.881922361615, 5908.586398952032, 5938.732757025944, 5940.732667029994, 5353.57171426285, 5393.78424863009, 5416.674999500043, 5449.04641687711, 5484.8354549363585, 3150.7164355207683, 3229.2088438332758, 3248.0, 3248.13924310058, 3278.0493656839726, 5895.35151133375, 5958.314793798769, 5967.0, 5973.37279585646, 5986.132010858489, 5991.910121348184, 6005.879882402415, 6020.789272375533, 6032.909506357408, 6039.909401358896, 5598.86002849932, 5751.396103409082, 5873.3832947539895, 5944.019236825875, 5976.551758618121, 5838.241028666246, 5838.532917366685, 5888.911666325094, 5916.852078698067, 5929.940700592939, 5736.483716465538, 5759.884802304015, 5760.827175184583, 5771.509421699203, 5813.273340832396, 5881.206037184926, 5942.970285148546, 5979.431953964367, 6022.48808851235, 6052.213212282375, 3699.3711069118854, 3761.153740408386, 3762.698984081212, 3854.5181852268465, 3863.265979463893, 5748.856278593069, 5780.768769249183, 5783.652980821164, 5824.825255242349, 5835.095560188178, 5604.243427137284, 5610.102383618601, 5631.887362252814, 5654.321481422091, 5664.065429204135, 5564.721763911869, 5610.775568977195, 5612.242347283228, 5644.971775141098, 5658.377578466448, 5537.418571050143, 5539.279893613804, 5542.7782888684005, 5586.636868603528, 5592.468715472024, 5650.124230744241, 5658.547316214611, 5688.914666280092, 5696.772129114789, 5715.31416230055, 5537.944620553743, 5538.639988400902, 5590.580706446952, 5601.80393686219, 5612.635178713371], "yui.html": [520.1183993131643, 613.7514306705783, 660.2769966886261, 670.842352047269, 674.1909708349979, 12138.15032947694, 12195.0, 12473.501059957602, 12513.249205047692, 12619.0, 11812.350320732356, 11856.288622682623, 11963.641090767269, 11973.580924667638, 11983.700407489818, 665.933406659335, 670.8691805098008, 813.6785969542027, 824.2128767027474, 832.4838600067936, 802.1176705623797, 809.522381794741, 811.0996793559144, 815.7267315449332, 824.3652387661497, 791.3471386106456, 853.185208126241, 853.9146085391442, 867.6876324523198, 871.5075982070142, 697.6372286411063, 698.7100353353378, 828.0725587342155, 834.1575009240711, 835.9623816928192, 619.6963487890946, 621.0776996160698, 625.8716963022615, 629.8173529676388, 630.2562975688686, 11942.761144777143, 12129.818052729217, 12152.270863748203, 12256.325902075472, 12306.0, 10355.275130740776, 10645.414502202375, 10696.0, 10851.348919064802, 11015.779684406267, 8457.830843383159, 8553.828923421559, 8608.870866937, 8805.0, 8880.24517915978, 2878.208492664513, 2943.5495920867843, 2998.0, 3024.3497648005564, 3156.526521021865, 42888.57111428908, 43241.13517729659, 43359.132817343474, 43582.0, 44275.557244427466, 7351.482201674729, 7884.960575197088, 7898.091719452336, 7944.761657150295, 7990.081140668781, 16712.91643541799, 16721.331146753993, 16730.49808505747, 16830.91584542094, 16862.494125176265, 6146.907796383058, 6409.839754006187, 6513.381228783258, 6623.271440141581, 6650.102236198148, 3298.340331933623, 3407.182276253731, 3424.8116353600294, 3453.240287136826, 3589.4795254687924, 2666.71999440056, 2678.7990900682526, 2683.1413947536603, 2692.8653567321558, 2701.9324516887236, 340.40429248814576, 356.1967762695158, 358.4855732024553, 358.5607630652482, 362.21580278696854, 434.9195398851223, 442.54417949512055, 484.428374518065, 500.7671432783773, 532.7256462921598, 6366.490680745529, 6996.650167491605, 7051.153861536648, 7108.431325493948, 7421.925780742124, 407.3807812125612, 410.386472224021, 431.784107946027, 446.9441319835021, 470.2123942396472, 3065.524843649238, 3396.541466901986, 3397.6262611112757, 3496.4056110461283, 3524.4713293006253, 53753.46246537485, 54480.45519544833, 54666.0, 54881.72559137179, 55452.0, 47520.28719569209, 48204.51795482, 48307.27539086917, 48326.75836620865, 48470.75764621155, 42809.0, 43322.07537690957, 43551.34672979908, 43676.781616091714, 43991.78004109959, 6923.688434020582, 6964.79105626832, 7120.038794762848, 7132.572045677069, 7155.677994490365, 31034.379312414076, 31903.840480797448, 32239.0, 32709.345813083128, 32980.0, 39266.607333926295, 39340.409893852186, 40559.0, 43866.56133438625, 43942.0, 5924.46679798803, 5975.25309336333, 6108.144859719554, 6158.815235542941, 6171.783987560414, 9124.954375228346, 9353.532323383668, 9433.0, 9572.521373931415, 9740.805183896424, 8608.09614990417, 8711.651533938571, 8788.516631585324, 8915.108489151033, 8915.554222288989, 8728.301735860989, 8877.422967507091, 8918.10818918103, 8925.018247992586, 8946.194842464209, 7929.960350198212, 8439.493630382196, 8772.38593298463, 8800.647974081221, 8806.647734090564, 7226.096737907762, 7230.950667626146, 7748.92251077482, 7795.4543181976715, 7911.8813217800625, 7321.0, 7580.62096895142, 7609.0, 7634.490330208703, 7665.731699390494]}, "summary": {"suite": 6064.587387255506, "subtests": {"jquery.html": {"filtered": 7052.733367306125, "value": 7052.733367306125}, "dojo.html": {"filtered": 4765.8195081251215, "value": 4765.8195081251215}, "mootools.html": {"filtered": 3747.8854227301244, "value": 3747.8854227301244}, "ext.html": {"filtered": 17648.14157391906, "value": 17648.14157391906}, "prototype.html": {"filtered": 4227.435495131465, "value": 4227.435495131465}, "yui.html": {"filtered": 5293.000438353602, "value": 5293.000438353602}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0025"}, "testrun": {"date": 1447695313, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151116080932", "branch": "Mozilla-Aurora", "revision": "a8608fc16c09c13e018c6007b9d7c211872bd202"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 188.0, 189.0, 187.0, 187.0, 180.0, 185.0, 189.0, 188.0, 188.0], "ai-astar": [119.0, 129.0, 120.0, 126.0, 128.0, 125.0, 112.0, 125.0, 125.0, 112.0], "imaging-gaussian-blur": [135.0, 136.0, 142.0, 136.0, 136.0, 136.0, 141.0, 138.0, 135.0, 141.0], "audio-beat-detection": [178.0, 149.0, 193.0, 186.0, 148.0, 174.0, 148.0, 183.0, 180.0, 151.0], "json-stringify-tinderbox": [67.0, 72.0, 75.0, 76.0, 76.0, 77.0, 78.0, 77.0, 77.0, 77.0], "stanford-crypto-pbkdf2": [162.0, 170.0, 167.0, 168.0, 174.0, 168.0, 171.0, 168.0, 170.0, 155.0], "json-parse-financial": [62.0, 66.0, 70.0, 69.0, 72.0, 73.0, 73.0, 82.0, 66.0, 66.0], "stanford-crypto-sha256-iterative": [74.0, 76.0, 76.0, 81.0, 81.0, 80.0, 80.0, 82.0, 85.0, 80.0], "audio-fft": [91.0, 89.0, 90.0, 143.0, 79.0, 81.0, 81.0, 82.0, 142.0, 96.0], "imaging-darkroom": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "stanford-crypto-ccm": [143.0, 141.0, 145.0, 149.0, 146.0, 140.0, 138.0, 143.0, 155.0, 145.0], "audio-oscillator": [111.0, 115.0, 159.0, 105.0, 104.0, 105.0, 149.0, 103.0, 103.0, 152.0], "stanford-crypto-aes": [91.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 102.0, 102.0, 103.0], "imaging-desaturate": [119.0, 119.0, 123.0, 122.0, 118.0, 118.0, 118.0, 118.0, 117.0, 125.0]}, "summary": {"suite": 1732.7, "subtests": {"audio-fft": {"filtered": 97.4, "value": 97.4}, "stanford-crypto-pbkdf2": {"filtered": 167.3, "value": 167.3}, "audio-beat-detection": {"filtered": 169.0, "value": 169.0}, "stanford-crypto-ccm": {"filtered": 144.5, "value": 144.5}, "imaging-darkroom": {"filtered": 146.4, "value": 146.4}, "json-parse-financial": {"filtered": 69.9, "value": 69.9}, "audio-oscillator": {"filtered": 120.6, "value": 120.6}, "ai-astar": {"filtered": 122.1, "value": 122.1}, "audio-dft": {"filtered": 186.4, "value": 186.4}, "stanford-crypto-sha256-iterative": {"filtered": 79.5, "value": 79.5}, "json-stringify-tinderbox": {"filtered": 75.2, "value": 75.2}, "imaging-gaussian-blur": {"filtered": 137.6, "value": 137.6}, "stanford-crypto-aes": {"filtered": 97.1, "value": 97.1}, "imaging-desaturate": {"filtered": 119.7, "value": 119.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0025"}, "testrun": {"date": 1447695313, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151116080932", "branch": "Mozilla-Aurora", "revision": "a8608fc16c09c13e018c6007b9d7c211872bd202"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.42779167614282], "Encrypt": [365.4970760233918], "NavierStokes": [6666.666666666667], "Decrypt": [6635.761589403974], "Splay": [663.8044914134742], "Richards": [188.64365214110546], "RegExp": [33716.666666666664], "Earley": [794.2811755361398], "Boyer": [14779.411764705883], "RayTrace": [1200.4801920768307]}, "summary": {"suite": 17618.872980590128, "subtests": {"DeltaBlue": {"filtered": 290.720846, "value": 290.720846}, "Encrypt": {"filtered": 728.2712159999999, "value": 728.2712159999999}, "NavierStokes": {"filtered": 222.59999999999985, "value": 222.59999999999985}, "Decrypt": {"filtered": 40.11310479041916, "value": 40.11310479041916}, "Splay": {"filtered": 122.76355621890548, "value": 122.76355621890548}, "RegExp": {"filtered": 27.018833415719214, "value": 27.018833415719214}, "Richards": {"filtered": 187.13590200000002, "value": 187.13590200000002}, "Earley": {"filtered": 839.0769169999999, "value": 839.0769169999999}, "Boyer": {"filtered": 45.09401393034823, "value": 45.09401393034823}, "RayTrace": {"filtered": 616.4108370000001, "value": 616.4108370000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0025"}, "testrun": {"date": 1447695313, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151116080932", "branch": "Mozilla-Aurora", "revision": "a8608fc16c09c13e018c6007b9d7c211872bd202"}}] 09:55:29 INFO - RETURN: dromaeo_css: 6064.59 09:55:29 INFO - RETURN: kraken: 1732.70 09:55:29 INFO - RETURN: v8_7: 17618.87 09:55:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17618.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1732.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6064.59"}}} 09:55:29 INFO - Return code: 0 09:55:29 INFO - # TBPL SUCCESS # 09:55:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:55:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:55:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:55:30 INFO - 2015-11-16 09:55:30.011 screenresolution[1948:12931] starting screenresolution argv=screenresolution get 09:55:30 INFO - 2015-11-16 09:55:30.015 screenresolution[1948:12931] Display 0: 1600x1200x32@60 09:55:30 INFO - 2015-11-16 09:55:30.021 screenresolution[1949:12934] starting screenresolution argv=screenresolution list 09:55:30 INFO - Available Modes on Display 0 09:55:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:55:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:55:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:55:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:55:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:55:30 INFO - Intel HD Graphics 3000: 09:55:30 INFO - Chipset Model: Intel HD Graphics 3000 09:55:30 INFO - Type: GPU 09:55:30 INFO - Bus: Built-In 09:55:30 INFO - VRAM (Total): 512 MB 09:55:30 INFO - VRAM (Dynamic, Max): 10 09:55:30 INFO - Vendor: Intel (0x8086) 09:55:30 INFO - Device ID: 0x0116 09:55:30 INFO - Revision ID: 0x0009 09:55:30 INFO - Displays: 09:55:30 INFO - Display: 09:55:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:55:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:55:30 INFO - Display Serial Number: 1600x1200 60 09:55:30 INFO - Main Display: Yes 09:55:30 INFO - Mirror: Off 09:55:30 INFO - Online: Yes 09:55:30 INFO - Rotation: Supported 09:55:30 INFO - Return code: 0 09:55:30 INFO - Running post-action listener: _resource_record_post_action 09:55:30 INFO - Running post-run listener: _resource_record_post_run 09:55:31 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 253952; Write bytes: 687443968; Read time: 248; Write time: 49874 09:55:31 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 333398528; Write bytes: 333735936; Read time: 35181; Write time: 5166 09:55:31 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 253952; Write bytes: 343443456; Read time: 248; Write time: 44123 09:55:31 INFO - Running post-run listener: _upload_blobber_files 09:55:31 INFO - Blob upload gear active. 09:55:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:55:31 INFO - Copying logs to upload dir... 09:55:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.620279 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-16 09:55:31.455528) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 09:55:31.459122) ========= 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.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010416 build_url: 'https://queue.taskcluster.net/v1/task/X27HnSUkT0m7ySfjucEmjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 09:55:31.488301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:55:31.488967) ========= 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.UoKQJ3O4r4/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.bZLGi1IWCR/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005517 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:55:31.541291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 09:55:31.541859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 09:55:31.542456) ========= ========= Total master_lag: 9.64 =========