builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0095 starttime: 1448880223.31 results: success (0) buildid: 20151130004006 builduid: 3fa642e90fb542db9b97daf4c7cff1b9 revision: 7ea5152b84175b42bfe7519e450d24e546e014db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.312512) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.312945) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.313239) ========= 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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.005844 basedir: '/builds/slave/test' ========= master_lag: 0.32 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.634972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.635287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.702024) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.702290) ========= 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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.036649 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.751374) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.751794) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.752257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:43.752543) ========= 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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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-30 02:43:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.91M=0.001s 2015-11-30 02:43:44 (8.91 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.242774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:44.006485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:44.006787) ========= 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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.126329 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:44.147725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-30 02:43:44.148032) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ea5152b84175b42bfe7519e450d24e546e014db --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 7ea5152b84175b42bfe7519e450d24e546e014db --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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-30 02:43:44,242 truncating revision to first 12 chars 2015-11-30 02:43:44,242 Setting DEBUG logging. 2015-11-30 02:43:44,242 attempt 1/10 2015-11-30 02:43:44,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ea5152b8417?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-30 02:43:45,536 unpacking tar archive at: mozilla-aurora-7ea5152b8417/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596397 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-30 02:43:45.756179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:45.756464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:45.771428) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:45.771691) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 02:43:45.772053) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2015-11-30 02:43:45.772345) ========= /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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:43:46 INFO - MultiFileLogger online at 20151130 02:43:46 in /builds/slave/test 02:43:46 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 02:43:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:43:46 INFO - {'append_to_log': False, 02:43:46 INFO - 'base_work_dir': '/builds/slave/test', 02:43:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:43:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:43:46 INFO - 'branch': 'Mozilla-Aurora', 02:43:46 INFO - 'buildbot_json_path': 'buildprops.json', 02:43:46 INFO - 'config_files': ('talos/mac_config.py',), 02:43:46 INFO - 'default_actions': ('clobber', 02:43:46 INFO - 'read-buildbot-config', 02:43:46 INFO - 'download-and-extract', 02:43:46 INFO - 'populate-webroot', 02:43:46 INFO - 'create-virtualenv', 02:43:46 INFO - 'install', 02:43:46 INFO - 'run-tests'), 02:43:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:43:46 INFO - 'download_minidump_stackwalk': True, 02:43:46 INFO - 'download_symbols': 'ondemand', 02:43:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:43:46 INFO - 'tooltool.py': '/tools/tooltool.py', 02:43:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:43:46 INFO - '/tools/misc-python/virtualenv.py')}, 02:43:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:43:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:43:46 INFO - 'installer_path': 'installer.exe', 02:43:46 INFO - 'log_level': 'info', 02:43:46 INFO - 'log_name': 'talos', 02:43:46 INFO - 'log_to_console': True, 02:43:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:43:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:43:46 INFO - 'opt_config_files': (), 02:43:46 INFO - 'pip_index': False, 02:43:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:43:46 INFO - 'cmd': ('bash', 02:43:46 INFO - '-c', 02:43:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:43:46 INFO - 'enabled': True, 02:43:46 INFO - 'halt_on_failure': False, 02:43:46 INFO - 'name': 'check_screen_resolution'},), 02:43:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:43:46 INFO - 'cmd': ('bash', 02:43:46 INFO - '-c', 02:43:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:43:46 INFO - 'enabled': True, 02:43:46 INFO - 'halt_on_failure': False, 02:43:46 INFO - 'name': 'check_screen_resolution'},), 02:43:46 INFO - 'run_cmd_checks_enabled': True, 02:43:46 INFO - 'sps_profile': False, 02:43:46 INFO - 'sps_profile_interval': 0, 02:43:46 INFO - 'suite': 'dromaeojs', 02:43:46 INFO - 'system_bits': '64', 02:43:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:43:46 INFO - 'title': 't-yosemite-r5-0095', 02:43:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:43:46 INFO - 'use_talos_json': True, 02:43:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:43:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:43:46 INFO - 'work_dir': 'build'} 02:43:46 INFO - ##### 02:43:46 INFO - ##### Running clobber step. 02:43:46 INFO - ##### 02:43:46 INFO - Running pre-action listener: _resource_record_pre_action 02:43:46 INFO - Running main action method: clobber 02:43:46 INFO - rmtree: /builds/slave/test/build 02:43:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:43:49 INFO - Running post-action listener: _resource_record_post_action 02:43:49 INFO - ##### 02:43:49 INFO - ##### Running read-buildbot-config step. 02:43:49 INFO - ##### 02:43:49 INFO - Running pre-action listener: _resource_record_pre_action 02:43:49 INFO - Running main action method: read_buildbot_config 02:43:49 INFO - Using buildbot properties: 02:43:49 INFO - { 02:43:49 INFO - "properties": { 02:43:49 INFO - "buildnumber": 443, 02:43:49 INFO - "product": "firefox", 02:43:49 INFO - "script_repo_revision": "production", 02:43:49 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:43:49 INFO - "repository": "", 02:43:49 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:43:49 INFO - "buildid": "20151130004006", 02:43:49 INFO - "slavename": "t-yosemite-r5-0095", 02:43:49 INFO - "stage_platform": "macosx64", 02:43:49 INFO - "basedir": "/builds/slave/test", 02:43:49 INFO - "nightly_build": "True", 02:43:49 INFO - "project": "", 02:43:49 INFO - "platform": "yosemite", 02:43:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:43:49 INFO - "slavebuilddir": "test", 02:43:49 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:43:49 INFO - "branch": "mozilla-aurora", 02:43:49 INFO - "repo_path": "releases/mozilla-aurora", 02:43:49 INFO - "pgo_build": "False", 02:43:49 INFO - "builduid": "3fa642e90fb542db9b97daf4c7cff1b9", 02:43:49 INFO - "revision": "7ea5152b84175b42bfe7519e450d24e546e014db" 02:43:49 INFO - }, 02:43:49 INFO - "sourcestamp": { 02:43:49 INFO - "repository": "", 02:43:49 INFO - "hasPatch": false, 02:43:49 INFO - "project": "", 02:43:49 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:43:49 INFO - "changes": [ 02:43:49 INFO - { 02:43:49 INFO - "category": null, 02:43:49 INFO - "files": [ 02:43:49 INFO - { 02:43:49 INFO - "url": null, 02:43:49 INFO - "name": "https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:43:49 INFO - } 02:43:49 INFO - ], 02:43:49 INFO - "repository": "", 02:43:49 INFO - "rev": "7ea5152b84175b42bfe7519e450d24e546e014db", 02:43:49 INFO - "who": "sendchange", 02:43:49 INFO - "when": 1448880159, 02:43:49 INFO - "number": 6720504, 02:43:49 INFO - "comments": "", 02:43:49 INFO - "project": "", 02:43:49 INFO - "at": "Mon 30 Nov 2015 02:42:39", 02:43:49 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:43:49 INFO - "revlink": "", 02:43:49 INFO - "properties": [ 02:43:49 INFO - [ 02:43:49 INFO - "buildid", 02:43:49 INFO - "20151130004006", 02:43:49 INFO - "Change" 02:43:49 INFO - ], 02:43:49 INFO - [ 02:43:49 INFO - "builduid", 02:43:49 INFO - "3fa642e90fb542db9b97daf4c7cff1b9", 02:43:49 INFO - "Change" 02:43:49 INFO - ], 02:43:49 INFO - [ 02:43:49 INFO - "nightly_build", 02:43:49 INFO - "True", 02:43:49 INFO - "Change" 02:43:49 INFO - ], 02:43:49 INFO - [ 02:43:49 INFO - "pgo_build", 02:43:49 INFO - "False", 02:43:49 INFO - "Change" 02:43:49 INFO - ] 02:43:49 INFO - ], 02:43:49 INFO - "revision": "7ea5152b84175b42bfe7519e450d24e546e014db" 02:43:49 INFO - } 02:43:49 INFO - ], 02:43:49 INFO - "revision": "7ea5152b84175b42bfe7519e450d24e546e014db" 02:43:49 INFO - } 02:43:49 INFO - } 02:43:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:43:49 INFO - Running post-action listener: _resource_record_post_action 02:43:49 INFO - ##### 02:43:49 INFO - ##### Running download-and-extract step. 02:43:49 INFO - ##### 02:43:49 INFO - Running pre-action listener: _resource_record_pre_action 02:43:49 INFO - Running main action method: download_and_extract 02:43:49 INFO - mkdir: /builds/slave/test/build/tests 02:43:49 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')]} 02:43:49 INFO - https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/test_packages.json 02:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/test_packages.json 02:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:43:52 INFO - Downloaded 1149 bytes. 02:43:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:43:52 INFO - Using the following test package requirements: 02:43:52 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:43:52 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:43:52 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'jsshell-mac.zip'], 02:43:52 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:43:52 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:43:52 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:43:52 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:43:52 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:43:52 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:43:52 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:43:52 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:43:52 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:43:52 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')]} 02:43:52 INFO - https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:43:54 INFO - Downloaded 17490245 bytes. 02:43:54 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 02:43:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:43:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:43:59 INFO - Return code: 0 02:43:59 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 02:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:59 INFO - https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:43:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:43:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:43:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:43:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:44:18 INFO - Downloaded 17490245 bytes. 02:44:18 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 02:44:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:44:25 INFO - Return code: 0 02:44: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')]} 02:44:25 INFO - https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:44:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:44:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:44:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:44:26 INFO - Downloaded 11131307 bytes. 02:44:26 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 02:44:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:44:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:44:27 INFO - Return code: 0 02:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:27 INFO - https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:44:32 INFO - Downloaded 107863920 bytes. 02:44:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:44:32 INFO - mkdir: /builds/slave/test/properties 02:44:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:32 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:32 INFO - Contents: 02:44:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:44:32 INFO - Running post-action listener: _resource_record_post_action 02:44:32 INFO - Running post-action listener: set_extra_try_arguments 02:44:32 INFO - ##### 02:44:32 INFO - ##### Running populate-webroot step. 02:44:32 INFO - ##### 02:44:32 INFO - Running pre-action listener: _resource_record_pre_action 02:44:32 INFO - Running main action method: populate_webroot 02:44:32 INFO - Guessing talos json url... 02:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:32 INFO - https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:44:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:44:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:44:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpdWTWE4ShupNWWMucNfOA/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 02:44:32 INFO - Downloaded 107 bytes. 02:44:32 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:44:32 INFO - Contents: 02:44:32 INFO - 20151130004006 02:44:32 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/7ea5152b84175b42bfe7519e450d24e546e014db 02:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:32 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7ea5152b84/testing/talos/talos.json 02:44:32 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7ea5152b84/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7ea5152b84/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:44:33 INFO - Downloaded 4264 bytes. 02:44:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:33 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:44:33 INFO - '../fennec_ids.txt'], 02:44:33 INFO - 'tests': ['tcheck2']}, 02:44:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:33 INFO - '--tppagecycles', 02:44:33 INFO - '7'], 02:44:33 INFO - 'tests': ['tsvgm']}}, 02:44:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:44:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:44:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:44:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'tests': ['damp', 'tps']}, 02:44:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['damp', 'tps']}, 02:44:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:44:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:33 INFO - 'other': {'tests': ['a11yr', 02:44:33 INFO - 'ts_paint', 02:44:33 INFO - 'tpaint', 02:44:33 INFO - 'sessionrestore', 02:44:33 INFO - 'sessionrestore_no_auto_restore']}, 02:44:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['a11yr', 02:44:33 INFO - 'ts_paint', 02:44:33 INFO - 'tpaint', 02:44:33 INFO - 'sessionrestore', 02:44:33 INFO - 'sessionrestore_no_auto_restore']}, 02:44:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['a11yr', 02:44:33 INFO - 'ts_paint', 02:44:33 INFO - 'tpaint', 02:44:33 INFO - 'sessionrestore', 02:44:33 INFO - 'sessionrestore_no_auto_restore']}, 02:44:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['a11yr', 02:44:33 INFO - 'ts_paint', 02:44:33 INFO - 'tpaint', 02:44:33 INFO - 'sessionrestore', 02:44:33 INFO - 'sessionrestore_no_auto_restore']}, 02:44:33 INFO - 'other_l64': {'tests': ['a11yr', 02:44:33 INFO - 'ts_paint', 02:44:33 INFO - 'tpaint', 02:44:33 INFO - 'sessionrestore', 02:44:33 INFO - 'sessionrestore_no_auto_restore']}, 02:44:33 INFO - 'other_nol64': {'tests': ['a11yr', 02:44:33 INFO - 'ts_paint', 02:44:33 INFO - 'tpaint', 02:44:33 INFO - 'sessionrestore', 02:44:33 INFO - 'sessionrestore_no_auto_restore']}, 02:44:33 INFO - 'svgr': {'tests': ['tsvgx', 02:44:33 INFO - 'tsvgr_opacity', 02:44:33 INFO - 'tart', 02:44:33 INFO - 'tscrollx', 02:44:33 INFO - 'cart']}, 02:44:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['tsvgx', 02:44:33 INFO - 'tsvgr_opacity', 02:44:33 INFO - 'tart', 02:44:33 INFO - 'tscrollx', 02:44:33 INFO - 'cart']}, 02:44:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'tests': ['tp5o']}, 02:44:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'talos_options': ['--e10s'], 02:44:33 INFO - 'tests': ['tp5o']}, 02:44:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'talos_options': ['--xperf_path', 02:44:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:33 INFO - 'tests': ['tp5n']}, 02:44:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:33 INFO - 'talos_options': ['--e10s', 02:44:33 INFO - '--xperf_path', 02:44:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:44:33 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:44:33 INFO - 'tests': ['tp5n']}}, 02:44:33 INFO - 'talos.zip': {'path': '', 02:44:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:33 INFO - Running post-action listener: _resource_record_post_action 02:44:33 INFO - ##### 02:44:33 INFO - ##### Running create-virtualenv step. 02:44:33 INFO - ##### 02:44:33 INFO - Running pre-action listener: _resource_record_pre_action 02:44:33 INFO - Running main action method: create_virtualenv 02:44:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:33 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 02:44:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:33 INFO - Using real prefix '/tools/python27' 02:44:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:38 INFO - Installing pip.................done. 02:44:38 INFO - Return code: 0 02:44:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:44:38 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 02:44:38 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 02:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:38 INFO - 'HOME': '/Users/cltbld', 02:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:38 INFO - 'LOGNAME': 'cltbld', 02:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:38 INFO - 'MOZ_NO_REMOTE': '1', 02:44:38 INFO - 'NO_EM_RESTART': '1', 02:44:38 INFO - 'PAGER': '/bin/cat', 02:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:38 INFO - 'PWD': '/builds/slave/test', 02:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:38 INFO - 'SHELL': '/bin/bash', 02:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:44:38 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:38 INFO - 'USER': 'cltbld', 02:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:38 INFO - 'XPC_FLAGS': '0x0', 02:44:38 INFO - 'XPC_SERVICE_NAME': '0', 02:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 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 02:44:39 INFO - Cleaning up... 02:44:39 INFO - Return code: 0 02:44:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:44:39 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')]} 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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')]} 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:44:39 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 02:44:39 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 02:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:39 INFO - 'HOME': '/Users/cltbld', 02:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:39 INFO - 'LOGNAME': 'cltbld', 02:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:39 INFO - 'MOZ_NO_REMOTE': '1', 02:44:39 INFO - 'NO_EM_RESTART': '1', 02:44:39 INFO - 'PAGER': '/bin/cat', 02:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:39 INFO - 'PWD': '/builds/slave/test', 02:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:39 INFO - 'SHELL': '/bin/bash', 02:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:44:39 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:39 INFO - 'USER': 'cltbld', 02:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:39 INFO - 'XPC_FLAGS': '0x0', 02:44:39 INFO - 'XPC_SERVICE_NAME': '0', 02:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 INFO - Downloading/unpacking psutil>=0.7.1 02:44:39 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 02:44:39 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 02:44:39 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 02:44:39 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 02:44:39 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 02:44:39 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 02:44:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:44:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:42 INFO - Installing collected packages: psutil 02:44:42 INFO - Running setup.py install for psutil 02:44:42 INFO - building 'psutil._psutil_osx' extension 02:44:42 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 02:44:44 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 02:44:44 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 02:44:44 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 02:44:45 INFO - building 'psutil._psutil_posix' extension 02:44:45 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 02:44:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:44:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:44:45 INFO - ^ 02:44:45 INFO - 1 warning generated. 02:44:45 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 02:44:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:45 INFO - Successfully installed psutil 02:44:45 INFO - Cleaning up... 02:44:45 INFO - Return code: 0 02:44:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:44:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:44:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:45 INFO - 'HOME': '/Users/cltbld', 02:44:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:45 INFO - 'LOGNAME': 'cltbld', 02:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:45 INFO - 'MOZ_NO_REMOTE': '1', 02:44:45 INFO - 'NO_EM_RESTART': '1', 02:44:45 INFO - 'PAGER': '/bin/cat', 02:44:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:45 INFO - 'PWD': '/builds/slave/test', 02:44:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:45 INFO - 'SHELL': '/bin/bash', 02:44:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:44:45 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:44:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:45 INFO - 'USER': 'cltbld', 02:44:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:45 INFO - 'XPC_FLAGS': '0x0', 02:44:45 INFO - 'XPC_SERVICE_NAME': '0', 02:44:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:44:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:44:48 INFO - Installing collected packages: mozsystemmonitor 02:44:48 INFO - Running setup.py install for mozsystemmonitor 02:44:48 INFO - Successfully installed mozsystemmonitor 02:44:48 INFO - Cleaning up... 02:44:49 INFO - Return code: 0 02:44:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44:49 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')]} 02:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:49 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')]} 02:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:49 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 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:44:49 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 02:44:49 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 02:44:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:44:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:49 INFO - 'HOME': '/Users/cltbld', 02:44:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:49 INFO - 'LOGNAME': 'cltbld', 02:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:49 INFO - 'MOZ_NO_REMOTE': '1', 02:44:49 INFO - 'NO_EM_RESTART': '1', 02:44:49 INFO - 'PAGER': '/bin/cat', 02:44:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:49 INFO - 'PWD': '/builds/slave/test', 02:44:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:49 INFO - 'SHELL': '/bin/bash', 02:44:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:44:49 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:44:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:49 INFO - 'USER': 'cltbld', 02:44:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:49 INFO - 'XPC_FLAGS': '0x0', 02:44:49 INFO - 'XPC_SERVICE_NAME': '0', 02:44:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44:53 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 02:44:53 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 02:44:53 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 02:44:53 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 02:44:53 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 02:44:53 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 02:44:53 INFO - Downloading docopt-0.6.1.tar.gz 02:44:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:53 INFO - Running setup.py install for blobuploader 02:44:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:53 INFO - Running setup.py install for requests 02:44:54 INFO - Running setup.py install for docopt 02:44:54 INFO - Successfully installed blobuploader requests docopt 02:44:54 INFO - Cleaning up... 02:44:54 INFO - Return code: 0 02:44:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:54 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')]} 02:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:54 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')]} 02:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:54 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 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:44:54 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 02:44:54 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 02:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:54 INFO - 'HOME': '/Users/cltbld', 02:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:54 INFO - 'LOGNAME': 'cltbld', 02:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:54 INFO - 'MOZ_NO_REMOTE': '1', 02:44:54 INFO - 'NO_EM_RESTART': '1', 02:44:54 INFO - 'PAGER': '/bin/cat', 02:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:54 INFO - 'PWD': '/builds/slave/test', 02:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:54 INFO - 'SHELL': '/bin/bash', 02:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:44:54 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:54 INFO - 'USER': 'cltbld', 02:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:54 INFO - 'XPC_FLAGS': '0x0', 02:44:54 INFO - 'XPC_SERVICE_NAME': '0', 02:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-7uEQCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-rQAlNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-46eULp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-7vlRjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-8Ys6Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-EyMH7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-G8UcAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-di6N7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-SbgsrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-1V1O9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-mwo9g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-qKpaSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-LFa6de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:56 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-6VH_Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:57 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-zv6Rnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:57 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-LVf07o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:57 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-sf7snG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:57 INFO - Running setup.py install for manifestparser 02:44:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:57 INFO - Running setup.py install for mozcrash 02:44:57 INFO - Running setup.py install for mozdebug 02:44:58 INFO - Running setup.py install for mozdevice 02:44:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozfile 02:44:58 INFO - Running setup.py install for mozhttpd 02:44:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozinfo 02:44:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozInstall 02:44:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozleak 02:44:59 INFO - Running setup.py install for mozlog 02:44:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for moznetwork 02:44:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozprocess 02:44:59 INFO - Running setup.py install for mozprofile 02:45:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Running setup.py install for mozrunner 02:45:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Running setup.py install for mozscreenshot 02:45:00 INFO - Running setup.py install for moztest 02:45:00 INFO - Running setup.py install for mozversion 02:45:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:00 INFO - Cleaning up... 02:45:00 INFO - Return code: 0 02:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45: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')]} 02:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:00 INFO - 'HOME': '/Users/cltbld', 02:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:00 INFO - 'LOGNAME': 'cltbld', 02:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:00 INFO - 'MOZ_NO_REMOTE': '1', 02:45:00 INFO - 'NO_EM_RESTART': '1', 02:45:00 INFO - 'PAGER': '/bin/cat', 02:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:00 INFO - 'PWD': '/builds/slave/test', 02:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:00 INFO - 'SHELL': '/bin/bash', 02:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:45:00 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:00 INFO - 'USER': 'cltbld', 02:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:00 INFO - 'XPC_FLAGS': '0x0', 02:45:00 INFO - 'XPC_SERVICE_NAME': '0', 02:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:01 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-N2hSOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:01 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-0D1Aq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:01 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-WP4FV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:01 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-pH8wAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:01 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-ROWo7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:01 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-g1hLE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-gXr0Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-VbpwBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-eQqk4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-U_hs_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-d2iOH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-OE25jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:02 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-LB3D3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:03 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-O2JLdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:03 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-E86xjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:03 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-1qk380-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:03 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-H4Ru2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:03 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 02:45:03 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 02:45:03 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 02:45:03 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 02:45:03 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 02:45:03 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 02:45:06 INFO - Downloading blessings-1.5.1.tar.gz 02:45:06 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 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:06 INFO - Installing collected packages: blessings 02:45:06 INFO - Running setup.py install for blessings 02:45:06 INFO - Successfully installed blessings 02:45:06 INFO - Cleaning up... 02:45:06 INFO - Return code: 0 02:45:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:07 INFO - Reading from file tmpfile_stdout 02:45:07 INFO - Current package versions: 02:45:07 INFO - blessings == 1.5.1 02:45:07 INFO - blobuploader == 1.2.4 02:45:07 INFO - docopt == 0.6.1 02:45:07 INFO - manifestparser == 1.1 02:45:07 INFO - mozInstall == 1.12 02:45:07 INFO - mozcrash == 0.16 02:45:07 INFO - mozdebug == 0.1 02:45:07 INFO - mozdevice == 0.46 02:45:07 INFO - mozfile == 1.2 02:45:07 INFO - mozhttpd == 0.7 02:45:07 INFO - mozinfo == 0.8 02:45:07 INFO - mozleak == 0.1 02:45:07 INFO - mozlog == 3.0 02:45:07 INFO - moznetwork == 0.27 02:45:07 INFO - mozprocess == 0.22 02:45:07 INFO - mozprofile == 0.27 02:45:07 INFO - mozrunner == 6.11 02:45:07 INFO - mozscreenshot == 0.1 02:45:07 INFO - mozsystemmonitor == 0.0 02:45:07 INFO - moztest == 0.7 02:45:07 INFO - mozversion == 1.4 02:45:07 INFO - psutil == 3.1.1 02:45:07 INFO - requests == 1.2.3 02:45:07 INFO - wsgiref == 0.1.2 02:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10efd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e524c94a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, '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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:45:07 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 02:45:07 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 02:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:07 INFO - 'HOME': '/Users/cltbld', 02:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:07 INFO - 'LOGNAME': 'cltbld', 02:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:07 INFO - 'MOZ_NO_REMOTE': '1', 02:45:07 INFO - 'NO_EM_RESTART': '1', 02:45:07 INFO - 'PAGER': '/bin/cat', 02:45:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:07 INFO - 'PWD': '/builds/slave/test', 02:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:07 INFO - 'SHELL': '/bin/bash', 02:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:45:07 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:07 INFO - 'USER': 'cltbld', 02:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:07 INFO - 'XPC_FLAGS': '0x0', 02:45:07 INFO - 'XPC_SERVICE_NAME': '0', 02:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 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)) 02:45:07 INFO - Cleaning up... 02:45:07 INFO - Return code: 0 02:45:07 INFO - Running post-action listener: _resource_record_post_action 02:45:07 INFO - Running post-action listener: _start_resource_monitoring 02:45:07 INFO - Starting resource monitoring. 02:45:07 INFO - ##### 02:45:07 INFO - ##### Running install step. 02:45:07 INFO - ##### 02:45:07 INFO - Running pre-action listener: _resource_record_pre_action 02:45:07 INFO - Running main action method: install 02:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:07 INFO - Reading from file tmpfile_stdout 02:45:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:08 INFO - Reading from file tmpfile_stdout 02:45:08 INFO - Output received: 02:45:08 INFO - Usage: mozinstall [options] installer 02:45:08 INFO - Options: 02:45:08 INFO - -h, --help show this help message and exit 02:45:08 INFO - -d DEST, --destination=DEST 02:45:08 INFO - Directory to install application into. [default: 02:45:08 INFO - "/builds/slave/test"] 02:45:08 INFO - --app=APP Application being installed. [default: firefox] 02:45:08 INFO - mkdir: /builds/slave/test/build/application 02:45:08 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'] 02:45:08 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 02:45:50 INFO - Reading from file tmpfile_stdout 02:45:50 INFO - Output received: 02:45:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:45:50 INFO - Running post-action listener: _resource_record_post_action 02:45:50 INFO - ##### 02:45:50 INFO - ##### Running run-tests step. 02:45:50 INFO - ##### 02:45:50 INFO - Running pre-action listener: _resource_record_pre_action 02:45:50 INFO - Running main action method: run_tests 02:45:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:45:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:45:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:45:50 INFO - 2015-11-30 02:45:50.105 screenresolution[1661:14131] starting screenresolution argv=screenresolution get 02:45:50 INFO - 2015-11-30 02:45:50.109 screenresolution[1661:14131] Display 0: 1600x1200x32@60 02:45:50 INFO - 2015-11-30 02:45:50.116 screenresolution[1662:14133] starting screenresolution argv=screenresolution list 02:45:50 INFO - Available Modes on Display 0 02:45:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:45:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:45:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:45:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:45:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:45:50 INFO - Intel HD Graphics 3000: 02:45:50 INFO - Chipset Model: Intel HD Graphics 3000 02:45:50 INFO - Type: GPU 02:45:50 INFO - Bus: Built-In 02:45:50 INFO - VRAM (Total): 512 MB 02:45:50 INFO - VRAM (Dynamic, Max): 10 02:45:50 INFO - Vendor: Intel (0x8086) 02:45:50 INFO - Device ID: 0x0116 02:45:50 INFO - Revision ID: 0x0009 02:45:50 INFO - Displays: 02:45:50 INFO - Display: 02:45:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:45:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:45:50 INFO - Display Serial Number: 1600x1200 60 02:45:50 INFO - Main Display: Yes 02:45:50 INFO - Mirror: Off 02:45:50 INFO - Online: Yes 02:45:50 INFO - Rotation: Supported 02:45:50 INFO - Return code: 0 02:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:50 INFO - Python 2.7.3 02:45:50 INFO - Return code: 0 02:45:50 INFO - grabbing minidump binary from tooltool 02:45:50 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')]} 02:45:50 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 0x10ef869f0>, '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 0x10ece5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef50990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:50 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 02:45:50 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 02:45:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:50 INFO - Return code: 0 02:45:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:45:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:45:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:50 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/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] in /builds/slave/test/build 02:45:50 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/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0095 --webServer localhost 02:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GYOrfCHlJg/Render', 02:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:50 INFO - 'HOME': '/Users/cltbld', 02:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:50 INFO - 'LOGNAME': 'cltbld', 02:45:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:50 INFO - 'MOZ_NO_REMOTE': '1', 02:45:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:50 INFO - 'NO_EM_RESTART': '1', 02:45:50 INFO - 'PAGER': '/bin/cat', 02:45:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:50 INFO - 'PWD': '/builds/slave/test', 02:45:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:50 INFO - 'SHELL': '/bin/bash', 02:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPV8EEk4vE/Listeners', 02:45:50 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:50 INFO - 'USER': 'cltbld', 02:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:50 INFO - 'XPC_FLAGS': '0x0', 02:45:50 INFO - 'XPC_SERVICE_NAME': '0', 02:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:50 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/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] with output_timeout 3600 02:45:50 INFO - mozversion INFO | application_buildid: 20151130004006 02:45:50 INFO - mozversion INFO | application_changeset: 7ea5152b84175b42bfe7519e450d24e546e014db 02:45:50 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:45:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:50 INFO - mozversion INFO | application_name: Firefox 02:45:50 INFO - mozversion INFO | application_remotingname: firefox-dev 02:45:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:45:50 INFO - mozversion INFO | application_vendor: Mozilla 02:45:50 INFO - mozversion INFO | application_version: 44.0a2 02:45:50 INFO - mozversion INFO | platform_buildid: 20151130004006 02:45:50 INFO - mozversion INFO | platform_changeset: 7ea5152b84175b42bfe7519e450d24e546e014db 02:45:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:45:50 INFO - mozversion INFO | platform_version: 44.0a2 02:45:50 INFO - 2015-11-30 02:45:50,905 DEBUG : using testdate: 1448880350 02:45:50 INFO - 2015-11-30 02:45:50,905 DEBUG : actual date: 1448880350 02:45:50 INFO - 2015-11-30 02:45:50,916 INFO : starting webserver on 'localhost:49288' 02:45:50 INFO - 2015-11-30 02:45:50,917 INFO : Starting test suite t-yosemite-r5-0095 02:45:50 INFO - 2015-11-30 02:45:50,917 INFO : Starting test dromaeo_css 02:45:50 INFO - 2015-11-30 02:45:50,917 DEBUG : operating with platform_type : mac_ 02:45:50 INFO - 2015-11-30 02:45:50,918 INFO : Initialising browser for dromaeo_css test... 02:45:50 INFO - 2015-11-30 02:45:50,953 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpALmyK4/profile http://localhost:49288/getInfo.html 02:45:54 INFO - 2015-11-30 02:45:54,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:45:54 INFO - 2015-11-30 02:45:54,616 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:45:54 INFO - 2015-11-30 02:45:54,616 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:45:54 INFO - 2015-11-30 02:45:54,616 DEBUG : BROWSER_OUTPUT: __metrics 02:45:54 INFO - 2015-11-30 02:45:54,632 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:45:55 INFO - 2015-11-30 02:45:55,393 INFO : Browser initialized. 02:45:55 INFO - 2015-11-30 02:45:55,393 INFO : Running cycle 1/1 for dromaeo_css test... 02:45:55 INFO - 2015-11-30 02:45:55,393 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpALmyK4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:46:07 INFO - 2015-11-30 02:46:07,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 199499776 02:46:07 INFO - 2015-11-30 02:46:07,530 DEBUG : BROWSER_OUTPUT: 02:46:59 INFO - 2015-11-30 02:46:59,272 DEBUG : BROWSER_OUTPUT: 1448880419271 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] 02:49:09 INFO - 2015-11-30 02:49:09,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 02:49:11 INFO - 2015-11-30 02:49:11,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 316452864 02:49:11 INFO - 2015-11-30 02:49:11,011 DEBUG : BROWSER_OUTPUT: 02:52:13 INFO - 2015-11-30 02:52:13,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 02:52:14 INFO - 2015-11-30 02:52:14,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 346673152 02:52:14 INFO - 2015-11-30 02:52:14,276 DEBUG : BROWSER_OUTPUT: 02:55:16 INFO - 2015-11-30 02:55:16,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 02:55:17 INFO - 2015-11-30 02:55:17,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 307544064 02:55:17 INFO - 2015-11-30 02:55:17,120 DEBUG : BROWSER_OUTPUT: 02:58:19 INFO - 2015-11-30 02:58:19,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 02:58:19 INFO - 2015-11-30 02:58:19,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 299667456 02:58:19 INFO - 2015-11-30 02:58:19,833 DEBUG : BROWSER_OUTPUT: 03:01:23 INFO - 2015-11-30 03:01:23,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 03:01:23 INFO - 2015-11-30 03:01:23,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 305389568 03:01:23 INFO - 2015-11-30 03:01:23,675 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 03:04:26 INFO - 2015-11-30 03:04:26,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 347086848 03:04:26 INFO - 2015-11-30 03:04:26,575 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,576 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:04:26 INFO - 2015-11-30 03:04:26,577 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:04:26 INFO - 2015-11-30 03:04:26,577 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:04:26 INFO - 2015-11-30 03:04:26,577 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:04:26 INFO - 2015-11-30 03:04:26,578 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2646.034197517906;2713.715059918707;2742.5337692592266;2751.463464624399;2753.2979090331964;4617;4647.604953578942;4664.626829853612;4688.2030054890665;4693.084848454549;4665.930011049829;4686.1799185142545;4717;4736.715797052179;4770.356001939737;4210.3894935234375;4315.71947823392;4341.544137865518;4394.824207031715;4424.867253982386;4293.8067786949505;4350.173467041268;4362.302031674933;4365.716228445157;4384.013596940678;4215.957840421587;4337.436133302682;4344.131173765244;4351.586599273064;4370.235208838457;4372.519022907493;4372.737635741865;4372.781360931941;4393.582609652078;4394.604485596312;4124.773137477438;4202.054537729017;4232.026633874226;4305.418768466279;4310.116426132667;4258.425112609789;4494.977525112354;4501.707389019736;4531.886702832423;4534.478534968488;4709.788059537329;4819.301201325823;4902;4961.776720047606;4975.4029516457895;5001.024800163969;5016.523430274118;5027.597792176617;5037.118504261776;5073.036123136592;4357.9128417431475;4529.705569138061;4536.818527258939;4598.770061496945;4639.211334073216;4920.286558449005;5071.290019397287;5080.974595127001;5090.720010399464;5122.897542049138;4856.101621200019;4886.462489126193;4934.087193869145;4945.975270123627;4949.554540091337;4693.718376897397;4742.928856067162;4775.068861572029;5029.044481548494;5040.420351659533;4713.293006049052;4827.734474603931;4833.685810422382;4842.806287748451;4852.902941941212;4942.135126352874;4964.801407943642;4969.229769385751;4981.37732783402;5003.2995380646735;3621.1128273573145;3706.09200745819;3719.1074142206216;3816.809159542012;3837.57786643469;3316.3201543683967;3395.8471868765964;3437.4671925851535;3437.9656203438144;3464.3071385722956;4625.213713668684;4679.4618618858585;4699.929501057487;4700.670953033255;4715.929261061086;4684.906301873943;4816.157172494799;4837.153498137882;5027.899442011212;5062.190049592047;4533.682642215079;4559.247724125548;4570.451545814457;4582.375555345003;4628.95371046292;4343.348497725303;4364.170807546556;4368.060866913629;4373.037931655031;4399.5380485049245;4896.485868983706;4974.32846565709;5018.222175562793;5078.289039534542;5096.184610462308;4821.156297647968;4920.852374428773;4930;4930.285108659296;4988.55103040728;5016.874578135576;5107.8212262572115;5122.257272695513;5128.871778205575;5132.255822905732;4577.542245775396;4698.271767875985;4701.647376446848;4925.359703238556;4928.310036594951;4846.80612775485;4959.479254678351;4963.354763880672;4986.177280748636;4995.525425084611;4817.5182481752945;4817.9518204817505;4823.9517604824905;4871.2206047032305;4885.096257192431;4484.237679594412;4705.64707646921;4717.8820529485665;4845.636577256791;4857.271409288635;4599.793009314656;4620.699654522446;4623.56076172763;4665.04366604852;4683.297505374221;4785.210440277455;4798.5441383068555;4806.975965120292;4827.468978412442;4846.103470857903;4517.616002639812;4523.208438523311;4613.561711637389;4651.953480465152;4746.501617330131 03:04:26 INFO - 2015-11-30 03:04:26,583 DEBUG : BROWSER_OUTPUT: |1;ext.html;456.8401059629129;466.66866524767414;470.5882352941176;474.9930148086056;505.1185680986679;28822.42355152896;29172.708272917265;34507.30985380291;34811.303773924505;35256.82371588145;37064;37601.435978460344;38031.42952855709;38045.42931856017;38229.426558601575;7051.294870512959;7761.417893657956;7913.2482414170845;7921.04947406312;7932.484388514757;7416.0729908761405;9332.860007099898;9399.859002114974;9625.133737963582;9666.178374838148;9330.860037099448;9383.81232375352;9395.530223488833;9407.952960235189;9451.905480945206;7506.924930750732;7591.3926885849;9414.482203478807;9425.905740942571;9549.904500955006;9272.397294175924;9433.575489103006;9464.763380915463;9495.715128546155;9505.952470237673;34827.6517234827;34912.65087349119;35299.4705079424;35498.645013549794;35649.287014259826;2538.9873050634815;2550.1584477122506;2667.293167310664;2699.811013229075;2924.897628583011;24548.263552093467;24679.5064098717;24710.382240443952;25342.493150137077;25477.3630659235;1935.3613307608596;1998.0808827939165;2002.6895831146196;2008.4075197816533;2015.5364266218705;251348;252473;255709;256338.71830640914;257261;48468.51531484711;49426;55745.163822542694;56158;56764;64230.35769642337;65212.67393663001;65690.34309656938;65849;66495.66752166208;14344.713105737826;14554.345054472575;14579.854201458062;14617.634559136106;14620.707585848224;10796.622118225825;10854;10860.402677852637;10952.726181845517;10982.835257471144;17581;18041;18147.72778408325;18199;18251.81748182501;6776.83057923546;6997.300269972962;7008.26413226614;7010.649467526705;7046.859062818715;734.3170851108521;773.8258891749311;855.9443636163629;904.3579058868146;931.512860662034;24217.273481795575;24468.877655611606;24543;24648.137315193882;24819.13133040335;873.6330741088758;891.7636826241052;900.8873890763655;911.6672414568635;1005.5625802775816;12064.819027714591;12387;12406.25562466255;12470.189437686522;13235.602931912059;283223;290267;294864;297458;298737;49044;49435.50564494309;49818.25272620914;50197.24704129368;50374.244386334234;1149.4482648328683;1191.666333426642;1203.332150656394;1207.3118322556234;1346.2393747532808;25258.24225273245;25921.611175832753;26042;26414.471710565296;26510.469790603693;43777.56222437862;44313.77843110764;44332.556674432846;44339;44797.776011119735;249723;251097;252023;252158;256632;27036.594451082856;27155.592666109627;27352.316192095357;27370.452590947672;27390.178294651192;37000;37085.62914370822;37438.43842342422;37792;38334.61665383422;30440.391192176474;31288.21779455532;31581;31654.208644784063;31836.52245216277;30836.84581577078;31005.534916975812;31037.224069398446;31064.22339441532;31252.531212032292;31963.840180798947;32531.186720331236;32565;32908.67091329056;33001.339973200884;26613.334666633487;27000.189994300203;27858.303542411602;27942.86028569844;28391.716082838906;20818.18954441131;21025.369238922856;21141.788582113983;21199.396102662893;21338.893305533373 03:04:26 INFO - 2015-11-30 03:04:26,583 DEBUG : BROWSER_OUTPUT: |2;jquery.html;283.78290607685113;285.86135724173784;298.9715976982186;299.49983527509056;304.61466245199813;12164.452599633016;12376.628701138958;14693;14969.625759356022;15544.145072021034;14830.258487075656;15051.172185529791;15540.922295388535;15542.53372398827;15552.144632045232;3461.8961431157104;3603.207294395242;3911.902202444933;4518.5481451854885;4714.5521175488275;4905.4849240829735;5056.3173971513925;5090.643654944155;5092.388913330406;5118.360204974379;3866.323393406157;3983.2830090583684;5078.974605126969;5080.415752188509;5141.100307446182;2939.4268117716947;2991.5512673098992;3921.156951255494;3967.0875698589343;3993.201359728066;3377.054424761071;3410.60778010527;3411.1131105912395;3411.300683359905;3435.604905435882;10386.480675966171;10416.479176041168;10542.736431589195;10592.470376481146;10601.575936962512;1593.283022639805;1635.5829263537842;1640.4012535424604;1644.8519633232947;1798.694221982266;7776.844463110762;7940.404469664741;8021.759347219593;8121.106678265386;8160.755177344689;1308.849482309537;1310.888574471171;1325.675209573651;1361.4894414594528;1375.3742047368423;52753.73623131898;53931.460685392645;54093.188602171;54112.729436352565;54322.72838635821;5368.4631536846;5396.271503346998;5450.5367043800925;5492.642978206404;5554.527865131509;6109.755609775648;6112.358202388774;6114.541409394314;6133.938660613426;6153.077038444269;4264;4333.198358303724;4448.021435284232;4466.397036400044;4492.752898590609;4445;4630.814767409266;4687.882802929954;4690.718556886598;4695.929561056587;2363.5272945410643;2380.952380952371;2409.4578719787905;2410.6986626671664;2414.1429792423437;841.2807049972308;877.0265005843509;882.4308321132834;913.3515204205089;944.4380593546829;330.0461665785881;330.30306054225565;331.78102452381313;333.34830406555125;352.5874726569868;8448.619812108469;9034.593443295067;9432.151106400457;9534.809303813885;9700.466474343837;355.16713307294356;364.843117459495;368.0485943835216;379.3702453926469;383.2430948875948;5075.540732259736;5081.932794113203;5263.947360526422;5270.474223528501;5293.5543718954195;464919;472796;479680;486127;488287;63280.36719632837;66573.66713166403;66697;67084;67227.66386168136;342.8097405939727;347.61762061731895;348.31729809573017;348.5625539947299;350.3553461630612;8449.155084491502;8705.956470217609;8780.78048048804;8828.955855220684;8880.378373513791;31305.53041704331;31399.21501962469;31545.21136971594;31696.5245521322;32185;43318.13363732771;43694.56305436905;43840.34239486474;44318;44529.55470445254;5128.076946149728;5158.613104017289;5182.585393168462;5193.091209038479;5207.192885102815;9428.057194280791;9431.528423578931;9475.620975161191;9498.240140788583;9517.714468565953;7768.84462310762;7991.600419979094;8256.091829898827;8348.165183481604;8351.582420879053;7985.041794984639;8013.6794528218215;8038.638261278374;8091.271785539329;8245.422820402755;7016.684249208696;7666.923330766621;8432.873506897278;8526.275266602408;8576.742697719079;5107.2594473800345;5147.5881929446305;5192.870178245423;5202.609804264771;5221.973890130525;8208.261256486945;8291.875621865556;8342.332613390792;8377.664893404439;8496.277816385676 03:04:26 INFO - 2015-11-30 03:04:26,586 DEBUG : BROWSER_OUTPUT: |3;mootools.html;628.5505863307734;1447.6019094748942;1522.1856306875816;1547.976780348295;1564.2257082744043;6156.784512542062;6379.840503987397;6562.442192413645;6682.498812589051;6760.763373281936;6539.444147247478;6543.901841472381;6610.27286998431;6728.629925354104;6758.797236082925;1918.3957053528163;1932.8260456558908;1936.0803618281345;1939.6120775844818;1946.1047917957756;1921.855860810438;1931.5557421792996;1937.7771556270998;1975.1111999600166;1979.4952287166752;1923.3268356075403;1937.2832052140727;1939.2436949589671;1944.2514631866763;1948.1720268885738;1852.138755478702;1879.6898511745615;1884.3122260375;1894.1381671339645;1901.2585091814203;1825.069214700499;1899.4016884681282;1906.65680177568;1934.8839069655867;1944.591635756493;5874.060150375919;6596.307387724316;6603.900941485882;6632.834179145511;6642.767503137367;3795.1650636859845;3966.1671049079728;4125.546189919107;4128.071183983609;4132.876013719593;2397.5324811661735;2426.2236084452984;2467;2472.8516289022537;2489.8381605195605;759.7682706774432;774.7559518751632;788.8225149341409;801.8316153607749;802.8113393352558;8751.343649226334;8761.956190219073;8844.469331840046;8898.332625053146;8903.510306933116;3511.5259439975275;3673.2102597941034;3677.4116141417244;3690.206605579813;3696.5194524711615;7250.383717384081;7284.927150728531;7296.489245752747;7305.671244793997;7323.633818309063;4107.014316564063;4150.543440221573;4150.771707556053;4151.564085771011;4152.730072545275;3817.0648191193336;3822.2737679840743;3838.2707285615643;3840.807959602065;3847.9807600961817;2921.7224363685414;2950.247686839842;2978.538326559387;2989.611350524418;3005.6543497497632;890.0520945193348;890.7639475538988;895.2524641924066;897.6454300551246;901.733988473402;854.747849384433;876.6318146378536;877.2981614708208;879.2131042716733;926.0878035135386;6010.188624535719;6114.541409394314;6138.570300078952;6192.133101365813;6208.4722798561725;978.5645387802502;995.2585323933715;1008.324422636835;1009.248110157937;1014.2595904989251;4706.62347012245;4901.1913034349645;5005.449400565934;5008.499150085036;5050.873728156826;7098.964505177544;7743.225677432211;8017.6792928283385;8020.679172833138;8047.798805029921;7912.4065695073095;7917;7986.361091112697;8030.39772017101;8056.7582972509745;6187.257529096537;6424.51816113784;6443.838904027343;6444.8388790280615;6458.580192287486;6330.525210609315;6356.792209480184;6360.300366959723;6370.458511026614;6382.680865956777;7150;7336.523125996793;7340.486165968331;7350.264973502821;7361.153467351109;7265.09186351706;7341.59621220838;7454.329110379875;7479.102507699111;7487.026686530716;5574.303212098488;5662.886742265049;5697.202391665087;5703.657780533182;5711.171880077282;6347.079673447417;6408.743650253938;6462.935370646233;6464.321246269074;6479.092926990131;6021.2473440819895;6065.4541091302;6080.513558915364;6144.293406258159;6205.689715514116;5818.679972601548;5912.556558258062;5963.850903727442;6019.608725432833;6022.126791615104;5915.940840591539;6099.085137229274;6101.84745381369;6111.908321375094;6141.815745527641;5525.613207075467;5539.113741801292;5547.472990065938;5585.497305242548;5591.608587399006;5509.118541033416;5535.252740880091;5542.168674698827;5546.72266386671;5563.749631266522 03:04:26 INFO - 2015-11-30 03:04:26,587 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.4285343631809;280.74452248453906;287.98560071996394;287.9999999999999;290.60913071918264;4959.603231741461;5093.465186155456;5141.768620412081;5168.586513078954;5215.42630310666;5110.233464980255;5124.871878203037;5135.743212839362;5154.4072431670365;5207.114790485617;4022.2960981828064;4054.4121102440126;4061.208064427423;4063.1467391847746;4069.3489041753323;3920.2551515212162;4026.4161696553983;4028.6777057835448;4034.8789536313957;4046.696497762665;4023.5574086850424;4057.8579749708765;4077.7349472284354;4078.3882417637296;4113.56807535209;4068.6745060395097;4072.9592704073175;4084.7344922580087;4096.85661001865;4106.384042393635;3533.4169861972746;3543.450765131409;3566.3937130687846;3592.6407359264126;3595.7662751921303;5010.549050585465;5015.072211640858;5036;5059.772310246048;5128.435872054071;4548.2495388260895;4551.112533056055;4566.063956888863;4607.14767767964;4630.606398456135;5395.757190926418;5403.405625381205;5404.973055119514;5444.945550544523;5510.614257002011;3771.641694039062;3774.452704357853;3789.8484060637816;3799.601041890617;3839.021049632354;5410.377806552257;5686.0617998030275;5691.174779656926;5749.080147176432;5791.276090488689;3554.3957527220437;3681.006128345332;3785.3943369060817;3829;3844.6539811416546;3913.7064720146104;3916.1580260244186;3920.5491368492417;3929.9607003929596;3943.3493473577114;4447.955520444754;4458.821647134078;4471.061077173765;4512.34570987205;4514.977425112919;5341.599380046512;5351.331083614548;5357.062514060024;5382.650127741685;5424.267723857229;1351.756683796926;1417.54638515674;1421.5593166118535;1424.3946322812762;1427.471835420901;935.1536859142487;936.6628013914985;939.1688355805026;951.3007939164846;952.6284748947916;5192.688438693691;5199.896002079937;5207.713575753294;5221.895562088737;5222.8955420892125;5543.833684989457;5588.552915766729;5615.634983726045;5661.065924122556;5663.32040155184;5198.818041368534;5223.190405487156;5234.581233501387;5251.789928402821;5263.868403289948;2986.22358186873;3068.432340017104;3104.301532155247;3109.9844500777353;3115.7818952673097;5702.401247868997;5742.913856292159;5765.4522820332;5775.768969241268;5782.045962416154;5759.596828221985;5789.073748200268;5791.391903850119;5828.358880523139;5829.038208695518;5544.61187716856;5750.482456578844;5755.740991655469;5773.364929857712;5780.566457515703;5628.493435590816;5637.46444087811;5654.6324488908085;5659.434056594308;5688.459596338341;5532.5297349724115;5539.833804985857;5542.3626282977975;5549.5837812163445;5611.80358687444;5709.457601527848;5722.856928576819;5749.281339832521;5787.016207244695;5812.796552120655;3586.300671369058;3648.5804132524036;3682.889513314498;3891.5135608048995;3917.6474117329576;5490.313710786152;5513.531349835149;5513.862153446196;5531.529819965348;5570.303712035996;5349.1976203569775;5349.839504814861;5358.946410535845;5366.356037275552;5415.052365835884;5319.601029922848;5343.973280133574;5349.1976203569775;5401.189821526646;5403.000444917703;5248.1340578804065;5288.471152884681;5308.601854860978;5310.522053015093;5322.787088516416;5402.243685883901;5405.864853378697;5411.648242864201;5412.83761487156;5440.755166017618;5285.392179899361;5303.4696530346655;5309.893802124013;5355.062863998863;5413.052715774802 03:04:26 INFO - 2015-11-30 03:04:26,591 DEBUG : BROWSER_OUTPUT: |5;yui.html;548.5282656915053;618.7463140112554;634.7080343042201;639.1626968671042;641.5925887061717;11730.589429369973;11732.82400763987;11753.294802311857;11793.469293881775;11816.350100744467;10977.560897564108;12070.939645301783;12346.197497162679;12387.194832335914;12426.316552589604;606.4269265544062;736.9889451658216;763.6410886883156;768.4390395011645;769.3422124083911;603.6378173096151;744.8696478116335;753.9849203015937;767.18678201107;768.3353898877459;777.4130531448749;789.5460110436493;797.5693125712108;803.8392321535687;805.118395357083;618.7092066728653;634.8666779976211;765.8544876473508;786.1705900275207;790.7430085222297;559.7033572206736;572.4390097704231;572.6621293436892;573.1460124414592;575.6172145523223;11562.30626162433;11694.941525292405;11734.354610496419;11787.528498860036;11858;8102.675892964275;8248.257656810856;8250.793730156734;8437.662493500253;8495.617697203641;7672;7685.846283074363;7744.7676569703;7840.960795196044;8145.389095817837;2426.0538390027905;2444.963325550118;2446.8042556595606;2490.651308816767;2492.538880307131;41921.580784192076;42108.78945605283;42668.359974600404;42870.78564607157;43332.56667433348;5678.4605462480995;5779.711014449261;5897.911531327033;5924.318703349084;5952;9582.275190465643;9591;9640.42157470554;9774.12032917041;9911.207103431709;5286.9471305287225;5310.7610157543;5313.149896016619;5316.069687804618;5342.252084708144;3045.543168524739;3080.2607374230024;3136.8274744888795;3288.8848890288723;3505.2814173094453;2304.746477887431;2315.282262498597;2322.303309007291;2327.55776402483;2357.174988753922;324.8229714805437;329.9373119107362;332.8302565691466;333.36493978969617;333.6796675191795;414.8506537646445;472.8557789874121;483.5841176588131;506.3898002906489;530.032690340123;6598.1422415085735;6752.831179220559;6964.338387853146;6997.160340759141;7023.92976070243;412.362939005061;438.1324976546456;440.37027051316284;499.64774833742126;542.967421954684;3148.1998882413877;3258.902232933016;3301.8679252829616;3325.401427742981;3435.0725304167736;54648.72675636596;55523;55598.72200638971;55789.721051395296;55839.44160558424;46835.5316446838;47104;47248.291275630894;47580;48385.032299353814;42324.78837605792;42389.36415953763;42476;44060.779696101956;44345.334819977725;6358.809235722936;6563.3764792344655;6625.933740662532;6675.327766428014;6862.073620061228;30025.249368765955;30258.394832103673;30389.24026899257;30397;31074;41559.37660935028;42194.57805421906;42221.788891055345;42301.85211084615;42491.7875410621;6317.842053948688;6376.39424254695;6446.387593178641;6446.935530644633;6583.374579414948;9621.807563848544;9675.70972870815;9709.223262139154;9727.12455878946;9918.950405248217;8536.189062039097;8588.785280368042;8703.347248956481;8987.865182022144;9036.23192028685;8333.250007499111;8513.775360261629;8772.561371931506;8811.471311721318;8966.820663586823;8881.600327985127;8942.68700595476;9005.954970225106;9009.144131307516;9417.764555886157;7778.844423111619;7813.413993950363;8014.19858014194;8214.917850821415;8347.666093356198;7787.766367008999;7816.491928024888;7831.804204894695;7861.135275119618;8346.582670866554 03:04:26 INFO - 2015-11-30 03:04:26,591 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:04:26 INFO - 2015-11-30 03:04:26,591 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:04:26 INFO - 2015-11-30 03:04:26,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 03:04:26 INFO - 2015-11-30 03:04:26,592 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:04:26 INFO - 2015-11-30 03:04:26,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1448881466575__endTimestamp 03:04:26 INFO - 2015-11-30 03:04:26,592 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,592 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:04:26 INFO - 2015-11-30 03:04:26,592 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:04:26 INFO - 2015-11-30 03:04:26,592 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,593 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4584.37 Median:4698.27 stddev:494.79 (10.5%) stddev-sans-first:472.36 03:04:26 INFO - 2015-11-30 03:04:26,593 DEBUG : BROWSER_OUTPUT: Values: 2646.0 2713.7 2742.5 2751.5 2753.3 4617.0 4647.6 4664.6 4688.2 4693.1 4665.9 4686.2 4717.0 4736.7 4770.4 4210.4 4315.7 4341.5 4394.8 4424.9 4293.8 4350.2 4362.3 4365.7 4384.0 4216.0 4337.4 4344.1 4351.6 4370.2 4372.5 4372.7 4372.8 4393.6 4394.6 4124.8 4202.1 4232.0 4305.4 4310.1 4258.4 4495.0 4501.7 4531.9 4534.5 4709.8 4819.3 4902.0 4961.8 4975.4 5001.0 5016.5 5027.6 5037.1 5073.0 4357.9 4529.7 4536.8 4598.8 4639.2 4920.3 5071.3 5081.0 5090.7 5122.9 4856.1 4886.5 4934.1 4946.0 4949.6 4693.7 4742.9 4775.1 5029.0 5040.4 4713.3 4827.7 4833.7 4842.8 4852.9 4942.1 4964.8 4969.2 4981.4 5003.3 3621.1 3706.1 3719.1 3816.8 3837.6 3316.3 3395.8 3437.5 3438.0 3464.3 4625.2 4679.5 4699.9 4700.7 4715.9 4684.9 4816.2 4837.2 5027.9 5062.2 4533.7 4559.2 4570.5 4582.4 4629.0 4343.3 4364.2 4368.1 4373.0 4399.5 4896.5 4974.3 5018.2 5078.3 5096.2 4821.2 4920.9 4930.0 4930.3 4988.6 5016.9 5107.8 5122.3 5128.9 5132.3 4577.5 4698.3 4701.6 4925.4 4928.3 4846.8 4959.5 4963.4 4986.2 4995.5 4817.5 4818.0 4824.0 4871.2 4885.1 4484.2 4705.6 4717.9 4845.6 4857.3 4599.8 4620.7 4623.6 4665.0 4683.3 4785.2 4798.5 4807.0 4827.5 4846.1 4517.6 4523.2 4613.6 4652.0 4746.5 03:04:26 INFO - 2015-11-30 03:04:26,593 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,593 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42157.78 Median:31617.60 stddev:69960.93 (221.3%) stddev-sans-first:70087.13 03:04:26 INFO - 2015-11-30 03:04:26,594 DEBUG : BROWSER_OUTPUT: Values: 456.8 466.7 470.6 475.0 505.1 28822.4 29172.7 34507.3 34811.3 35256.8 37064.0 37601.4 38031.4 38045.4 38229.4 7051.3 7761.4 7913.2 7921.0 7932.5 7416.1 9332.9 9399.9 9625.1 9666.2 9330.9 9383.8 9395.5 9408.0 9451.9 7506.9 7591.4 9414.5 9425.9 9549.9 9272.4 9433.6 9464.8 9495.7 9506.0 34827.7 34912.7 35299.5 35498.6 35649.3 2539.0 2550.2 2667.3 2699.8 2924.9 24548.3 24679.5 24710.4 25342.5 25477.4 1935.4 1998.1 2002.7 2008.4 2015.5 251348.0 252473.0 255709.0 256338.7 257261.0 48468.5 49426.0 55745.2 56158.0 56764.0 64230.4 65212.7 65690.3 65849.0 66495.7 14344.7 14554.3 14579.9 14617.6 14620.7 10796.6 10854.0 10860.4 10952.7 10982.8 17581.0 18041.0 18147.7 18199.0 18251.8 6776.8 6997.3 7008.3 7010.6 7046.9 734.3 773.8 855.9 904.4 931.5 24217.3 24468.9 24543.0 24648.1 24819.1 873.6 891.8 900.9 911.7 1005.6 12064.8 12387.0 12406.3 12470.2 13235.6 283223.0 290267.0 294864.0 297458.0 298737.0 49044.0 49435.5 49818.3 50197.2 50374.2 1149.4 1191.7 1203.3 1207.3 1346.2 25258.2 25921.6 26042.0 26414.5 26510.5 43777.6 44313.8 44332.6 44339.0 44797.8 249723.0 251097.0 252023.0 252158.0 256632.0 27036.6 27155.6 27352.3 27370.5 27390.2 37000.0 37085.6 37438.4 37792.0 38334.6 30440.4 31288.2 31581.0 31654.2 31836.5 30836.8 31005.5 31037.2 31064.2 31252.5 31963.8 32531.2 32565.0 32908.7 33001.3 26613.3 27000.2 27858.3 27942.9 28391.7 20818.2 21025.4 21141.8 21199.4 21338.9 03:04:26 INFO - 2015-11-30 03:04:26,594 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,594 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23506.32 Median:487207.00 stddev:78504.86 (16.1%) stddev-sans-first:78705.72 03:04:26 INFO - 2015-11-30 03:04:26,596 DEBUG : BROWSER_OUTPUT: Values: 283.8 285.9 299.0 299.5 304.6 12164.5 12376.6 14693.0 14969.6 15544.1 14830.3 15051.2 15540.9 15542.5 15552.1 3461.9 3603.2 3911.9 4518.5 4714.6 4905.5 5056.3 5090.6 5092.4 5118.4 3866.3 3983.3 5079.0 5080.4 5141.1 2939.4 2991.6 3921.2 3967.1 3993.2 3377.1 3410.6 3411.1 3411.3 3435.6 10386.5 10416.5 10542.7 10592.5 10601.6 1593.3 1635.6 1640.4 1644.9 1798.7 7776.8 7940.4 8021.8 8121.1 8160.8 1308.8 1310.9 1325.7 1361.5 1375.4 52753.7 53931.5 54093.2 54112.7 54322.7 5368.5 5396.3 5450.5 5492.6 5554.5 6109.8 6112.4 6114.5 6133.9 6153.1 4264.0 4333.2 4448.0 4466.4 4492.8 4445.0 4630.8 4687.9 4690.7 4695.9 2363.5 2381.0 2409.5 2410.7 2414.1 841.3 877.0 882.4 913.4 944.4 330.0 330.3 331.8 333.3 352.6 8448.6 9034.6 9432.2 9534.8 9700.5 355.2 364.8 368.0 379.4 383.2 5075.5 5081.9 5263.9 5270.5 5293.6 464919.0 472796.0 479680.0 486127.0 488287.0 63280.4 66573.7 66697.0 67084.0 67227.7 342.8 347.6 348.3 348.6 350.4 8449.2 8706.0 8780.8 8829.0 8880.4 31305.5 31399.2 31545.2 31696.5 32185.0 43318.1 43694.6 43840.3 44318.0 44529.6 5128.1 5158.6 5182.6 5193.1 5207.2 9428.1 9431.5 9475.6 9498.2 9517.7 7768.8 7991.6 8256.1 8348.2 8351.6 7985.0 8013.7 8038.6 8091.3 8245.4 7016.7 7666.9 8432.9 8526.3 8576.7 5107.3 5147.6 5192.9 5202.6 5222.0 8208.3 8291.9 8342.3 8377.7 8496.3 03:04:26 INFO - 2015-11-30 03:04:26,596 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,596 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4637.51 Median:6043.79 stddev:2397.88 (39.7%) stddev-sans-first:2385.65 03:04:26 INFO - 2015-11-30 03:04:26,596 DEBUG : BROWSER_OUTPUT: Values: 628.6 1447.6 1522.2 1548.0 1564.2 6156.8 6379.8 6562.4 6682.5 6760.8 6539.4 6543.9 6610.3 6728.6 6758.8 1918.4 1932.8 1936.1 1939.6 1946.1 1921.9 1931.6 1937.8 1975.1 1979.5 1923.3 1937.3 1939.2 1944.3 1948.2 1852.1 1879.7 1884.3 1894.1 1901.3 1825.1 1899.4 1906.7 1934.9 1944.6 5874.1 6596.3 6603.9 6632.8 6642.8 3795.2 3966.2 4125.5 4128.1 4132.9 2397.5 2426.2 2467.0 2472.9 2489.8 759.8 774.8 788.8 801.8 802.8 8751.3 8762.0 8844.5 8898.3 8903.5 3511.5 3673.2 3677.4 3690.2 3696.5 7250.4 7284.9 7296.5 7305.7 7323.6 4107.0 4150.5 4150.8 4151.6 4152.7 3817.1 3822.3 3838.3 3840.8 3848.0 2921.7 2950.2 2978.5 2989.6 3005.7 890.1 890.8 895.3 897.6 901.7 854.7 876.6 877.3 879.2 926.1 6010.2 6114.5 6138.6 6192.1 6208.5 978.6 995.3 1008.3 1009.2 1014.3 4706.6 4901.2 5005.4 5008.5 5050.9 7099.0 7743.2 8017.7 8020.7 8047.8 7912.4 7917.0 7986.4 8030.4 8056.8 6187.3 6424.5 6443.8 6444.8 6458.6 6330.5 6356.8 6360.3 6370.5 6382.7 7150.0 7336.5 7340.5 7350.3 7361.2 7265.1 7341.6 7454.3 7479.1 7487.0 5574.3 5662.9 5697.2 5703.7 5711.2 6347.1 6408.7 6462.9 6464.3 6479.1 6021.2 6065.5 6080.5 6144.3 6205.7 5818.7 5912.6 5963.9 6019.6 6022.1 5915.9 6099.1 6101.8 6111.9 6141.8 5525.6 5539.1 5547.5 5585.5 5591.6 5509.1 5535.3 5542.2 5546.7 5563.7 03:04:26 INFO - 2015-11-30 03:04:26,597 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,597 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4559.54 Median:5223.04 stddev:1352.38 (25.9%) stddev-sans-first:1317.36 03:04:26 INFO - 2015-11-30 03:04:26,598 DEBUG : BROWSER_OUTPUT: Values: 273.4 280.7 288.0 288.0 290.6 4959.6 5093.5 5141.8 5168.6 5215.4 5110.2 5124.9 5135.7 5154.4 5207.1 4022.3 4054.4 4061.2 4063.1 4069.3 3920.3 4026.4 4028.7 4034.9 4046.7 4023.6 4057.9 4077.7 4078.4 4113.6 4068.7 4073.0 4084.7 4096.9 4106.4 3533.4 3543.5 3566.4 3592.6 3595.8 5010.5 5015.1 5036.0 5059.8 5128.4 4548.2 4551.1 4566.1 4607.1 4630.6 5395.8 5403.4 5405.0 5444.9 5510.6 3771.6 3774.5 3789.8 3799.6 3839.0 5410.4 5686.1 5691.2 5749.1 5791.3 3554.4 3681.0 3785.4 3829.0 3844.7 3913.7 3916.2 3920.5 3930.0 3943.3 4448.0 4458.8 4471.1 4512.3 4515.0 5341.6 5351.3 5357.1 5382.7 5424.3 1351.8 1417.5 1421.6 1424.4 1427.5 935.2 936.7 939.2 951.3 952.6 5192.7 5199.9 5207.7 5221.9 5222.9 5543.8 5588.6 5615.6 5661.1 5663.3 5198.8 5223.2 5234.6 5251.8 5263.9 2986.2 3068.4 3104.3 3110.0 3115.8 5702.4 5742.9 5765.5 5775.8 5782.0 5759.6 5789.1 5791.4 5828.4 5829.0 5544.6 5750.5 5755.7 5773.4 5780.6 5628.5 5637.5 5654.6 5659.4 5688.5 5532.5 5539.8 5542.4 5549.6 5611.8 5709.5 5722.9 5749.3 5787.0 5812.8 3586.3 3648.6 3682.9 3891.5 3917.6 5490.3 5513.5 5513.9 5531.5 5570.3 5349.2 5349.8 5358.9 5366.4 5415.1 5319.6 5344.0 5349.2 5401.2 5403.0 5248.1 5288.5 5308.6 5310.5 5322.8 5402.2 5405.9 5411.6 5412.8 5440.8 5285.4 5303.5 5309.9 5355.1 5413.1 03:04:26 INFO - 2015-11-30 03:04:26,598 DEBUG : BROWSER_OUTPUT: 03:04:26 INFO - 2015-11-30 03:04:26,598 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11737.59 Median:574.38 stddev:15021.34 (2615.2%) stddev-sans-first:15039.98 03:04:26 INFO - 2015-11-30 03:04:26,600 DEBUG : BROWSER_OUTPUT: Values: 548.5 618.7 634.7 639.2 641.6 11730.6 11732.8 11753.3 11793.5 11816.4 10977.6 12070.9 12346.2 12387.2 12426.3 606.4 737.0 763.6 768.4 769.3 603.6 744.9 754.0 767.2 768.3 777.4 789.5 797.6 803.8 805.1 618.7 634.9 765.9 786.2 790.7 559.7 572.4 572.7 573.1 575.6 11562.3 11694.9 11734.4 11787.5 11858.0 8102.7 8248.3 8250.8 8437.7 8495.6 7672.0 7685.8 7744.8 7841.0 8145.4 2426.1 2445.0 2446.8 2490.7 2492.5 41921.6 42108.8 42668.4 42870.8 43332.6 5678.5 5779.7 5897.9 5924.3 5952.0 9582.3 9591.0 9640.4 9774.1 9911.2 5286.9 5310.8 5313.1 5316.1 5342.3 3045.5 3080.3 3136.8 3288.9 3505.3 2304.7 2315.3 2322.3 2327.6 2357.2 324.8 329.9 332.8 333.4 333.7 414.9 472.9 483.6 506.4 530.0 6598.1 6752.8 6964.3 6997.2 7023.9 412.4 438.1 440.4 499.6 543.0 3148.2 3258.9 3301.9 3325.4 3435.1 54648.7 55523.0 55598.7 55789.7 55839.4 46835.5 47104.0 47248.3 47580.0 48385.0 42324.8 42389.4 42476.0 44060.8 44345.3 6358.8 6563.4 6625.9 6675.3 6862.1 30025.2 30258.4 30389.2 30397.0 31074.0 41559.4 42194.6 42221.8 42301.9 42491.8 6317.8 6376.4 6446.4 6446.9 6583.4 9621.8 9675.7 9709.2 9727.1 9919.0 8536.2 8588.8 8703.3 8987.9 9036.2 8333.3 8513.8 8772.6 8811.5 8966.8 8881.6 8942.7 9006.0 9009.1 9417.8 7778.8 7813.4 8014.2 8214.9 8347.7 7787.8 7816.5 7831.8 7861.1 8346.6 03:04:26 INFO - 2015-11-30 03:04:26,600 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:04:26 INFO - 2015-11-30 03:04:26,600 DEBUG : BROWSER_OUTPUT: 03:04:27 INFO - 2015-11-30 03:04:27,275 INFO : Browser exited with error code: 0 03:04:27 INFO - 2015-11-30 03:04:27,308 INFO : Completed test dromaeo_css (00:18:36) 03:04:27 INFO - 2015-11-30 03:04:27,308 INFO : Starting test kraken 03:04:27 INFO - 2015-11-30 03:04:27,308 DEBUG : operating with platform_type : mac_ 03:04:27 INFO - 2015-11-30 03:04:27,308 INFO : Initialising browser for kraken test... 03:04:27 INFO - 2015-11-30 03:04:27,324 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpEMOdxK/profile http://localhost:49288/getInfo.html 03:04:29 INFO - 2015-11-30 03:04:29,898 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:04:29 INFO - 2015-11-30 03:04:29,898 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:04:29 INFO - 2015-11-30 03:04:29,898 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:04:29 INFO - 2015-11-30 03:04:29,898 DEBUG : BROWSER_OUTPUT: __metrics 03:04:29 INFO - 2015-11-30 03:04:29,914 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:04:30 INFO - 2015-11-30 03:04:30,673 INFO : Browser initialized. 03:04:30 INFO - 2015-11-30 03:04:30,674 INFO : Running cycle 1/1 for kraken test... 03:04:30 INFO - 2015-11-30 03:04:30,674 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpEMOdxK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:04:42 INFO - 2015-11-30 03:04:42,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 199102464 03:04:42 INFO - 2015-11-30 03:04:42,795 DEBUG : BROWSER_OUTPUT: 03:04:45 INFO - 2015-11-30 03:04:45,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:46 INFO - 2015-11-30 03:04:46,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 264421376 03:04:46 INFO - 2015-11-30 03:04:46,394 DEBUG : BROWSER_OUTPUT: 03:04:49 INFO - 2015-11-30 03:04:49,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 03:04:50 INFO - 2015-11-30 03:04:50,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 279011328 03:04:50 INFO - 2015-11-30 03:04:50,069 DEBUG : BROWSER_OUTPUT: 03:04:53 INFO - 2015-11-30 03:04:53,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 03:04:53 INFO - 2015-11-30 03:04:53,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 266645504 03:04:53 INFO - 2015-11-30 03:04:53,949 DEBUG : BROWSER_OUTPUT: 03:04:56 INFO - 2015-11-30 03:04:56,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 03:04:56 INFO - 2015-11-30 03:04:56,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 268091392 03:04:56 INFO - 2015-11-30 03:04:56,888 DEBUG : BROWSER_OUTPUT: 03:04:59 INFO - 2015-11-30 03:04:59,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:59 INFO - 2015-11-30 03:04:59,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 268206080 03:04:59 INFO - 2015-11-30 03:04:59,960 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-30 03:05:03,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:04 INFO - 2015-11-30 03:05:04,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 263401472 03:05:04 INFO - 2015-11-30 03:05:04,093 DEBUG : BROWSER_OUTPUT: 03:05:07 INFO - 2015-11-30 03:05:07,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:08 INFO - 2015-11-30 03:05:08,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 263208960 03:05:08 INFO - 2015-11-30 03:05:08,341 DEBUG : BROWSER_OUTPUT: 03:05:11 INFO - 2015-11-30 03:05:11,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 03:05:12 INFO - 2015-11-30 03:05:12,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 265297920 03:05:12 INFO - 2015-11-30 03:05:12,267 DEBUG : BROWSER_OUTPUT: 03:05:14 INFO - 2015-11-30 03:05:14,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:14 INFO - 2015-11-30 03:05:14,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 297578496 03:05:14 INFO - 2015-11-30 03:05:14,635 DEBUG : BROWSER_OUTPUT: 03:05:16 INFO - 2015-11-30 03:05:16,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:17 INFO - 2015-11-30 03:05:17,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 301297664 03:05:17 INFO - 2015-11-30 03:05:17,312 DEBUG : BROWSER_OUTPUT: 03:05:19 INFO - 2015-11-30 03:05:19,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:20 INFO - 2015-11-30 03:05:20,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 306384896 03:05:20 INFO - 2015-11-30 03:05:20,254 DEBUG : BROWSER_OUTPUT: 03:05:23 INFO - 2015-11-30 03:05:23,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:23 INFO - 2015-11-30 03:05:23,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 308453376 03:05:23 INFO - 2015-11-30 03:05:23,806 DEBUG : BROWSER_OUTPUT: 03:05:26 INFO - 2015-11-30 03:05:26,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:27 INFO - 2015-11-30 03:05:27,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 308506624 03:05:27 INFO - 2015-11-30 03:05:27,313 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 03:05:29 INFO - 2015-11-30 03:05:29,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 367329280 03:05:29 INFO - 2015-11-30 03:05:29,524 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,525 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:05:29 INFO - 2015-11-30 03:05:29,525 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:05:29 INFO - 2015-11-30 03:05:29,525 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:05:29 INFO - 2015-11-30 03:05:29,525 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:05:29 INFO - 2015-11-30 03:05:29,525 DEBUG : BROWSER_OUTPUT: |0;ai-astar;126;138;127;140;141;138;120;135;128;122 03:05:29 INFO - 2015-11-30 03:05:29,526 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;162;194;196;154;178;155;192;187;159 03:05:29 INFO - 2015-11-30 03:05:29,526 DEBUG : BROWSER_OUTPUT: |2;audio-dft;195;197;196;199;198;195;198;198;196;196 03:05:29 INFO - 2015-11-30 03:05:29,526 DEBUG : BROWSER_OUTPUT: |3;audio-fft;91;95;102;147;80;83;84;85;136;81 03:05:29 INFO - 2015-11-30 03:05:29,526 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;117;122;161;108;110;108;151;107;107;154 03:05:29 INFO - 2015-11-30 03:05:29,526 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;148;142;142;141;142;142;139;136;148 03:05:29 INFO - 2015-11-30 03:05:29,526 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;154;154;153;153;146;154;153;154;154;160 03:05:29 INFO - 2015-11-30 03:05:29,528 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;124;125;129;127;124;125;124;123;125;130 03:05:29 INFO - 2015-11-30 03:05:29,528 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;73;73;76;76;77;77;86;70;70 03:05:29 INFO - 2015-11-30 03:05:29,528 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;79;82;82;82;82;82;83;82;79 03:05:29 INFO - 2015-11-30 03:05:29,528 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;100;100;100;102;100;101;101;102;105 03:05:29 INFO - 2015-11-30 03:05:29,528 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;142;158;152;157;150;148;156;156;155;152 03:05:29 INFO - 2015-11-30 03:05:29,529 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;170;166;164;185;165;170;174;175;179;172 03:05:29 INFO - 2015-11-30 03:05:29,529 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;80;85;84;85;84;84;85;84;84 03:05:29 INFO - 2015-11-30 03:05:29,529 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:05:29 INFO - 2015-11-30 03:05:29,529 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:05:29 INFO - 2015-11-30 03:05:29,529 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 03:05:29 INFO - 2015-11-30 03:05:29,529 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:05:29 INFO - 2015-11-30 03:05:29,530 DEBUG : BROWSER_OUTPUT: __startTimestamp1448881529524__endTimestamp 03:05:29 INFO - 2015-11-30 03:05:29,530 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,530 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:05:29 INFO - 2015-11-30 03:05:29,530 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:05:29 INFO - 2015-11-30 03:05:29,530 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,532 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.50 Median:136.50 stddev:7.78 (5.7%) stddev-sans-first:7.99 03:05:29 INFO - 2015-11-30 03:05:29,532 DEBUG : BROWSER_OUTPUT: Values: 126.0 138.0 127.0 140.0 141.0 138.0 120.0 135.0 128.0 122.0 03:05:29 INFO - 2015-11-30 03:05:29,532 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,532 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:176.20 Median:186.00 stddev:16.98 (9.1%) stddev-sans-first:17.71 03:05:29 INFO - 2015-11-30 03:05:29,532 DEBUG : BROWSER_OUTPUT: Values: 185.0 162.0 194.0 196.0 154.0 178.0 155.0 192.0 187.0 159.0 03:05:29 INFO - 2015-11-30 03:05:29,532 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,533 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.80 Median:197.50 stddev:1.40 (0.7%) stddev-sans-first:1.32 03:05:29 INFO - 2015-11-30 03:05:29,533 DEBUG : BROWSER_OUTPUT: Values: 195.0 197.0 196.0 199.0 198.0 195.0 198.0 198.0 196.0 196.0 03:05:29 INFO - 2015-11-30 03:05:29,533 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,533 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:98.40 Median:83.50 stddev:23.85 (28.6%) stddev-sans-first:25.15 03:05:29 INFO - 2015-11-30 03:05:29,533 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 102.0 147.0 80.0 83.0 84.0 85.0 136.0 81.0 03:05:29 INFO - 2015-11-30 03:05:29,533 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,534 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:124.50 Median:119.50 stddev:21.95 (18.4%) stddev-sans-first:23.11 03:05:29 INFO - 2015-11-30 03:05:29,534 DEBUG : BROWSER_OUTPUT: Values: 117.0 122.0 161.0 108.0 110.0 108.0 151.0 107.0 107.0 154.0 03:05:29 INFO - 2015-11-30 03:05:29,534 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,534 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:142.90 Median:142.00 stddev:4.20 (3.0%) stddev-sans-first:3.83 03:05:29 INFO - 2015-11-30 03:05:29,534 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 142.0 142.0 141.0 142.0 142.0 139.0 136.0 148.0 03:05:29 INFO - 2015-11-30 03:05:29,534 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,535 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:153.50 Median:154.00 stddev:3.34 (2.2%) stddev-sans-first:3.54 03:05:29 INFO - 2015-11-30 03:05:29,535 DEBUG : BROWSER_OUTPUT: Values: 154.0 154.0 153.0 153.0 146.0 154.0 153.0 154.0 154.0 160.0 03:05:29 INFO - 2015-11-30 03:05:29,535 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,535 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.60 Median:125.00 stddev:2.32 (1.9%) stddev-sans-first:2.39 03:05:29 INFO - 2015-11-30 03:05:29,535 DEBUG : BROWSER_OUTPUT: Values: 124.0 125.0 129.0 127.0 124.0 125.0 124.0 123.0 125.0 130.0 03:05:29 INFO - 2015-11-30 03:05:29,536 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.30 Median:76.00 stddev:5.62 (7.4%) stddev-sans-first:4.85 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: Values: 65.0 73.0 73.0 76.0 76.0 77.0 77.0 86.0 70.0 70.0 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.70 Median:82.00 stddev:2.71 (3.3%) stddev-sans-first:1.42 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: Values: 74.0 79.0 82.0 82.0 82.0 82.0 82.0 83.0 82.0 79.0 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,537 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:100.60 Median:101.50 stddev:2.50 (2.5%) stddev-sans-first:1.64 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: Values: 95.0 100.0 100.0 100.0 102.0 100.0 101.0 101.0 102.0 105.0 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:155.50 stddev:4.93 (3.2%) stddev-sans-first:3.42 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: Values: 142.0 158.0 152.0 157.0 150.0 148.0 156.0 156.0 155.0 152.0 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:173.00 stddev:6.57 (3.8%) stddev-sans-first:6.92 03:05:29 INFO - 2015-11-30 03:05:29,538 DEBUG : BROWSER_OUTPUT: Values: 170.0 166.0 164.0 185.0 165.0 170.0 174.0 175.0 179.0 172.0 03:05:29 INFO - 2015-11-30 03:05:29,539 DEBUG : BROWSER_OUTPUT: 03:05:29 INFO - 2015-11-30 03:05:29,539 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.30 Median:84.00 stddev:2.36 (2.8%) stddev-sans-first:1.54 03:05:29 INFO - 2015-11-30 03:05:29,539 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 85.0 84.0 85.0 84.0 84.0 85.0 84.0 84.0 03:05:29 INFO - 2015-11-30 03:05:29,539 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:05:29 INFO - 2015-11-30 03:05:29,539 DEBUG : BROWSER_OUTPUT: 03:05:30 INFO - 2015-11-30 03:05:30,242 INFO : Browser exited with error code: 0 03:05:30 INFO - 2015-11-30 03:05:30,300 INFO : Completed test kraken (00:01:02) 03:05:30 INFO - 2015-11-30 03:05:30,300 INFO : Starting test v8_7 03:05:30 INFO - 2015-11-30 03:05:30,300 DEBUG : operating with platform_type : mac_ 03:05:30 INFO - 2015-11-30 03:05:30,300 INFO : Initialising browser for v8_7 test... 03:05:30 INFO - 2015-11-30 03:05:30,316 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpKnoDid/profile http://localhost:49288/getInfo.html 03:05:32 INFO - 2015-11-30 03:05:32,849 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:05:32 INFO - 2015-11-30 03:05:32,849 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:05:32 INFO - 2015-11-30 03:05:32,849 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:05:32 INFO - 2015-11-30 03:05:32,849 DEBUG : BROWSER_OUTPUT: __metrics 03:05:32 INFO - 2015-11-30 03:05:32,867 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:05:33 INFO - 2015-11-30 03:05:33,735 INFO : Browser initialized. 03:05:33 INFO - 2015-11-30 03:05:33,735 INFO : Running cycle 1/1 for v8_7 test... 03:05:33 INFO - 2015-11-30 03:05:33,735 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpKnoDid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:05:45 INFO - 2015-11-30 03:05:45,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 199938048 03:05:45 INFO - 2015-11-30 03:05:45,792 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/v8_7/run.html (next: http://localhost:49288/tests/v8_7/run.html) 03:06:08 INFO - 2015-11-30 03:06:08,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 526118912 03:06:08 INFO - 2015-11-30 03:06:08,969 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,969 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: |0;Richards;196.54088050314465 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;238.03856224708403 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: |2;Encrypt;375.6574004507889 03:06:08 INFO - 2015-11-30 03:06:08,970 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6738.255033557047 03:06:08 INFO - 2015-11-30 03:06:08,971 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1216.54501216545 03:06:08 INFO - 2015-11-30 03:06:08,971 DEBUG : BROWSER_OUTPUT: |5;Earley;834.7245409015025 03:06:08 INFO - 2015-11-30 03:06:08,971 DEBUG : BROWSER_OUTPUT: |6;Boyer;15676.923076923076 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: |7;RegExp;34879.31034482759 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: |8;Splay;723.589001447178 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6944.444444444444 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: __startTimestamp1448881568969__endTimestamp 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,972 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:06:08 INFO - 2015-11-30 03:06:08,973 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:06:08 INFO - 2015-11-30 03:06:08,974 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,974 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:196.54 Median:196.54 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,974 DEBUG : BROWSER_OUTPUT: Values: 196.5 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:238.04 Median:238.04 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: Values: 238.0 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:375.66 Median:375.66 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: Values: 375.7 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,975 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6738.26 Median:6738.26 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: Values: 6738.3 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1216.55 Median:1216.55 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: Values: 1216.5 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:834.72 Median:834.72 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,976 DEBUG : BROWSER_OUTPUT: Values: 834.7 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15676.92 Median:15676.92 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: Values: 15676.9 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34879.31 Median:34879.31 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: Values: 34879.3 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,977 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,978 DEBUG : BROWSER_OUTPUT: Values: 723.6 03:06:08 INFO - 2015-11-30 03:06:08,978 DEBUG : BROWSER_OUTPUT: 03:06:08 INFO - 2015-11-30 03:06:08,978 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6944.44 Median:6944.44 stddev:0.00 (0.0%) 03:06:08 INFO - 2015-11-30 03:06:08,978 DEBUG : BROWSER_OUTPUT: Values: 6944.4 03:06:08 INFO - 2015-11-30 03:06:08,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:06:08 INFO - 2015-11-30 03:06:08,978 DEBUG : BROWSER_OUTPUT: 03:06:09 INFO - 2015-11-30 03:06:09,680 INFO : Browser exited with error code: 0 03:06:09 INFO - 2015-11-30 03:06:09,703 INFO : Completed test v8_7 (00:00:39) 03:06:10 INFO - 2015-11-30 03:06:10,168 INFO : Completed test suite (00:20:19) 03:06:10 INFO - 2015-11-30 03:06:10,168 DEBUG : Working with test: dromaeo_css 03:06:10 INFO - 2015-11-30 03:06:10,168 DEBUG : Generating results file: dromaeo_css 03:06:10 INFO - 2015-11-30 03:06:10,169 DEBUG : Working with test: kraken 03:06:10 INFO - 2015-11-30 03:06:10,169 DEBUG : Generating results file: kraken 03:06:10 INFO - 2015-11-30 03:06:10,169 INFO : javascript benchmark 03:06:10 INFO - 2015-11-30 03:06:10,170 DEBUG : Working with test: v8_7 03:06:10 INFO - 2015-11-30 03:06:10,170 DEBUG : Generating results file: v8_7 03:06:10 INFO - 2015-11-30 03:06:10,170 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:06:10 INFO - 2015-11-30 03:06:10,226 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:06:10 INFO - 2015-11-30 03:06:10,226 DEBUG : process_Request line: dromaeo_css 5654.64 graph.html#tests=[[72,52,55]] 03:06:10 INFO - 2015-11-30 03:06:10,226 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:06:10 INFO - 2015-11-30 03:06:10,258 DEBUG : process_Request line: kraken 1812.90 graph.html#tests=[[232,52,55]] 03:06:10 INFO - 2015-11-30 03:06:10,258 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:06:10 INFO - 2015-11-30 03:06:10,287 DEBUG : process_Request line: v8_7 16910.68 graph.html#tests=[[230,52,55]] 03:06:10 INFO - 2015-11-30 03:06:10,288 INFO : javascript benchmark 03:06:10 INFO - 2015-11-30 03:06:10,290 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [283.78290607685113, 285.86135724173784, 298.9715976982186, 299.49983527509056, 304.61466245199813, 12164.452599633016, 12376.628701138958, 14693.0, 14969.625759356022, 15544.145072021034, 14830.258487075656, 15051.172185529791, 15540.922295388535, 15542.53372398827, 15552.144632045232, 3461.8961431157104, 3603.207294395242, 3911.902202444933, 4518.5481451854885, 4714.5521175488275, 4905.4849240829735, 5056.3173971513925, 5090.643654944155, 5092.388913330406, 5118.360204974379, 3866.323393406157, 3983.2830090583684, 5078.974605126969, 5080.415752188509, 5141.100307446182, 2939.4268117716947, 2991.5512673098992, 3921.156951255494, 3967.0875698589343, 3993.201359728066, 3377.054424761071, 3410.60778010527, 3411.1131105912395, 3411.300683359905, 3435.604905435882, 10386.480675966171, 10416.479176041168, 10542.736431589195, 10592.470376481146, 10601.575936962512, 1593.283022639805, 1635.5829263537842, 1640.4012535424604, 1644.8519633232947, 1798.694221982266, 7776.844463110762, 7940.404469664741, 8021.759347219593, 8121.106678265386, 8160.755177344689, 1308.849482309537, 1310.888574471171, 1325.675209573651, 1361.4894414594528, 1375.3742047368423, 52753.73623131898, 53931.460685392645, 54093.188602171, 54112.729436352565, 54322.72838635821, 5368.4631536846, 5396.271503346998, 5450.5367043800925, 5492.642978206404, 5554.527865131509, 6109.755609775648, 6112.358202388774, 6114.541409394314, 6133.938660613426, 6153.077038444269, 4264.0, 4333.198358303724, 4448.021435284232, 4466.397036400044, 4492.752898590609, 4445.0, 4630.814767409266, 4687.882802929954, 4690.718556886598, 4695.929561056587, 2363.5272945410643, 2380.952380952371, 2409.4578719787905, 2410.6986626671664, 2414.1429792423437, 841.2807049972308, 877.0265005843509, 882.4308321132834, 913.3515204205089, 944.4380593546829, 330.0461665785881, 330.30306054225565, 331.78102452381313, 333.34830406555125, 352.5874726569868, 8448.619812108469, 9034.593443295067, 9432.151106400457, 9534.809303813885, 9700.466474343837, 355.16713307294356, 364.843117459495, 368.0485943835216, 379.3702453926469, 383.2430948875948, 5075.540732259736, 5081.932794113203, 5263.947360526422, 5270.474223528501, 5293.5543718954195, 464919.0, 472796.0, 479680.0, 486127.0, 488287.0, 63280.36719632837, 66573.66713166403, 66697.0, 67084.0, 67227.66386168136, 342.8097405939727, 347.61762061731895, 348.31729809573017, 348.5625539947299, 350.3553461630612, 8449.155084491502, 8705.956470217609, 8780.78048048804, 8828.955855220684, 8880.378373513791, 31305.53041704331, 31399.21501962469, 31545.21136971594, 31696.5245521322, 32185.0, 43318.13363732771, 43694.56305436905, 43840.34239486474, 44318.0, 44529.55470445254, 5128.076946149728, 5158.613104017289, 5182.585393168462, 5193.091209038479, 5207.192885102815, 9428.057194280791, 9431.528423578931, 9475.620975161191, 9498.240140788583, 9517.714468565953, 7768.84462310762, 7991.600419979094, 8256.091829898827, 8348.165183481604, 8351.582420879053, 7985.041794984639, 8013.6794528218215, 8038.638261278374, 8091.271785539329, 8245.422820402755, 7016.684249208696, 7666.923330766621, 8432.873506897278, 8526.275266602408, 8576.742697719079, 5107.2594473800345, 5147.5881929446305, 5192.870178245423, 5202.609804264771, 5221.973890130525, 8208.261256486945, 8291.875621865556, 8342.332613390792, 8377.664893404439, 8496.277816385676], "dojo.html": [2646.034197517906, 2713.715059918707, 2742.5337692592266, 2751.463464624399, 2753.2979090331964, 4617.0, 4647.604953578942, 4664.626829853612, 4688.2030054890665, 4693.084848454549, 4665.930011049829, 4686.1799185142545, 4717.0, 4736.715797052179, 4770.356001939737, 4210.3894935234375, 4315.71947823392, 4341.544137865518, 4394.824207031715, 4424.867253982386, 4293.8067786949505, 4350.173467041268, 4362.302031674933, 4365.716228445157, 4384.013596940678, 4215.957840421587, 4337.436133302682, 4344.131173765244, 4351.586599273064, 4370.235208838457, 4372.519022907493, 4372.737635741865, 4372.781360931941, 4393.582609652078, 4394.604485596312, 4124.773137477438, 4202.054537729017, 4232.026633874226, 4305.418768466279, 4310.116426132667, 4258.425112609789, 4494.977525112354, 4501.707389019736, 4531.886702832423, 4534.478534968488, 4709.788059537329, 4819.301201325823, 4902.0, 4961.776720047606, 4975.4029516457895, 5001.024800163969, 5016.523430274118, 5027.597792176617, 5037.118504261776, 5073.036123136592, 4357.9128417431475, 4529.705569138061, 4536.818527258939, 4598.770061496945, 4639.211334073216, 4920.286558449005, 5071.290019397287, 5080.974595127001, 5090.720010399464, 5122.897542049138, 4856.101621200019, 4886.462489126193, 4934.087193869145, 4945.975270123627, 4949.554540091337, 4693.718376897397, 4742.928856067162, 4775.068861572029, 5029.044481548494, 5040.420351659533, 4713.293006049052, 4827.734474603931, 4833.685810422382, 4842.806287748451, 4852.902941941212, 4942.135126352874, 4964.801407943642, 4969.229769385751, 4981.37732783402, 5003.2995380646735, 3621.1128273573145, 3706.09200745819, 3719.1074142206216, 3816.809159542012, 3837.57786643469, 3316.3201543683967, 3395.8471868765964, 3437.4671925851535, 3437.9656203438144, 3464.3071385722956, 4625.213713668684, 4679.4618618858585, 4699.929501057487, 4700.670953033255, 4715.929261061086, 4684.906301873943, 4816.157172494799, 4837.153498137882, 5027.899442011212, 5062.190049592047, 4533.682642215079, 4559.247724125548, 4570.451545814457, 4582.375555345003, 4628.95371046292, 4343.348497725303, 4364.170807546556, 4368.060866913629, 4373.037931655031, 4399.5380485049245, 4896.485868983706, 4974.32846565709, 5018.222175562793, 5078.289039534542, 5096.184610462308, 4821.156297647968, 4920.852374428773, 4930.0, 4930.285108659296, 4988.55103040728, 5016.874578135576, 5107.8212262572115, 5122.257272695513, 5128.871778205575, 5132.255822905732, 4577.542245775396, 4698.271767875985, 4701.647376446848, 4925.359703238556, 4928.310036594951, 4846.80612775485, 4959.479254678351, 4963.354763880672, 4986.177280748636, 4995.525425084611, 4817.5182481752945, 4817.9518204817505, 4823.9517604824905, 4871.2206047032305, 4885.096257192431, 4484.237679594412, 4705.64707646921, 4717.8820529485665, 4845.636577256791, 4857.271409288635, 4599.793009314656, 4620.699654522446, 4623.56076172763, 4665.04366604852, 4683.297505374221, 4785.210440277455, 4798.5441383068555, 4806.975965120292, 4827.468978412442, 4846.103470857903, 4517.616002639812, 4523.208438523311, 4613.561711637389, 4651.953480465152, 4746.501617330131], "mootools.html": [628.5505863307734, 1447.6019094748942, 1522.1856306875816, 1547.976780348295, 1564.2257082744043, 6156.784512542062, 6379.840503987397, 6562.442192413645, 6682.498812589051, 6760.763373281936, 6539.444147247478, 6543.901841472381, 6610.27286998431, 6728.629925354104, 6758.797236082925, 1918.3957053528163, 1932.8260456558908, 1936.0803618281345, 1939.6120775844818, 1946.1047917957756, 1921.855860810438, 1931.5557421792996, 1937.7771556270998, 1975.1111999600166, 1979.4952287166752, 1923.3268356075403, 1937.2832052140727, 1939.2436949589671, 1944.2514631866763, 1948.1720268885738, 1852.138755478702, 1879.6898511745615, 1884.3122260375, 1894.1381671339645, 1901.2585091814203, 1825.069214700499, 1899.4016884681282, 1906.65680177568, 1934.8839069655867, 1944.591635756493, 5874.060150375919, 6596.307387724316, 6603.900941485882, 6632.834179145511, 6642.767503137367, 3795.1650636859845, 3966.1671049079728, 4125.546189919107, 4128.071183983609, 4132.876013719593, 2397.5324811661735, 2426.2236084452984, 2467.0, 2472.8516289022537, 2489.8381605195605, 759.7682706774432, 774.7559518751632, 788.8225149341409, 801.8316153607749, 802.8113393352558, 8751.343649226334, 8761.956190219073, 8844.469331840046, 8898.332625053146, 8903.510306933116, 3511.5259439975275, 3673.2102597941034, 3677.4116141417244, 3690.206605579813, 3696.5194524711615, 7250.383717384081, 7284.927150728531, 7296.489245752747, 7305.671244793997, 7323.633818309063, 4107.014316564063, 4150.543440221573, 4150.771707556053, 4151.564085771011, 4152.730072545275, 3817.0648191193336, 3822.2737679840743, 3838.2707285615643, 3840.807959602065, 3847.9807600961817, 2921.7224363685414, 2950.247686839842, 2978.538326559387, 2989.611350524418, 3005.6543497497632, 890.0520945193348, 890.7639475538988, 895.2524641924066, 897.6454300551246, 901.733988473402, 854.747849384433, 876.6318146378536, 877.2981614708208, 879.2131042716733, 926.0878035135386, 6010.188624535719, 6114.541409394314, 6138.570300078952, 6192.133101365813, 6208.4722798561725, 978.5645387802502, 995.2585323933715, 1008.324422636835, 1009.248110157937, 1014.2595904989251, 4706.62347012245, 4901.1913034349645, 5005.449400565934, 5008.499150085036, 5050.873728156826, 7098.964505177544, 7743.225677432211, 8017.6792928283385, 8020.679172833138, 8047.798805029921, 7912.4065695073095, 7917.0, 7986.361091112697, 8030.39772017101, 8056.7582972509745, 6187.257529096537, 6424.51816113784, 6443.838904027343, 6444.8388790280615, 6458.580192287486, 6330.525210609315, 6356.792209480184, 6360.300366959723, 6370.458511026614, 6382.680865956777, 7150.0, 7336.523125996793, 7340.486165968331, 7350.264973502821, 7361.153467351109, 7265.09186351706, 7341.59621220838, 7454.329110379875, 7479.102507699111, 7487.026686530716, 5574.303212098488, 5662.886742265049, 5697.202391665087, 5703.657780533182, 5711.171880077282, 6347.079673447417, 6408.743650253938, 6462.935370646233, 6464.321246269074, 6479.092926990131, 6021.2473440819895, 6065.4541091302, 6080.513558915364, 6144.293406258159, 6205.689715514116, 5818.679972601548, 5912.556558258062, 5963.850903727442, 6019.608725432833, 6022.126791615104, 5915.940840591539, 6099.085137229274, 6101.84745381369, 6111.908321375094, 6141.815745527641, 5525.613207075467, 5539.113741801292, 5547.472990065938, 5585.497305242548, 5591.608587399006, 5509.118541033416, 5535.252740880091, 5542.168674698827, 5546.72266386671, 5563.749631266522], "ext.html": [456.8401059629129, 466.66866524767414, 470.5882352941176, 474.9930148086056, 505.1185680986679, 28822.42355152896, 29172.708272917265, 34507.30985380291, 34811.303773924505, 35256.82371588145, 37064.0, 37601.435978460344, 38031.42952855709, 38045.42931856017, 38229.426558601575, 7051.294870512959, 7761.417893657956, 7913.2482414170845, 7921.04947406312, 7932.484388514757, 7416.0729908761405, 9332.860007099898, 9399.859002114974, 9625.133737963582, 9666.178374838148, 9330.860037099448, 9383.81232375352, 9395.530223488833, 9407.952960235189, 9451.905480945206, 7506.924930750732, 7591.3926885849, 9414.482203478807, 9425.905740942571, 9549.904500955006, 9272.397294175924, 9433.575489103006, 9464.763380915463, 9495.715128546155, 9505.952470237673, 34827.6517234827, 34912.65087349119, 35299.4705079424, 35498.645013549794, 35649.287014259826, 2538.9873050634815, 2550.1584477122506, 2667.293167310664, 2699.811013229075, 2924.897628583011, 24548.263552093467, 24679.5064098717, 24710.382240443952, 25342.493150137077, 25477.3630659235, 1935.3613307608596, 1998.0808827939165, 2002.6895831146196, 2008.4075197816533, 2015.5364266218705, 251348.0, 252473.0, 255709.0, 256338.71830640914, 257261.0, 48468.51531484711, 49426.0, 55745.163822542694, 56158.0, 56764.0, 64230.35769642337, 65212.67393663001, 65690.34309656938, 65849.0, 66495.66752166208, 14344.713105737826, 14554.345054472575, 14579.854201458062, 14617.634559136106, 14620.707585848224, 10796.622118225825, 10854.0, 10860.402677852637, 10952.726181845517, 10982.835257471144, 17581.0, 18041.0, 18147.72778408325, 18199.0, 18251.81748182501, 6776.83057923546, 6997.300269972962, 7008.26413226614, 7010.649467526705, 7046.859062818715, 734.3170851108521, 773.8258891749311, 855.9443636163629, 904.3579058868146, 931.512860662034, 24217.273481795575, 24468.877655611606, 24543.0, 24648.137315193882, 24819.13133040335, 873.6330741088758, 891.7636826241052, 900.8873890763655, 911.6672414568635, 1005.5625802775816, 12064.819027714591, 12387.0, 12406.25562466255, 12470.189437686522, 13235.602931912059, 283223.0, 290267.0, 294864.0, 297458.0, 298737.0, 49044.0, 49435.50564494309, 49818.25272620914, 50197.24704129368, 50374.244386334234, 1149.4482648328683, 1191.666333426642, 1203.332150656394, 1207.3118322556234, 1346.2393747532808, 25258.24225273245, 25921.611175832753, 26042.0, 26414.471710565296, 26510.469790603693, 43777.56222437862, 44313.77843110764, 44332.556674432846, 44339.0, 44797.776011119735, 249723.0, 251097.0, 252023.0, 252158.0, 256632.0, 27036.594451082856, 27155.592666109627, 27352.316192095357, 27370.452590947672, 27390.178294651192, 37000.0, 37085.62914370822, 37438.43842342422, 37792.0, 38334.61665383422, 30440.391192176474, 31288.21779455532, 31581.0, 31654.208644784063, 31836.52245216277, 30836.84581577078, 31005.534916975812, 31037.224069398446, 31064.22339441532, 31252.531212032292, 31963.840180798947, 32531.186720331236, 32565.0, 32908.67091329056, 33001.339973200884, 26613.334666633487, 27000.189994300203, 27858.303542411602, 27942.86028569844, 28391.716082838906, 20818.18954441131, 21025.369238922856, 21141.788582113983, 21199.396102662893, 21338.893305533373], "prototype.html": [273.4285343631809, 280.74452248453906, 287.98560071996394, 287.9999999999999, 290.60913071918264, 4959.603231741461, 5093.465186155456, 5141.768620412081, 5168.586513078954, 5215.42630310666, 5110.233464980255, 5124.871878203037, 5135.743212839362, 5154.4072431670365, 5207.114790485617, 4022.2960981828064, 4054.4121102440126, 4061.208064427423, 4063.1467391847746, 4069.3489041753323, 3920.2551515212162, 4026.4161696553983, 4028.6777057835448, 4034.8789536313957, 4046.696497762665, 4023.5574086850424, 4057.8579749708765, 4077.7349472284354, 4078.3882417637296, 4113.56807535209, 4068.6745060395097, 4072.9592704073175, 4084.7344922580087, 4096.85661001865, 4106.384042393635, 3533.4169861972746, 3543.450765131409, 3566.3937130687846, 3592.6407359264126, 3595.7662751921303, 5010.549050585465, 5015.072211640858, 5036.0, 5059.772310246048, 5128.435872054071, 4548.2495388260895, 4551.112533056055, 4566.063956888863, 4607.14767767964, 4630.606398456135, 5395.757190926418, 5403.405625381205, 5404.973055119514, 5444.945550544523, 5510.614257002011, 3771.641694039062, 3774.452704357853, 3789.8484060637816, 3799.601041890617, 3839.021049632354, 5410.377806552257, 5686.0617998030275, 5691.174779656926, 5749.080147176432, 5791.276090488689, 3554.3957527220437, 3681.006128345332, 3785.3943369060817, 3829.0, 3844.6539811416546, 3913.7064720146104, 3916.1580260244186, 3920.5491368492417, 3929.9607003929596, 3943.3493473577114, 4447.955520444754, 4458.821647134078, 4471.061077173765, 4512.34570987205, 4514.977425112919, 5341.599380046512, 5351.331083614548, 5357.062514060024, 5382.650127741685, 5424.267723857229, 1351.756683796926, 1417.54638515674, 1421.5593166118535, 1424.3946322812762, 1427.471835420901, 935.1536859142487, 936.6628013914985, 939.1688355805026, 951.3007939164846, 952.6284748947916, 5192.688438693691, 5199.896002079937, 5207.713575753294, 5221.895562088737, 5222.8955420892125, 5543.833684989457, 5588.552915766729, 5615.634983726045, 5661.065924122556, 5663.32040155184, 5198.818041368534, 5223.190405487156, 5234.581233501387, 5251.789928402821, 5263.868403289948, 2986.22358186873, 3068.432340017104, 3104.301532155247, 3109.9844500777353, 3115.7818952673097, 5702.401247868997, 5742.913856292159, 5765.4522820332, 5775.768969241268, 5782.045962416154, 5759.596828221985, 5789.073748200268, 5791.391903850119, 5828.358880523139, 5829.038208695518, 5544.61187716856, 5750.482456578844, 5755.740991655469, 5773.364929857712, 5780.566457515703, 5628.493435590816, 5637.46444087811, 5654.6324488908085, 5659.434056594308, 5688.459596338341, 5532.5297349724115, 5539.833804985857, 5542.3626282977975, 5549.5837812163445, 5611.80358687444, 5709.457601527848, 5722.856928576819, 5749.281339832521, 5787.016207244695, 5812.796552120655, 3586.300671369058, 3648.5804132524036, 3682.889513314498, 3891.5135608048995, 3917.6474117329576, 5490.313710786152, 5513.531349835149, 5513.862153446196, 5531.529819965348, 5570.303712035996, 5349.1976203569775, 5349.839504814861, 5358.946410535845, 5366.356037275552, 5415.052365835884, 5319.601029922848, 5343.973280133574, 5349.1976203569775, 5401.189821526646, 5403.000444917703, 5248.1340578804065, 5288.471152884681, 5308.601854860978, 5310.522053015093, 5322.787088516416, 5402.243685883901, 5405.864853378697, 5411.648242864201, 5412.83761487156, 5440.755166017618, 5285.392179899361, 5303.4696530346655, 5309.893802124013, 5355.062863998863, 5413.052715774802], "yui.html": [548.5282656915053, 618.7463140112554, 634.7080343042201, 639.1626968671042, 641.5925887061717, 11730.589429369973, 11732.82400763987, 11753.294802311857, 11793.469293881775, 11816.350100744467, 10977.560897564108, 12070.939645301783, 12346.197497162679, 12387.194832335914, 12426.316552589604, 606.4269265544062, 736.9889451658216, 763.6410886883156, 768.4390395011645, 769.3422124083911, 603.6378173096151, 744.8696478116335, 753.9849203015937, 767.18678201107, 768.3353898877459, 777.4130531448749, 789.5460110436493, 797.5693125712108, 803.8392321535687, 805.118395357083, 618.7092066728653, 634.8666779976211, 765.8544876473508, 786.1705900275207, 790.7430085222297, 559.7033572206736, 572.4390097704231, 572.6621293436892, 573.1460124414592, 575.6172145523223, 11562.30626162433, 11694.941525292405, 11734.354610496419, 11787.528498860036, 11858.0, 8102.675892964275, 8248.257656810856, 8250.793730156734, 8437.662493500253, 8495.617697203641, 7672.0, 7685.846283074363, 7744.7676569703, 7840.960795196044, 8145.389095817837, 2426.0538390027905, 2444.963325550118, 2446.8042556595606, 2490.651308816767, 2492.538880307131, 41921.580784192076, 42108.78945605283, 42668.359974600404, 42870.78564607157, 43332.56667433348, 5678.4605462480995, 5779.711014449261, 5897.911531327033, 5924.318703349084, 5952.0, 9582.275190465643, 9591.0, 9640.42157470554, 9774.12032917041, 9911.207103431709, 5286.9471305287225, 5310.7610157543, 5313.149896016619, 5316.069687804618, 5342.252084708144, 3045.543168524739, 3080.2607374230024, 3136.8274744888795, 3288.8848890288723, 3505.2814173094453, 2304.746477887431, 2315.282262498597, 2322.303309007291, 2327.55776402483, 2357.174988753922, 324.8229714805437, 329.9373119107362, 332.8302565691466, 333.36493978969617, 333.6796675191795, 414.8506537646445, 472.8557789874121, 483.5841176588131, 506.3898002906489, 530.032690340123, 6598.1422415085735, 6752.831179220559, 6964.338387853146, 6997.160340759141, 7023.92976070243, 412.362939005061, 438.1324976546456, 440.37027051316284, 499.64774833742126, 542.967421954684, 3148.1998882413877, 3258.902232933016, 3301.8679252829616, 3325.401427742981, 3435.0725304167736, 54648.72675636596, 55523.0, 55598.72200638971, 55789.721051395296, 55839.44160558424, 46835.5316446838, 47104.0, 47248.291275630894, 47580.0, 48385.032299353814, 42324.78837605792, 42389.36415953763, 42476.0, 44060.779696101956, 44345.334819977725, 6358.809235722936, 6563.3764792344655, 6625.933740662532, 6675.327766428014, 6862.073620061228, 30025.249368765955, 30258.394832103673, 30389.24026899257, 30397.0, 31074.0, 41559.37660935028, 42194.57805421906, 42221.788891055345, 42301.85211084615, 42491.7875410621, 6317.842053948688, 6376.39424254695, 6446.387593178641, 6446.935530644633, 6583.374579414948, 9621.807563848544, 9675.70972870815, 9709.223262139154, 9727.12455878946, 9918.950405248217, 8536.189062039097, 8588.785280368042, 8703.347248956481, 8987.865182022144, 9036.23192028685, 8333.250007499111, 8513.775360261629, 8772.561371931506, 8811.471311721318, 8966.820663586823, 8881.600327985127, 8942.68700595476, 9005.954970225106, 9009.144131307516, 9417.764555886157, 7778.844423111619, 7813.413993950363, 8014.19858014194, 8214.917850821415, 8347.666093356198, 7787.766367008999, 7816.491928024888, 7831.804204894695, 7861.135275119618, 8346.582670866554]}, "summary": {"suite": 5654.63792753937, "subtests": {"jquery.html": {"filtered": 5615.632339077772, "value": 5615.632339077772}, "dojo.html": {"filtered": 4552.955355052689, "value": 4552.955355052689}, "mootools.html": {"filtered": 3791.279733594404, "value": 3791.279733594404}, "ext.html": {"filtered": 16451.984506077635, "value": 16451.984506077635}, "prototype.html": {"filtered": 4119.193428053017, "value": 4119.193428053017}, "yui.html": {"filtered": 4975.937257605259, "value": 4975.937257605259}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1448880350, "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": "20151130004006", "branch": "Mozilla-Aurora", "revision": "7ea5152b84175b42bfe7519e450d24e546e014db"}}, {"talos_counters": {}, "results": {"audio-dft": [195.0, 197.0, 196.0, 199.0, 198.0, 195.0, 198.0, 198.0, 196.0, 196.0], "ai-astar": [126.0, 138.0, 127.0, 140.0, 141.0, 138.0, 120.0, 135.0, 128.0, 122.0], "imaging-gaussian-blur": [149.0, 148.0, 142.0, 142.0, 141.0, 142.0, 142.0, 139.0, 136.0, 148.0], "audio-beat-detection": [185.0, 162.0, 194.0, 196.0, 154.0, 178.0, 155.0, 192.0, 187.0, 159.0], "json-stringify-tinderbox": [74.0, 79.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 79.0], "stanford-crypto-pbkdf2": [170.0, 166.0, 164.0, 185.0, 165.0, 170.0, 174.0, 175.0, 179.0, 172.0], "json-parse-financial": [65.0, 73.0, 73.0, 76.0, 76.0, 77.0, 77.0, 86.0, 70.0, 70.0], "stanford-crypto-sha256-iterative": [78.0, 80.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0], "audio-fft": [91.0, 95.0, 102.0, 147.0, 80.0, 83.0, 84.0, 85.0, 136.0, 81.0], "imaging-darkroom": [154.0, 154.0, 153.0, 153.0, 146.0, 154.0, 153.0, 154.0, 154.0, 160.0], "stanford-crypto-ccm": [142.0, 158.0, 152.0, 157.0, 150.0, 148.0, 156.0, 156.0, 155.0, 152.0], "audio-oscillator": [117.0, 122.0, 161.0, 108.0, 110.0, 108.0, 151.0, 107.0, 107.0, 154.0], "stanford-crypto-aes": [95.0, 100.0, 100.0, 100.0, 102.0, 100.0, 101.0, 101.0, 102.0, 105.0], "imaging-desaturate": [124.0, 125.0, 129.0, 127.0, 124.0, 125.0, 124.0, 123.0, 125.0, 130.0]}, "summary": {"suite": 1812.8999999999996, "subtests": {"audio-fft": {"filtered": 98.4, "value": 98.4}, "stanford-crypto-pbkdf2": {"filtered": 172.0, "value": 172.0}, "audio-beat-detection": {"filtered": 176.2, "value": 176.2}, "stanford-crypto-ccm": {"filtered": 152.6, "value": 152.6}, "imaging-darkroom": {"filtered": 153.5, "value": 153.5}, "json-parse-financial": {"filtered": 74.3, "value": 74.3}, "audio-oscillator": {"filtered": 124.5, "value": 124.5}, "ai-astar": {"filtered": 131.5, "value": 131.5}, "audio-dft": {"filtered": 196.8, "value": 196.8}, "stanford-crypto-sha256-iterative": {"filtered": 83.3, "value": 83.3}, "json-stringify-tinderbox": {"filtered": 80.7, "value": 80.7}, "imaging-gaussian-blur": {"filtered": 142.9, "value": 142.9}, "stanford-crypto-aes": {"filtered": 100.6, "value": 100.6}, "imaging-desaturate": {"filtered": 125.6, "value": 125.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1448880350, "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": "20151130004006", "branch": "Mozilla-Aurora", "revision": "7ea5152b84175b42bfe7519e450d24e546e014db"}}, {"talos_counters": {}, "results": {"DeltaBlue": [238.03856224708403], "Encrypt": [375.6574004507889], "NavierStokes": [6944.444444444444], "Decrypt": [6738.255033557047], "Splay": [723.589001447178], "Richards": [196.54088050314465], "RegExp": [34879.31034482759], "Earley": [834.7245409015025], "Boyer": [15676.923076923076], "RayTrace": [1216.54501216545]}, "summary": {"suite": 16910.67891220936, "subtests": {"DeltaBlue": {"filtered": 277.761718, "value": 277.761718}, "Encrypt": {"filtered": 708.5738219999998, "value": 708.5738219999998}, "NavierStokes": {"filtered": 213.69599999999986, "value": 213.69599999999986}, "Decrypt": {"filtered": 39.502957171314755, "value": 39.502957171314755}, "Splay": {"filtered": 112.62056199999999, "value": 112.62056199999999}, "RegExp": {"filtered": 26.11820563519526, "value": 26.11820563519526}, "Richards": {"filtered": 179.61657599999998, "value": 179.61657599999998}, "Earley": {"filtered": 798.4226739999999, "value": 798.4226739999999}, "Boyer": {"filtered": 42.51236015701669, "value": 42.51236015701669}, "RayTrace": {"filtered": 608.2709580000002, "value": 608.2709580000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1448880350, "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": "20151130004006", "branch": "Mozilla-Aurora", "revision": "7ea5152b84175b42bfe7519e450d24e546e014db"}}] 03:06:10 INFO - RETURN: dromaeo_css: 5654.64 03:06:10 INFO - RETURN: kraken: 1812.90 03:06:10 INFO - RETURN: v8_7: 16910.68 03:06:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "16910.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1812.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5654.64"}}} 03:06:10 INFO - Return code: 0 03:06:10 INFO - # TBPL SUCCESS # 03:06:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:10 INFO - 2015-11-30 03:06:10.413 screenresolution[1691:16367] starting screenresolution argv=screenresolution get 03:06:10 INFO - 2015-11-30 03:06:10.416 screenresolution[1691:16367] Display 0: 1600x1200x32@60 03:06:10 INFO - 2015-11-30 03:06:10.423 screenresolution[1692:16370] starting screenresolution argv=screenresolution list 03:06:10 INFO - Available Modes on Display 0 03:06:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:10 INFO - Intel HD Graphics 3000: 03:06:10 INFO - Chipset Model: Intel HD Graphics 3000 03:06:10 INFO - Type: GPU 03:06:10 INFO - Bus: Built-In 03:06:10 INFO - VRAM (Total): 512 MB 03:06:10 INFO - VRAM (Dynamic, Max): 10 03:06:10 INFO - Vendor: Intel (0x8086) 03:06:10 INFO - Device ID: 0x0116 03:06:10 INFO - Revision ID: 0x0009 03:06:10 INFO - Displays: 03:06:10 INFO - Display: 03:06:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:10 INFO - Display Serial Number: 1600x1200 60 03:06:10 INFO - Main Display: Yes 03:06:10 INFO - Mirror: Off 03:06:10 INFO - Online: Yes 03:06:10 INFO - Rotation: Supported 03:06:10 INFO - Return code: 0 03:06:10 INFO - Running post-action listener: _resource_record_post_action 03:06:10 INFO - Running post-run listener: _resource_record_post_run 03:06:11 INFO - Total resource usage - Wall time: 1263s; CPU: 30.0%; Read bytes: 36889600; Write bytes: 687083520; Read time: 3952; Write time: 60071 03:06:11 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 338471424; Write bytes: 333834240; Read time: 37199; Write time: 7396 03:06:11 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 35058688; Write bytes: 342153216; Read time: 3694; Write time: 51645 03:06:11 INFO - Running post-run listener: _upload_blobber_files 03:06:11 INFO - Blob upload gear active. 03:06:11 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:06:11 INFO - Copying logs to upload dir... 03:06:11 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1346.063265 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2015-11-30 03:06:11.866025) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 03:06:11.869766) ========= 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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/bpdWTWE4ShupNWWMucNfOA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 03:06:11.892980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:06:11.893330) ========= 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.GYOrfCHlJg/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.aPV8EEk4vE/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.005618 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:06:11.944119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 03:06:11.944614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 03:06:11.945231) ========= ========= Total master_lag: 0.45 =========