builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0037 starttime: 1448532817.04 results: success (0) buildid: 20151126004035 builduid: 737d90b70b824a8aab8d712979603a82 revision: 1f88b627ee6a78de1536beaab4b1a7c04a992806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.042019) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.042691) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.043179) ========= 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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.005945 basedir: '/builds/slave/test' ========= master_lag: 0.32 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.364622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.365126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.404973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.405563) ========= 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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.022268 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.457624) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.458123) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.458713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.459178) ========= 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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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-26 02:13:37-- 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% 1.03G=0s 2015-11-26 02:13:37 (1.03 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.235761 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.706367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.706679) ========= 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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.048023 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:37.979509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 02:13:37.979832) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1f88b627ee6a78de1536beaab4b1a7c04a992806 --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 1f88b627ee6a78de1536beaab4b1a7c04a992806 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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-26 02:13:38,195 truncating revision to first 12 chars 2015-11-26 02:13:38,195 Setting DEBUG logging. 2015-11-26 02:13:38,195 attempt 1/10 2015-11-26 02:13:38,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1f88b627ee6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 02:13:39,299 unpacking tar archive at: mozilla-aurora-1f88b627ee6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.364234 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 02:13:39.487878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:39.488154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:39.501955) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:39.502211) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 02:13:39.502570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-26 02:13:39.502838) ========= /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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:13:39 INFO - MultiFileLogger online at 20151126 02:13:39 in /builds/slave/test 02:13:39 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:13:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:39 INFO - {'append_to_log': False, 02:13:39 INFO - 'base_work_dir': '/builds/slave/test', 02:13:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:13:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:39 INFO - 'branch': 'Mozilla-Aurora', 02:13:39 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:39 INFO - 'config_files': ('talos/mac_config.py',), 02:13:39 INFO - 'default_actions': ('clobber', 02:13:39 INFO - 'read-buildbot-config', 02:13:39 INFO - 'download-and-extract', 02:13:39 INFO - 'populate-webroot', 02:13:39 INFO - 'create-virtualenv', 02:13:39 INFO - 'install', 02:13:39 INFO - 'run-tests'), 02:13:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:39 INFO - 'download_minidump_stackwalk': True, 02:13:39 INFO - 'download_symbols': 'ondemand', 02:13:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:39 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:39 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:39 INFO - 'installer_path': 'installer.exe', 02:13:39 INFO - 'log_level': 'info', 02:13:39 INFO - 'log_name': 'talos', 02:13:39 INFO - 'log_to_console': True, 02:13:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:13:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:13:39 INFO - 'opt_config_files': (), 02:13:39 INFO - 'pip_index': False, 02:13:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:39 INFO - 'cmd': ('bash', 02:13:39 INFO - '-c', 02:13:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:39 INFO - 'enabled': True, 02:13:39 INFO - 'halt_on_failure': False, 02:13:39 INFO - 'name': 'check_screen_resolution'},), 02:13:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:39 INFO - 'cmd': ('bash', 02:13:39 INFO - '-c', 02:13:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:39 INFO - 'enabled': True, 02:13:39 INFO - 'halt_on_failure': False, 02:13:39 INFO - 'name': 'check_screen_resolution'},), 02:13:39 INFO - 'run_cmd_checks_enabled': True, 02:13:39 INFO - 'sps_profile': False, 02:13:39 INFO - 'sps_profile_interval': 0, 02:13:39 INFO - 'suite': 'dromaeojs', 02:13:39 INFO - 'system_bits': '64', 02:13:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:39 INFO - 'title': 't-yosemite-r5-0037', 02:13:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:39 INFO - 'use_talos_json': True, 02:13:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:39 INFO - 'work_dir': 'build'} 02:13:39 INFO - ##### 02:13:39 INFO - ##### Running clobber step. 02:13:39 INFO - ##### 02:13:39 INFO - Running pre-action listener: _resource_record_pre_action 02:13:39 INFO - Running main action method: clobber 02:13:39 INFO - rmtree: /builds/slave/test/build 02:13:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:41 INFO - Running post-action listener: _resource_record_post_action 02:13:41 INFO - ##### 02:13:41 INFO - ##### Running read-buildbot-config step. 02:13:41 INFO - ##### 02:13:41 INFO - Running pre-action listener: _resource_record_pre_action 02:13:41 INFO - Running main action method: read_buildbot_config 02:13:41 INFO - Using buildbot properties: 02:13:41 INFO - { 02:13:41 INFO - "properties": { 02:13:41 INFO - "buildnumber": 438, 02:13:41 INFO - "product": "firefox", 02:13:41 INFO - "script_repo_revision": "production", 02:13:41 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:13:41 INFO - "repository": "", 02:13:41 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:13:41 INFO - "buildid": "20151126004035", 02:13:41 INFO - "slavename": "t-yosemite-r5-0037", 02:13:41 INFO - "stage_platform": "macosx64", 02:13:41 INFO - "basedir": "/builds/slave/test", 02:13:41 INFO - "nightly_build": "True", 02:13:41 INFO - "project": "", 02:13:41 INFO - "platform": "yosemite", 02:13:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:13:41 INFO - "slavebuilddir": "test", 02:13:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:13:41 INFO - "branch": "mozilla-aurora", 02:13:41 INFO - "repo_path": "releases/mozilla-aurora", 02:13:41 INFO - "pgo_build": "False", 02:13:41 INFO - "builduid": "737d90b70b824a8aab8d712979603a82", 02:13:41 INFO - "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806" 02:13:41 INFO - }, 02:13:41 INFO - "sourcestamp": { 02:13:41 INFO - "repository": "", 02:13:41 INFO - "hasPatch": false, 02:13:41 INFO - "project": "", 02:13:41 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:13:41 INFO - "changes": [ 02:13:41 INFO - { 02:13:41 INFO - "category": null, 02:13:41 INFO - "files": [ 02:13:41 INFO - { 02:13:41 INFO - "url": null, 02:13:41 INFO - "name": "https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:13:41 INFO - } 02:13:41 INFO - ], 02:13:41 INFO - "repository": "", 02:13:41 INFO - "rev": "1f88b627ee6a78de1536beaab4b1a7c04a992806", 02:13:41 INFO - "who": "sendchange", 02:13:41 INFO - "when": 1448532782, 02:13:41 INFO - "number": 6709711, 02:13:41 INFO - "comments": "", 02:13:41 INFO - "project": "", 02:13:41 INFO - "at": "Thu 26 Nov 2015 02:13:02", 02:13:41 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:13:41 INFO - "revlink": "", 02:13:41 INFO - "properties": [ 02:13:41 INFO - [ 02:13:41 INFO - "buildid", 02:13:41 INFO - "20151126004035", 02:13:41 INFO - "Change" 02:13:41 INFO - ], 02:13:41 INFO - [ 02:13:41 INFO - "builduid", 02:13:41 INFO - "737d90b70b824a8aab8d712979603a82", 02:13:41 INFO - "Change" 02:13:41 INFO - ], 02:13:41 INFO - [ 02:13:41 INFO - "nightly_build", 02:13:41 INFO - "True", 02:13:41 INFO - "Change" 02:13:41 INFO - ], 02:13:41 INFO - [ 02:13:41 INFO - "pgo_build", 02:13:41 INFO - "False", 02:13:41 INFO - "Change" 02:13:41 INFO - ] 02:13:41 INFO - ], 02:13:41 INFO - "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806" 02:13:41 INFO - } 02:13:41 INFO - ], 02:13:41 INFO - "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806" 02:13:41 INFO - } 02:13:41 INFO - } 02:13:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:13:41 INFO - Running post-action listener: _resource_record_post_action 02:13:41 INFO - ##### 02:13:41 INFO - ##### Running download-and-extract step. 02:13:41 INFO - ##### 02:13:41 INFO - Running pre-action listener: _resource_record_pre_action 02:13:41 INFO - Running main action method: download_and_extract 02:13:41 INFO - mkdir: /builds/slave/test/build/tests 02:13:41 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:13:41 INFO - https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/test_packages.json 02:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/test_packages.json 02:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:13:42 INFO - Downloaded 1149 bytes. 02:13:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:13:42 INFO - Using the following test package requirements: 02:13:42 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:13:42 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:13:42 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'jsshell-mac.zip'], 02:13:42 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:13:42 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:13:42 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:13:42 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:13:42 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:13:42 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:13:42 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:13:42 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:13:42 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:13:42 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:13:42 INFO - https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:13:44 INFO - Downloaded 17448062 bytes. 02:13:44 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:13:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:13:49 INFO - Return code: 0 02:13:49 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:13: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:13:49 INFO - https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:13:51 INFO - Downloaded 17448062 bytes. 02:13:51 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:13:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:13:55 INFO - Return code: 0 02:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:55 INFO - https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:13:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:13:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:13:57 INFO - Downloaded 11131307 bytes. 02:13:57 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:13:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:13:57 INFO - Return code: 0 02:13:57 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:13:57 INFO - https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:13:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:13:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:13:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:14:08 INFO - Downloaded 107818367 bytes. 02:14:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:14:08 INFO - mkdir: /builds/slave/test/properties 02:14:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:08 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:08 INFO - Contents: 02:14:08 INFO - build_url:https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:14:08 INFO - Running post-action listener: _resource_record_post_action 02:14:08 INFO - Running post-action listener: set_extra_try_arguments 02:14:08 INFO - ##### 02:14:08 INFO - ##### Running populate-webroot step. 02:14:08 INFO - ##### 02:14:08 INFO - Running pre-action listener: _resource_record_pre_action 02:14:08 INFO - Running main action method: populate_webroot 02:14:08 INFO - Guessing talos json url... 02:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:08 INFO - https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/npr6-sqFRHqj6_42AWkfeg/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:14:08 INFO - Downloaded 107 bytes. 02:14:08 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:14:08 INFO - Contents: 02:14:08 INFO - 20151126004035 02:14:08 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/1f88b627ee6a78de1536beaab4b1a7c04a992806 02:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:08 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1f88b627ee/testing/talos/talos.json 02:14:08 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1f88b627ee/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1f88b627ee/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:14:09 INFO - Downloaded 4264 bytes. 02:14:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:14:09 INFO - '../fennec_ids.txt'], 02:14:09 INFO - 'tests': ['tcheck2']}, 02:14:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:09 INFO - '--tppagecycles', 02:14:09 INFO - '7'], 02:14:09 INFO - 'tests': ['tsvgm']}}, 02:14:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:14:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:14:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:14:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'tests': ['damp', 'tps']}, 02:14:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['damp', 'tps']}, 02:14:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:14:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:09 INFO - 'other': {'tests': ['a11yr', 02:14:09 INFO - 'ts_paint', 02:14:09 INFO - 'tpaint', 02:14:09 INFO - 'sessionrestore', 02:14:09 INFO - 'sessionrestore_no_auto_restore']}, 02:14:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['a11yr', 02:14:09 INFO - 'ts_paint', 02:14:09 INFO - 'tpaint', 02:14:09 INFO - 'sessionrestore', 02:14:09 INFO - 'sessionrestore_no_auto_restore']}, 02:14:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['a11yr', 02:14:09 INFO - 'ts_paint', 02:14:09 INFO - 'tpaint', 02:14:09 INFO - 'sessionrestore', 02:14:09 INFO - 'sessionrestore_no_auto_restore']}, 02:14:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['a11yr', 02:14:09 INFO - 'ts_paint', 02:14:09 INFO - 'tpaint', 02:14:09 INFO - 'sessionrestore', 02:14:09 INFO - 'sessionrestore_no_auto_restore']}, 02:14:09 INFO - 'other_l64': {'tests': ['a11yr', 02:14:09 INFO - 'ts_paint', 02:14:09 INFO - 'tpaint', 02:14:09 INFO - 'sessionrestore', 02:14:09 INFO - 'sessionrestore_no_auto_restore']}, 02:14:09 INFO - 'other_nol64': {'tests': ['a11yr', 02:14:09 INFO - 'ts_paint', 02:14:09 INFO - 'tpaint', 02:14:09 INFO - 'sessionrestore', 02:14:09 INFO - 'sessionrestore_no_auto_restore']}, 02:14:09 INFO - 'svgr': {'tests': ['tsvgx', 02:14:09 INFO - 'tsvgr_opacity', 02:14:09 INFO - 'tart', 02:14:09 INFO - 'tscrollx', 02:14:09 INFO - 'cart']}, 02:14:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['tsvgx', 02:14:09 INFO - 'tsvgr_opacity', 02:14:09 INFO - 'tart', 02:14:09 INFO - 'tscrollx', 02:14:09 INFO - 'cart']}, 02:14:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'tests': ['tp5o']}, 02:14:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'talos_options': ['--e10s'], 02:14:09 INFO - 'tests': ['tp5o']}, 02:14:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'talos_options': ['--xperf_path', 02:14:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:09 INFO - 'tests': ['tp5n']}, 02:14:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:09 INFO - 'talos_options': ['--e10s', 02:14:09 INFO - '--xperf_path', 02:14:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:14:09 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:14:09 INFO - 'tests': ['tp5n']}}, 02:14:09 INFO - 'talos.zip': {'path': '', 02:14:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:09 INFO - Running post-action listener: _resource_record_post_action 02:14:09 INFO - ##### 02:14:09 INFO - ##### Running create-virtualenv step. 02:14:09 INFO - ##### 02:14:09 INFO - Running pre-action listener: _resource_record_pre_action 02:14:09 INFO - Running main action method: create_virtualenv 02:14:09 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:09 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:14:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:09 INFO - Using real prefix '/tools/python27' 02:14:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:10 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:13 INFO - Installing pip.................done. 02:14:13 INFO - Return code: 0 02:14:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:13 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 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:13 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:14:13 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:14:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:13 INFO - 'HOME': '/Users/cltbld', 02:14:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:13 INFO - 'LOGNAME': 'cltbld', 02:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:13 INFO - 'MOZ_NO_REMOTE': '1', 02:14:13 INFO - 'NO_EM_RESTART': '1', 02:14:13 INFO - 'PAGER': '/bin/cat', 02:14:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:13 INFO - 'PWD': '/builds/slave/test', 02:14:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:13 INFO - 'SHELL': '/bin/bash', 02:14:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:13 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:13 INFO - 'USER': 'cltbld', 02:14:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:13 INFO - 'XPC_FLAGS': '0x0', 02:14:13 INFO - 'XPC_SERVICE_NAME': '0', 02:14:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:14 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:14:14 INFO - Cleaning up... 02:14:14 INFO - Return code: 0 02:14:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:14 INFO - 'HOME': '/Users/cltbld', 02:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:14 INFO - 'LOGNAME': 'cltbld', 02:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:14 INFO - 'MOZ_NO_REMOTE': '1', 02:14:14 INFO - 'NO_EM_RESTART': '1', 02:14:14 INFO - 'PAGER': '/bin/cat', 02:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:14 INFO - 'PWD': '/builds/slave/test', 02:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:14 INFO - 'SHELL': '/bin/bash', 02:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:14 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:14 INFO - 'USER': 'cltbld', 02:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:14 INFO - 'XPC_FLAGS': '0x0', 02:14:14 INFO - 'XPC_SERVICE_NAME': '0', 02:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:15 INFO - Downloading/unpacking psutil>=0.7.1 02:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:14:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:17 INFO - Installing collected packages: psutil 02:14:17 INFO - Running setup.py install for psutil 02:14:17 INFO - building 'psutil._psutil_osx' extension 02:14:17 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:14:20 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:14:20 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:14:20 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:14:20 INFO - building 'psutil._psutil_posix' extension 02:14:20 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:14:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:14:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:14:20 INFO - ^ 02:14:20 INFO - 1 warning generated. 02:14:20 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:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:21 INFO - Successfully installed psutil 02:14:21 INFO - Cleaning up... 02:14:21 INFO - Return code: 0 02:14:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:14:21 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:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:21 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:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:21 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 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:21 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:14:21 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:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:21 INFO - 'HOME': '/Users/cltbld', 02:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:21 INFO - 'LOGNAME': 'cltbld', 02:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:21 INFO - 'MOZ_NO_REMOTE': '1', 02:14:21 INFO - 'NO_EM_RESTART': '1', 02:14:21 INFO - 'PAGER': '/bin/cat', 02:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:21 INFO - 'PWD': '/builds/slave/test', 02:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:21 INFO - 'SHELL': '/bin/bash', 02:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:21 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:21 INFO - 'USER': 'cltbld', 02:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:21 INFO - 'XPC_FLAGS': '0x0', 02:14:21 INFO - 'XPC_SERVICE_NAME': '0', 02:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:14:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:23 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:14:23 INFO - Installing collected packages: mozsystemmonitor 02:14:23 INFO - Running setup.py install for mozsystemmonitor 02:14:24 INFO - Successfully installed mozsystemmonitor 02:14:24 INFO - Cleaning up... 02:14:24 INFO - Return code: 0 02:14:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:24 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:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:24 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:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:24 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 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:24 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:14:24 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:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:24 INFO - 'HOME': '/Users/cltbld', 02:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:24 INFO - 'LOGNAME': 'cltbld', 02:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:24 INFO - 'MOZ_NO_REMOTE': '1', 02:14:24 INFO - 'NO_EM_RESTART': '1', 02:14:24 INFO - 'PAGER': '/bin/cat', 02:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:24 INFO - 'PWD': '/builds/slave/test', 02:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:24 INFO - 'SHELL': '/bin/bash', 02:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:24 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:24 INFO - 'USER': 'cltbld', 02:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:24 INFO - 'XPC_FLAGS': '0x0', 02:14:24 INFO - 'XPC_SERVICE_NAME': '0', 02:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:24 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:14:24 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:14:24 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:14:24 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:14:24 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:14:24 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:14:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:26 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:14:26 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:14:26 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:14:26 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:14:26 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:14:26 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:14:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - Downloading docopt-0.6.1.tar.gz 02:14:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:28 INFO - Running setup.py install for blobuploader 02:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:28 INFO - Running setup.py install for requests 02:14:28 INFO - Running setup.py install for docopt 02:14:29 INFO - Successfully installed blobuploader requests docopt 02:14:29 INFO - Cleaning up... 02:14:29 INFO - Return code: 0 02:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:29 INFO - 'HOME': '/Users/cltbld', 02:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:29 INFO - 'LOGNAME': 'cltbld', 02:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:29 INFO - 'MOZ_NO_REMOTE': '1', 02:14:29 INFO - 'NO_EM_RESTART': '1', 02:14:29 INFO - 'PAGER': '/bin/cat', 02:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:29 INFO - 'PWD': '/builds/slave/test', 02:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:29 INFO - 'SHELL': '/bin/bash', 02:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:29 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:29 INFO - 'USER': 'cltbld', 02:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:29 INFO - 'XPC_FLAGS': '0x0', 02:14:29 INFO - 'XPC_SERVICE_NAME': '0', 02:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:29 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-U79Dwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:29 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-gP0YpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:29 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-PJbyuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:29 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-dBMnQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:29 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-rMvW1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-c0vldB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-AxLg9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-rslFie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-4w4yY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-NvtU3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-88sdcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Rm8MxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:30 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-jFWw2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:31 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-jrSmyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:31 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-jUyxda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:31 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-z5UCfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:31 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-YtNi8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:31 INFO - Running setup.py install for manifestparser 02:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for mozcrash 02:14:31 INFO - Running setup.py install for mozdebug 02:14:31 INFO - Running setup.py install for mozdevice 02:14:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Running setup.py install for mozfile 02:14:32 INFO - Running setup.py install for mozhttpd 02:14:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Running setup.py install for mozinfo 02:14:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Running setup.py install for mozInstall 02:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Running setup.py install for mozleak 02:14:32 INFO - Running setup.py install for mozlog 02:14:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Running setup.py install for moznetwork 02:14:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Running setup.py install for mozprocess 02:14:33 INFO - Running setup.py install for mozprofile 02:14:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Running setup.py install for mozrunner 02:14:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Running setup.py install for mozscreenshot 02:14:34 INFO - Running setup.py install for moztest 02:14:34 INFO - Running setup.py install for mozversion 02:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:34 INFO - Cleaning up... 02:14:34 INFO - Return code: 0 02:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:34 INFO - 'HOME': '/Users/cltbld', 02:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:34 INFO - 'LOGNAME': 'cltbld', 02:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:34 INFO - 'MOZ_NO_REMOTE': '1', 02:14:34 INFO - 'NO_EM_RESTART': '1', 02:14:34 INFO - 'PAGER': '/bin/cat', 02:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:34 INFO - 'PWD': '/builds/slave/test', 02:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:34 INFO - 'SHELL': '/bin/bash', 02:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:34 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:34 INFO - 'USER': 'cltbld', 02:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:34 INFO - 'XPC_FLAGS': '0x0', 02:14:34 INFO - 'XPC_SERVICE_NAME': '0', 02:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:34 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-w5V6qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:34 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-8DXkWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-6Jrsap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-rvcBaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-pZ6v9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-6IaPTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-yJMS1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-TButu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-V0QEAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:35 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-sHbUwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-qs57gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Wh_oqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Fj450K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-UT3TSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-iJkaky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-3PcHLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:36 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-65Yhoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:39 INFO - Downloading blessings-1.5.1.tar.gz 02:14:39 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:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:39 INFO - Installing collected packages: blessings 02:14:39 INFO - Running setup.py install for blessings 02:14:39 INFO - Successfully installed blessings 02:14:39 INFO - Cleaning up... 02:14:39 INFO - Return code: 0 02:14:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:40 INFO - Reading from file tmpfile_stdout 02:14:40 INFO - Current package versions: 02:14:40 INFO - blessings == 1.5.1 02:14:40 INFO - blobuploader == 1.2.4 02:14:40 INFO - docopt == 0.6.1 02:14:40 INFO - manifestparser == 1.1 02:14:40 INFO - mozInstall == 1.12 02:14:40 INFO - mozcrash == 0.16 02:14:40 INFO - mozdebug == 0.1 02:14:40 INFO - mozdevice == 0.46 02:14:40 INFO - mozfile == 1.2 02:14:40 INFO - mozhttpd == 0.7 02:14:40 INFO - mozinfo == 0.8 02:14:40 INFO - mozleak == 0.1 02:14:40 INFO - mozlog == 3.0 02:14:40 INFO - moznetwork == 0.27 02:14:40 INFO - mozprocess == 0.22 02:14:40 INFO - mozprofile == 0.27 02:14:40 INFO - mozrunner == 6.11 02:14:40 INFO - mozscreenshot == 0.1 02:14:40 INFO - mozsystemmonitor == 0.0 02:14:40 INFO - moztest == 0.7 02:14:40 INFO - mozversion == 1.4 02:14:40 INFO - psutil == 3.1.1 02:14:40 INFO - requests == 1.2.3 02:14:40 INFO - wsgiref == 0.1.2 02:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:40 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:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:40 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:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:40 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 0x109323a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109390228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1506308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, '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.zY2dBsz8WC/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.5soXi29NNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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:14:40 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:14:40 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:14:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:14:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:40 INFO - 'HOME': '/Users/cltbld', 02:14:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:40 INFO - 'LOGNAME': 'cltbld', 02:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:40 INFO - 'MOZ_NO_REMOTE': '1', 02:14:40 INFO - 'NO_EM_RESTART': '1', 02:14:40 INFO - 'PAGER': '/bin/cat', 02:14:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:40 INFO - 'PWD': '/builds/slave/test', 02:14:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:40 INFO - 'SHELL': '/bin/bash', 02:14:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:14:40 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:14:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:40 INFO - 'USER': 'cltbld', 02:14:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:40 INFO - 'XPC_FLAGS': '0x0', 02:14:40 INFO - 'XPC_SERVICE_NAME': '0', 02:14:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 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:14:40 INFO - Cleaning up... 02:14:40 INFO - Return code: 0 02:14:40 INFO - Running post-action listener: _resource_record_post_action 02:14:40 INFO - Running post-action listener: _start_resource_monitoring 02:14:40 INFO - Starting resource monitoring. 02:14:40 INFO - ##### 02:14:40 INFO - ##### Running install step. 02:14:40 INFO - ##### 02:14:40 INFO - Running pre-action listener: _resource_record_pre_action 02:14:40 INFO - Running main action method: install 02:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:40 INFO - Reading from file tmpfile_stdout 02:14:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:40 INFO - Reading from file tmpfile_stdout 02:14:40 INFO - Output received: 02:14:40 INFO - Usage: mozinstall [options] installer 02:14:40 INFO - Options: 02:14:40 INFO - -h, --help show this help message and exit 02:14:40 INFO - -d DEST, --destination=DEST 02:14:40 INFO - Directory to install application into. [default: 02:14:40 INFO - "/builds/slave/test"] 02:14:40 INFO - --app=APP Application being installed. [default: firefox] 02:14:40 INFO - mkdir: /builds/slave/test/build/application 02:14:40 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:14:40 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:15:19 INFO - Reading from file tmpfile_stdout 02:15:19 INFO - Output received: 02:15:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:15:19 INFO - Running post-action listener: _resource_record_post_action 02:15:19 INFO - ##### 02:15:19 INFO - ##### Running run-tests step. 02:15:19 INFO - ##### 02:15:19 INFO - Running pre-action listener: _resource_record_pre_action 02:15:19 INFO - Running main action method: run_tests 02:15:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:15:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:15:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:15:19 INFO - 2015-11-26 02:15:19.770 screenresolution[1727:13443] starting screenresolution argv=screenresolution get 02:15:19 INFO - 2015-11-26 02:15:19.773 screenresolution[1727:13443] Display 0: 1600x1200x32@60 02:15:19 INFO - 2015-11-26 02:15:19.780 screenresolution[1728:13445] starting screenresolution argv=screenresolution list 02:15:19 INFO - Available Modes on Display 0 02:15:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:15:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:15:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:15:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:15:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:15:20 INFO - Intel HD Graphics 3000: 02:15:20 INFO - Chipset Model: Intel HD Graphics 3000 02:15:20 INFO - Type: GPU 02:15:20 INFO - Bus: Built-In 02:15:20 INFO - VRAM (Total): 512 MB 02:15:20 INFO - VRAM (Dynamic, Max): 10 02:15:20 INFO - Vendor: Intel (0x8086) 02:15:20 INFO - Device ID: 0x0116 02:15:20 INFO - Revision ID: 0x0009 02:15:20 INFO - Displays: 02:15:20 INFO - Display: 02:15:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:15:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:15:20 INFO - Display Serial Number: 1600x1200 60 02:15:20 INFO - Main Display: Yes 02:15:20 INFO - Mirror: Off 02:15:20 INFO - Online: Yes 02:15:20 INFO - Rotation: Supported 02:15:20 INFO - Return code: 0 02:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:20 INFO - Python 2.7.3 02:15:20 INFO - Return code: 0 02:15:20 INFO - grabbing minidump binary from tooltool 02:15:20 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:15:20 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 0x1092d89f0>, '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 0x109037cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092a2990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:20 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:15:20 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:15:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:20 INFO - Return code: 0 02:15:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:15:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:20 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/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0037', '--webServer', 'localhost'] in /builds/slave/test/build 02:15:20 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/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0037 --webServer localhost 02:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zY2dBsz8WC/Render', 02:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:20 INFO - 'HOME': '/Users/cltbld', 02:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:20 INFO - 'LOGNAME': 'cltbld', 02:15:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:20 INFO - 'MOZ_NO_REMOTE': '1', 02:15:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:20 INFO - 'NO_EM_RESTART': '1', 02:15:20 INFO - 'PAGER': '/bin/cat', 02:15:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:20 INFO - 'PWD': '/builds/slave/test', 02:15:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:20 INFO - 'SHELL': '/bin/bash', 02:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5soXi29NNA/Listeners', 02:15:20 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 02:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:20 INFO - 'USER': 'cltbld', 02:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:20 INFO - 'XPC_FLAGS': '0x0', 02:15:20 INFO - 'XPC_SERVICE_NAME': '0', 02:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:15:20 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/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0037', '--webServer', 'localhost'] with output_timeout 3600 02:15:20 INFO - mozversion INFO | application_buildid: 20151126004035 02:15:20 INFO - mozversion INFO | application_changeset: 1f88b627ee6a78de1536beaab4b1a7c04a992806 02:15:20 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:15:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:20 INFO - mozversion INFO | application_name: Firefox 02:15:20 INFO - mozversion INFO | application_remotingname: firefox-dev 02:15:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:20 INFO - mozversion INFO | application_vendor: Mozilla 02:15:20 INFO - mozversion INFO | application_version: 44.0a2 02:15:20 INFO - mozversion INFO | platform_buildid: 20151126004035 02:15:20 INFO - mozversion INFO | platform_changeset: 1f88b627ee6a78de1536beaab4b1a7c04a992806 02:15:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:20 INFO - mozversion INFO | platform_version: 44.0a2 02:15:20 INFO - 2015-11-26 02:15:20,515 DEBUG : using testdate: 1448532920 02:15:20 INFO - 2015-11-26 02:15:20,515 DEBUG : actual date: 1448532920 02:15:20 INFO - 2015-11-26 02:15:20,607 INFO : starting webserver on 'localhost:49276' 02:15:20 INFO - 2015-11-26 02:15:20,608 INFO : Starting test suite t-yosemite-r5-0037 02:15:20 INFO - 2015-11-26 02:15:20,608 INFO : Starting test dromaeo_css 02:15:20 INFO - 2015-11-26 02:15:20,608 DEBUG : operating with platform_type : mac_ 02:15:20 INFO - 2015-11-26 02:15:20,609 INFO : Initialising browser for dromaeo_css test... 02:15:20 INFO - 2015-11-26 02:15:20,635 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpO4NZl1/profile http://localhost:49276/getInfo.html 02:15:23 INFO - 2015-11-26 02:15:23,691 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:15:23 INFO - 2015-11-26 02:15:23,692 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:15:23 INFO - 2015-11-26 02:15:23,692 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:15:23 INFO - 2015-11-26 02:15:23,692 DEBUG : BROWSER_OUTPUT: __metrics 02:15:23 INFO - 2015-11-26 02:15:23,710 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:24 INFO - 2015-11-26 02:15:24,434 INFO : Browser initialized. 02:15:24 INFO - 2015-11-26 02:15:24,435 INFO : Running cycle 1/1 for dromaeo_css test... 02:15:24 INFO - 2015-11-26 02:15:24,435 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpO4NZl1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:15:36 INFO - 2015-11-26 02:15:36,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 201175040 02:15:36 INFO - 2015-11-26 02:15:36,484 DEBUG : BROWSER_OUTPUT: 02:16:28 INFO - 2015-11-26 02:16:28,060 DEBUG : BROWSER_OUTPUT: 1448532988059 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:18:38 INFO - 2015-11-26 02:18:38,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:18:39 INFO - 2015-11-26 02:18:39,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 299958272 02:18:39 INFO - 2015-11-26 02:18:39,748 DEBUG : BROWSER_OUTPUT: 02:21:42 INFO - 2015-11-26 02:21:42,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:21:43 INFO - 2015-11-26 02:21:43,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 344326144 02:21:43 INFO - 2015-11-26 02:21:43,001 DEBUG : BROWSER_OUTPUT: 02:24:45 INFO - 2015-11-26 02:24:45,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:24:45 INFO - 2015-11-26 02:24:45,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 315232256 02:24:45 INFO - 2015-11-26 02:24:45,815 DEBUG : BROWSER_OUTPUT: 02:27:47 INFO - 2015-11-26 02:27:47,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 02:27:48 INFO - 2015-11-26 02:27:48,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 298598400 02:27:48 INFO - 2015-11-26 02:27:48,453 DEBUG : BROWSER_OUTPUT: 02:30:51 INFO - 2015-11-26 02:30:51,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 02:30:52 INFO - 2015-11-26 02:30:52,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 300093440 02:30:52 INFO - 2015-11-26 02:30:52,472 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 02:33:55 INFO - 2015-11-26 02:33:55,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 344092672 02:33:55 INFO - 2015-11-26 02:33:55,588 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:33:55 INFO - 2015-11-26 02:33:55,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:33:55 INFO - 2015-11-26 02:33:55,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:33:55 INFO - 2015-11-26 02:33:55,588 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:33:55 INFO - 2015-11-26 02:33:55,589 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2893.5659651052338;2932.516134837752;2947.1011341540834;2982.985085074575;3029.9849550400613;4971.850844474662;4975.179095449251;4978.576820970217;5021.347224860772;5031.421386540549;4941.728204948727;4992.276119962603;5034.219695947125;5059.165237735779;5160.974195129019;4542.795574199153;4678.06438712258;4726.834560790373;4733.621310295168;4766.380370551823;4659.277811939155;4711.128441238365;4734.763261836912;4776.283557466373;4807.423109226897;4771.045790841828;4797.352357431737;4802.879928001793;4803.687760295587;4809.062232864575;4716.481187069419;4774.737389443597;4781.2350023996;4787.593054590364;4791.736454495001;4465.776711164429;4576.977115114437;4636.0727854428915;4788.473267940559;4801.927971080437;5094.032133894548;5094.235864620299;5104.045926463936;5106.591472682214;5130.358705161855;5187.688738675653;5446.509814116709;5475.835724928259;5484.478974497416;5492.945070549284;5371;5400.1899715043055;5403.405625381205;5474.91787623186;5531.474509921551;5050.116229659795;5135.152699804527;5146.176611742103;5152.9742351288005;5160.071187186268;5399.217113518518;5704.572157088235;5710.391619453148;5732.914006289909;5733.197352370671;5148.150555158357;5208.765605547684;5214.739263036833;5280.762365693553;5303.522682958553;5523.033469142884;5524.116141417354;5534.75093620788;5542.722863856791;5609.607327487119;5129.333186685707;5441.238226648273;5445.183222516575;5468.425815289417;5491.972540137273;5194.1429664105;5238.266642669953;5282.81510147143;5344.225087362311;5347.224652425377;4235.025944032828;4236.724612900151;4237.258479766028;4263.381809637585;4272.145570885773;3684.1342284563107;3865.942010869839;3868.01365651757;3871.903202419962;3874.9418758718643;4990.451050384455;4995.225740010304;5035.018171456604;5056.570191533688;5083.2375143727995;5379.704116273564;5404;5404.108322126884;5419.05166595852;5490.890182196334;4924.8030078797165;5040.647154699136;5046.722430266297;5056.393232812086;5081.339425874613;4632.420947381577;4660.836870709577;4669.743164125938;4736.73947932867;4741.193997020515;5508.20131080991;5580.2745643066955;5590.189422533791;5593.965116453388;5627.8593035174445;5223.660462069954;5541.695206763667;5551.056320425618;5551.528120109836;5577.247071645438;5396.64921780083;5462;5495.862603434946;5512.062949298549;5532.806351777668;5428.321459817523;5436.53789427903;5457.536109430743;5467.699276539828;5472.616916815785;5187.688738675692;5578.442155784389;5581.246531718329;5582.302212223472;5605.663660180402;5253.422123566481;5293.311869456946;5306.628536002443;5306.97346513265;5357.249985002025;5328.60035497347;5366.2487251784005;5374.059539580479;5381.811636592701;5398.541124004503;4876.341693871424;5271.156614941591;5276.841694749163;5281.366236051698;5313.654612450178;5221.112410890082;5241.371035475768;5272.86817829542;5303.734813259244;5355.785768569213;5289.920651190312;5309.7345132743985;5311.867203319948;5325;5329.387120481194 02:33:55 INFO - 2015-11-26 02:33:55,594 DEBUG : BROWSER_OUTPUT: |1;ext.html;517.2241637543684;517.8575891629804;520.7292208051813;524.2555571089054;550.3780727777611;30585.54121688174;31755.206119846986;35221.47167792482;35385.64614353856;35756.463653045226;39248.60751392485;40048.599514004854;40198;40304.59695403045;40348.59651403485;7714.112877019131;8375.623096960637;8494.023187333443;8500.447470914401;8506.44708093975;7900.288973992339;10074.294799364048;10230.283880128394;10234.846477302846;10286.331388459763;10000.799984000316;10027.498625068754;10109.292349535535;10124.544395502184;10140.23948203884;7932.563708996003;8134.959325203396;9924.354916930377;10030.147437467824;10107.595696172144;9761.65834195807;9897.851532227023;9901.405915645084;9989.75025624358;10024.248181386425;37442;37872.43191352132;37980;38053.619463805284;38104.237915241814;2737.2190173065405;3226.080567038406;3299.6040475142895;3314.8839790607453;3338.315645292709;25918.35204119912;26172.8691356542;26551.203463896112;26784.59823102655;27734.861325693244;2109.156337465011;2222.866628002325;2224.8442609017375;2229.9331020069426;2244.5510897820336;266482;268305;268612;271852;271938;55289;56650;56748;57082.429175708545;57089;68204.6589767048;68965;69525.65237173781;69537;69616.6519167411;16312.102834344225;16361;16807.15964201785;16814;16816.663666726596;12701.872981270253;12705.618831435071;12720.618381448572;12816.102872798814;12841.486340546273;18863.151158197914;19045.238190472504;19250.22999080049;19304.71042934357;19347.709784353247;7749.496282741604;7793.454458187985;7928.682852685828;7970.4819186752675;8006.9599652002535;779.2519181585741;822.6791551294999;897.241830653097;974.7222041718077;990.9306348555676;27119.014287274433;27286.45427091447;27307.31731706723;27351.86324068367;27540.862295688392;894.1952242981368;985.5170966226641;1004.8141093897652;1025.9743506412399;1036.0571879589538;11213.66359009231;13441.529546465827;13539.66150846217;13609.863901361057;13688.452461901612;293818;302084;303917;304589;306935;52300.21549676758;52447.73776131171;52693.209601856004;52855;53486.73256633692;1255.6233130060946;1261.6152073617452;1343.7111021130504;1343.7312537492737;1353.059623561635;26088.608670869573;26700.332491687863;26858.462830742887;27373.178804635892;27377.726222738314;45148;45743.77128114338;46000;46003.53996459993;46169.76915115403;193861;410782;423382;424289;427128;28832.693384529608;28860.134195974155;29072.41855162927;29802.956896508516;30165;38831.41752873766;40930.38604420877;40992.59007410007;41296.1740765189;41739;34083.65916340805;35045.29909401849;35355.70496618276;35389.292214156085;35515.46726799152;33578.546512208355;33950;34302;34304.656953430145;34307.65692343045;33764;33825;34503.827480862434;34612.307753845285;34618;26741.331466713487;30140.397192055596;30322.54516182215;30326.241843954078;30493;22981.77018229796;23095.19166829153;23185.884070579537;23498.765012349657;23501.647475287544 02:33:55 INFO - 2015-11-26 02:33:55,594 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.73320544140194;321.19700748129674;324.9255174512488;326.23335162368454;327.3583775799433;9645.758856028602;9985.051420115096;11118.277311974716;16367;16798.58003549912;10115.747106322346;11061.778764424707;11063.114950803916;11361.943190284037;11379.601713940014;4017.3572228443527;4119.155573107506;4121.608447197512;4141.875743727693;4146.564610715876;3308.834558272089;3389.491576263568;4101.0772576170275;4390.846320378788;4539.750313732743;4436.755978421185;4461.7992190351515;4466.2184117779425;4467.218236808546;4486.865394038184;4133.46264985553;4451.421315229016;4470.597646211841;4533.093381323749;4535.342375355555;3822.1591249924973;3826.215625796705;3827.75119617224;3838.963479860422;3845.1732877431486;11939.283642981361;12330.136890417674;12336.383180841012;12573.1198816082;12663.556775512905;1747.6067884725962;1754.16677078388;1766.4044608184754;1833.5874428253537;1924.7978962209047;8890.777730556723;8924.955375223148;8979.506127163004;9184.770380740469;9244;1317.3610798762593;1419.836718777333;1441.7188648213603;1443.487561915526;1502.188818038258;56759;58180.709096454244;58277;58601.706991465195;58609.70695146497;6114.755409783559;6127.785527506516;6130.47890929276;6220.284667263322;6225.968870155711;7116.64416779159;7123.679434425463;7138.643067846587;7139.928600713926;7189.96405017982;5235.05768961583;5281.0758117329315;5330.38700549434;5349.652272602269;5354.143337066129;5638.661680299195;5698.430156984351;5715.599908006399;5718.313802343745;5764.682942438122;2713.8507382094176;2750.573661082535;2753.063958254203;2763.0329384715187;2795.8182718123257;942.4580866002076;956.8756061711933;993.6273897288517;1012.5342342522375;1033.214756784849;365.82988910156905;389.91616802387625;402.9274730548471;404.5832792224014;409.9877003689894;9774.31579789408;10426.530806113744;10593.470326483644;10667.83998240027;11320.490577924013;390.75382509019704;398.4561074133787;403.60245158518836;407.5720493481891;413.54510038957505;5735.827925162252;5860.648361098348;5897.970510147507;5901.852453688693;5915.763369465173;512376;513787;516032;527358;530976;68656;69000;69335.65332173307;69885;70596.29403706;429.83451371222304;434.3831758902366;434.841282931734;436.27795997623986;437.5952244174126;9851.852222216528;9983.201343892326;10187.13409360183;10340.793184136426;10451.425171615634;33406.66593334036;34163.316733665684;34725.652743473256;34829.47755783716;35087.82456087703;45092.77453612711;45647.543524565655;45648.77175614101;45702.314465283715;45805.31292030556;5932.7033648318275;5954.047352423591;5963.940360596339;6014.6391216527145;6024.427679370453;10537;11004;11022.559097636005;11048.723781905517;11092.556297748;9194.356395052282;9279.304052195977;9283.48940808235;9438.858417123885;9478.763030924281;9166.17504424605;9179.265658747418;9264;9277.953610231905;9310.301727370339;7764.867255757497;7846.450748447553;8168.959155204186;8349.58252087381;9079.364444488823;5748.856278593069;5767;5830.475257226701;5830.82507524775;5840.649561026352;9329.86005209936;9438.764030899009;9444.480553569345;9548.18840398574;9576.808463830544 02:33:55 INFO - 2015-11-26 02:33:55,597 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1144;1612.830652781458;1679.319875450443;1711.3582406597523;1717.1929193279161;6489.383508566684;6939.514234003622;7312.670929808158;7467.962660186691;7474.103107627078;7206.999999999987;7304.853902921938;7347.66935487903;7352.154502232245;7380.188179300273;1983.1472466839252;1995.1022040081948;1995.900204989752;2004.1582535335194;2006.5284658105334;2018.8485863560218;2031.959360812783;2036.643587372204;2071.8860462674547;2080.3342930262247;2020.8585399022002;2022.130483891926;2027.3613811649284;2037.0120491561581;2045.6931460281003;2010.567727938493;2018.8183063524207;2021.191523390641;2022.7067075274003;2027.5336672565393;2028.158314299564;2036.643587372204;2089.4671858676093;2097.916083356664;2100.85294029418;6468.288488266334;7292.343689067956;7314.378277846389;7326.523775954546;7351.411887049023;3976.76139431635;4350.282203436429;4470.150671372461;4471.731696098244;4530.0939812037395;2604.427026054265;2652.7877769778565;2686.1270087221537;2698.4198397344467;2700.851453170075;670.6613160354038;772.2702046565997;783.1541934710499;787.1223585701958;791.3589992106412;9642.084002019867;9715;9754.170895473893;9765.804683906354;9794.069563391395;4086.244044851712;4095.7712686194022;4165.312723400605;4165.91668166641;4181.686373521998;8537.18896704812;8561.48631082137;8571.271441927382;8577.656893724306;8589;4575.794089265991;4584.404027476474;4586.610138138229;4587.4036375271;4592.104539614743;4188.916221675549;4200.306949353384;4204.600562946515;4205.726627769246;4211.326187809936;3509.8596056157467;3524.647535246455;3540.0972751948602;3555.982220088935;3578.355895938756;1114.1198453221864;1132.020802006275;1137.5790957345669;1138.2260063157132;1143.2054721968152;978.2223132609593;1007.0734923870057;1163.7497937943383;1188.5305304404712;1190.5118901250446;6920.134983127109;6927.549709268881;7021.262767409451;7028.753993610199;7040.929590704028;1038.3925403638955;1053.4153544782719;1061.0768631290825;1069.187417562658;1073.9624113156;5499.752511137009;5510.91733623996;5514.145307477347;5529.419410961791;5538.529225015919;8666.263367613697;8695.434796738191;8903.287736981027;8911.688090916787;8946.150115738994;7941.682332706742;8101.068377136705;8570.185832345916;8790.736277911545;8854.778630534289;6916.896246556305;6950.096487456598;6971.965140174165;6975.441964642816;6975.9302406975285;6835.555688880207;6887.242403335729;6930;6931.514793964374;6932.341427564374;7774.611269436393;7869.291763741291;7893.684252629831;7931.524108553505;7983.281504664608;7898.973133492609;8078.030636323679;8083.110857805755;8108.3107935823755;8211.71259005932;6198.969005154945;6292.590981586182;6301.558890877594;6306.148669929685;6324.747010119544;7015.929840701528;7041.929580704333;7043.119610048744;7046.207316529781;7129;6535.248446428722;6577.671116444254;6628.502862285444;6650.634215118215;6668;6079.878402432015;6398.840028999312;6480.189976252968;6543.803685889431;6563.015547667888;6161.383861613803;6391.680415979089;6414.807555773335;6420.036994450683;6593.472522198117;5786.971065144816;5794.739236734273;5837.6497410155525;5845.3277873045145;5856.970715146397;5840.94159058404;5924.763009479572;5929.911051334319;5941.524678025661;5957.672328022 02:33:55 INFO - 2015-11-26 02:33:55,599 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.69144090146244;304.2045052188528;311.071451716626;311.11642934067254;311.66963019199665;5612.747426365813;5679.403662615423;5711.828645140652;5723.198752174699;5747.1379293106;5571.609987300891;5606.719664016803;5624.971875140629;5628.971855140719;5670.3479099903425;4233.555476674951;4234.110836724276;4263.296556068252;4272.124214536028;4276.978615106936;4187.1625674865;4257.340112282601;4260.595243451867;4277.2087163874785;4278.572142785728;4185.246655601991;4217.683673724468;4230.323148296273;4232.724872883268;4246.766427846467;4181.874543763692;4205.201011807762;4210.473690788652;4287.978560107211;4349.565043495625;3660.7803531788177;3690.335739566877;3694.9261014779554;3724.478572999782;3726.254749050174;5445.50990410861;5453.918191227135;5459.863503412406;5463.535599474049;5490.286262785852;4775.761211939389;4786.808527658889;4789.137955168068;4799.976000120012;4800.543948324904;5593.440655934414;5814.389489103668;5852.882942341129;5943.910841337383;5961.254843144607;3975.185087057146;3993.4608827808165;3998.5801490843332;4001.5398229203724;4014.2774300625874;6164.106204600353;6246.156768836195;6256.405641464099;6282.905756413657;6291.213598300213;4072.490938632671;4081.3265811141423;4089.5501494835544;4090.8363665453644;4094.9181016379507;3897.6686981606313;3976.3637817949566;3985.242803867256;4007.0783719744622;4144.5233798113;4686;4702.059588082398;4704.858854234379;4712.034033023222;4714.15145273854;5874.73563689635;5886.676232807236;5890.852728681817;5891.558133139946;5915.260592425947;1460.007195107316;1478.3938585180024;1484.665950161205;1486.762118061105;1487.8363380028188;865.1132589096227;875.7941883657336;886.2378354615026;908.9954550227338;947.9952600236954;5699.059655156935;5714.79998200061;5728.283964504437;5729.627574207663;5740.770369185269;6170.413810687977;6177.536684748662;6178.598391104564;6184.5052395808225;6185.505159587222;5685;5704.857378565569;5706.543476521868;5728.77084916607;5743.253377061039;3326.7338612910908;3369.1913940654067;3411.573553305837;3420.3330350581396;3421.4525675891737;6131.570790044743;6179.567430279927;6228.781992630236;6238.001919692918;6239.251289845248;6297.779577714758;6298.842528936813;6301.495880329563;6304.275008374096;6311.242650881832;6068.089786532056;6197.1324014637985;6210.254769427788;6216.7824126155365;6243.750249989949;6130.141780150871;6143.262808463013;6145.13968044483;6149.354317796567;6162.630242185483;5997.280326360865;6008.54935879802;6022.728977196124;6044.395560443921;6058.666773327509;6126.5098792097415;6194.876102477835;6208.472279856082;6232;6241.687915604292;3912.784796836201;3948.6051394861433;3971.6822654187017;3976.940345894756;3993.520777506718;6161.199044124235;6182.010878259457;6185.257769067741;6187.133801267736;6193.349698281616;5978.252718410199;5991.550633702403;5994.67029313392;5999.460048595647;6034.034554471264;5796.797112101056;5918.408159184047;5935.317438494629;5944;5946.613470124601;5796.710164491674;5801.216835727291;5804.941950580609;5818.854528636818;5828.067509198508;5808.477237048517;5876.794312199053;5912.320083190488;5938.762449502145;5967.164596956516;5742.7702891883855;5785.971070144622;5798.159266906359;5808.970955145197;5815.127730840408 02:33:55 INFO - 2015-11-26 02:33:55,602 DEBUG : BROWSER_OUTPUT: |5;yui.html;708.6031822179576;710.7561766907911;728.5774250934459;734.963251837408;744.8808190689489;12620.936895315523;12820.743585128292;12855.22868627883;12875.098743087987;12907.935460322697;12809.487620495169;13028.674283142902;13033.478660853554;13071.607851764462;13076.346182690851;634.3783092569284;658.4863806231148;810.7810891059411;824.5712229640583;826.4917075998247;802.5385403393043;805.3758337288618;818.2226884459757;818.950862948222;829;842.0947481457428;850.7150104714927;851.2253848997414;851.4805968359327;860.5525126933991;665.364576829127;682.8156397772623;828.1842385250524;830.9875351869727;852.7868032991752;620.6059152438189;620.736187120472;620.944115029645;621.816564113583;622.0917460507665;12286.692832679166;12466.937665311707;12485.625431237077;12491.812622810665;12605.810912836314;8416.789580260482;8635.222829945335;8887.022427532966;8904.51025193614;9462.763430914214;8325.916740832636;8420.621072051712;8457.450265732708;8571.528565928871;8574.742757717278;2612.1771641932733;2658.9202323930313;2663.1477927063347;2696.164189101365;2731.112388473754;41478.1704365911;41624.79187604073;41972.58027419748;42309.1538169238;42366.78816605897;6358.491320694426;6383.96808015957;6545.280019197884;6683.398494135551;6776.220734615582;11620.477078531487;11856.822147667792;11861.46623401949;11861.703457413461;11880.346580937958;5527.44725527444;5534.640248383842;5553.944460555343;5710.371859095496;5835.008048631743;3532.3818331791836;3596.1908570571413;3639.3813051781262;3669.3395188865725;3685.447182922583;2429.781319681237;2450.522148181123;2450.9754902451104;2453.987730061374;2455.1407007547214;367.39013238025285;373.86914579897365;376.8454933477261;376.8624452074973;379.78162556529554;505.36071869085634;527.862755683525;535.5153586004672;538.1228597386236;562.471276999619;7224.638768061576;7265.273472652692;7317.597532135677;7429.962850185822;7923.564203968722;407.8225971702319;497.8282492540068;500.8522485866678;543.8286939614009;556.3018411893129;3181.427343078222;3481.408160612702;3502.5972013218297;3691.8523259069875;3765.7740535567955;51545;51963;52234.21648675273;52753;52968.20547691788;40648;42739.29042838252;46059;49927.99999999927;49931.25103123456;43436.56563434325;44059;44510.77744611321;45006.549934500894;45019.54980450219;6807.693653785493;6911.965440172767;7680.846383072419;7861.410394220571;8110.918890811253;31754.682453175174;32366;32432.35135297328;32488.187795305308;32688;42292.577074228866;43962;44857.32714009358;44864.55135448735;45300.32049519326;6948.478864085113;6976.5814051157095;7043.119610048744;7084.468664850054;7263.745768898063;10120.797584048425;10280.383177009404;10424.374537527772;10453.268271221246;10560.630377936735;8959.865602016105;9383.390079644802;9720.125188733047;9837.065478779505;9864.852027219455;9526;9823.263255256028;9896.851547226941;10029.29794914349;10360.481975901326;9150.535914253687;9182.862257066283;9332;9606.327557070937;9627.422354658744;8265;8267.173282671685;8293.83412331762;8469.110743371857;8516.829663406821;8171.7548473545885;8225.259726624632;8232.259096681328;8305;8412.200840920103 02:33:55 INFO - 2015-11-26 02:33:55,602 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:33:55 INFO - 2015-11-26 02:33:55,602 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:33:55 INFO - 2015-11-26 02:33:55,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1034 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: __startTimestamp1448534035586__endTimestamp 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,603 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5062.66 Median:5214.74 stddev:550.42 (10.6%) stddev-sans-first:525.15 02:33:55 INFO - 2015-11-26 02:33:55,604 DEBUG : BROWSER_OUTPUT: Values: 2893.6 2932.5 2947.1 2983.0 3030.0 4971.9 4975.2 4978.6 5021.3 5031.4 4941.7 4992.3 5034.2 5059.2 5161.0 4542.8 4678.1 4726.8 4733.6 4766.4 4659.3 4711.1 4734.8 4776.3 4807.4 4771.0 4797.4 4802.9 4803.7 4809.1 4716.5 4774.7 4781.2 4787.6 4791.7 4465.8 4577.0 4636.1 4788.5 4801.9 5094.0 5094.2 5104.0 5106.6 5130.4 5187.7 5446.5 5475.8 5484.5 5492.9 5371.0 5400.2 5403.4 5474.9 5531.5 5050.1 5135.2 5146.2 5153.0 5160.1 5399.2 5704.6 5710.4 5732.9 5733.2 5148.2 5208.8 5214.7 5280.8 5303.5 5523.0 5524.1 5534.8 5542.7 5609.6 5129.3 5441.2 5445.2 5468.4 5492.0 5194.1 5238.3 5282.8 5344.2 5347.2 4235.0 4236.7 4237.3 4263.4 4272.1 3684.1 3865.9 3868.0 3871.9 3874.9 4990.5 4995.2 5035.0 5056.6 5083.2 5379.7 5404.0 5404.1 5419.1 5490.9 4924.8 5040.6 5046.7 5056.4 5081.3 4632.4 4660.8 4669.7 4736.7 4741.2 5508.2 5580.3 5590.2 5594.0 5627.9 5223.7 5541.7 5551.1 5551.5 5577.2 5396.6 5462.0 5495.9 5512.1 5532.8 5428.3 5436.5 5457.5 5467.7 5472.6 5187.7 5578.4 5581.2 5582.3 5605.7 5253.4 5293.3 5306.6 5307.0 5357.2 5328.6 5366.2 5374.1 5381.8 5398.5 4876.3 5271.2 5276.8 5281.4 5313.7 5221.1 5241.4 5272.9 5303.7 5355.8 5289.9 5309.7 5311.9 5325.0 5329.4 02:33:55 INFO - 2015-11-26 02:33:55,604 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,604 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47686.59 Median:3307.24 stddev:85217.40 (2576.7%) stddev-sans-first:85382.86 02:33:55 INFO - 2015-11-26 02:33:55,605 DEBUG : BROWSER_OUTPUT: Values: 517.2 517.9 520.7 524.3 550.4 30585.5 31755.2 35221.5 35385.6 35756.5 39248.6 40048.6 40198.0 40304.6 40348.6 7714.1 8375.6 8494.0 8500.4 8506.4 7900.3 10074.3 10230.3 10234.8 10286.3 10000.8 10027.5 10109.3 10124.5 10140.2 7932.6 8135.0 9924.4 10030.1 10107.6 9761.7 9897.9 9901.4 9989.8 10024.2 37442.0 37872.4 37980.0 38053.6 38104.2 2737.2 3226.1 3299.6 3314.9 3338.3 25918.4 26172.9 26551.2 26784.6 27734.9 2109.2 2222.9 2224.8 2229.9 2244.6 266482.0 268305.0 268612.0 271852.0 271938.0 55289.0 56650.0 56748.0 57082.4 57089.0 68204.7 68965.0 69525.7 69537.0 69616.7 16312.1 16361.0 16807.2 16814.0 16816.7 12701.9 12705.6 12720.6 12816.1 12841.5 18863.2 19045.2 19250.2 19304.7 19347.7 7749.5 7793.5 7928.7 7970.5 8007.0 779.3 822.7 897.2 974.7 990.9 27119.0 27286.5 27307.3 27351.9 27540.9 894.2 985.5 1004.8 1026.0 1036.1 11213.7 13441.5 13539.7 13609.9 13688.5 293818.0 302084.0 303917.0 304589.0 306935.0 52300.2 52447.7 52693.2 52855.0 53486.7 1255.6 1261.6 1343.7 1343.7 1353.1 26088.6 26700.3 26858.5 27373.2 27377.7 45148.0 45743.8 46000.0 46003.5 46169.8 193861.0 410782.0 423382.0 424289.0 427128.0 28832.7 28860.1 29072.4 29803.0 30165.0 38831.4 40930.4 40992.6 41296.2 41739.0 34083.7 35045.3 35355.7 35389.3 35515.5 33578.5 33950.0 34302.0 34304.7 34307.7 33764.0 33825.0 34503.8 34612.3 34618.0 26741.3 30140.4 30322.5 30326.2 30493.0 22981.8 23095.2 23185.9 23498.8 23501.6 02:33:55 INFO - 2015-11-26 02:33:55,605 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,606 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25336.55 Median:4534.22 stddev:85298.60 (1881.2%) stddev-sans-first:85517.19 02:33:55 INFO - 2015-11-26 02:33:55,607 DEBUG : BROWSER_OUTPUT: Values: 315.7 321.2 324.9 326.2 327.4 9645.8 9985.1 11118.3 16367.0 16798.6 10115.7 11061.8 11063.1 11361.9 11379.6 4017.4 4119.2 4121.6 4141.9 4146.6 3308.8 3389.5 4101.1 4390.8 4539.8 4436.8 4461.8 4466.2 4467.2 4486.9 4133.5 4451.4 4470.6 4533.1 4535.3 3822.2 3826.2 3827.8 3839.0 3845.2 11939.3 12330.1 12336.4 12573.1 12663.6 1747.6 1754.2 1766.4 1833.6 1924.8 8890.8 8925.0 8979.5 9184.8 9244.0 1317.4 1419.8 1441.7 1443.5 1502.2 56759.0 58180.7 58277.0 58601.7 58609.7 6114.8 6127.8 6130.5 6220.3 6226.0 7116.6 7123.7 7138.6 7139.9 7190.0 5235.1 5281.1 5330.4 5349.7 5354.1 5638.7 5698.4 5715.6 5718.3 5764.7 2713.9 2750.6 2753.1 2763.0 2795.8 942.5 956.9 993.6 1012.5 1033.2 365.8 389.9 402.9 404.6 410.0 9774.3 10426.5 10593.5 10667.8 11320.5 390.8 398.5 403.6 407.6 413.5 5735.8 5860.6 5898.0 5901.9 5915.8 512376.0 513787.0 516032.0 527358.0 530976.0 68656.0 69000.0 69335.7 69885.0 70596.3 429.8 434.4 434.8 436.3 437.6 9851.9 9983.2 10187.1 10340.8 10451.4 33406.7 34163.3 34725.7 34829.5 35087.8 45092.8 45647.5 45648.8 45702.3 45805.3 5932.7 5954.0 5963.9 6014.6 6024.4 10537.0 11004.0 11022.6 11048.7 11092.6 9194.4 9279.3 9283.5 9438.9 9478.8 9166.2 9179.3 9264.0 9278.0 9310.3 7764.9 7846.5 8169.0 8349.6 9079.4 5748.9 5767.0 5830.5 5830.8 5840.6 9329.9 9438.8 9444.5 9548.2 9576.8 02:33:55 INFO - 2015-11-26 02:33:55,607 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,607 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5092.14 Median:6180.18 stddev:2636.61 (42.7%) stddev-sans-first:2627.30 02:33:55 INFO - 2015-11-26 02:33:55,607 DEBUG : BROWSER_OUTPUT: Values: 1144.0 1612.8 1679.3 1711.4 1717.2 6489.4 6939.5 7312.7 7468.0 7474.1 7207.0 7304.9 7347.7 7352.2 7380.2 1983.1 1995.1 1995.9 2004.2 2006.5 2018.8 2032.0 2036.6 2071.9 2080.3 2020.9 2022.1 2027.4 2037.0 2045.7 2010.6 2018.8 2021.2 2022.7 2027.5 2028.2 2036.6 2089.5 2097.9 2100.9 6468.3 7292.3 7314.4 7326.5 7351.4 3976.8 4350.3 4470.2 4471.7 4530.1 2604.4 2652.8 2686.1 2698.4 2700.9 670.7 772.3 783.2 787.1 791.4 9642.1 9715.0 9754.2 9765.8 9794.1 4086.2 4095.8 4165.3 4165.9 4181.7 8537.2 8561.5 8571.3 8577.7 8589.0 4575.8 4584.4 4586.6 4587.4 4592.1 4188.9 4200.3 4204.6 4205.7 4211.3 3509.9 3524.6 3540.1 3556.0 3578.4 1114.1 1132.0 1137.6 1138.2 1143.2 978.2 1007.1 1163.7 1188.5 1190.5 6920.1 6927.5 7021.3 7028.8 7040.9 1038.4 1053.4 1061.1 1069.2 1074.0 5499.8 5510.9 5514.1 5529.4 5538.5 8666.3 8695.4 8903.3 8911.7 8946.2 7941.7 8101.1 8570.2 8790.7 8854.8 6916.9 6950.1 6972.0 6975.4 6975.9 6835.6 6887.2 6930.0 6931.5 6932.3 7774.6 7869.3 7893.7 7931.5 7983.3 7899.0 8078.0 8083.1 8108.3 8211.7 6199.0 6292.6 6301.6 6306.1 6324.7 7015.9 7041.9 7043.1 7046.2 7129.0 6535.2 6577.7 6628.5 6650.6 6668.0 6079.9 6398.8 6480.2 6543.8 6563.0 6161.4 6391.7 6414.8 6420.0 6593.5 5787.0 5794.7 5837.6 5845.3 5857.0 5840.9 5924.8 5929.9 5941.5 5957.7 02:33:55 INFO - 2015-11-26 02:33:55,608 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,609 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4925.38 Median:5728.53 stddev:1513.02 (26.4%) stddev-sans-first:1476.84 02:33:55 INFO - 2015-11-26 02:33:55,609 DEBUG : BROWSER_OUTPUT: Values: 296.7 304.2 311.1 311.1 311.7 5612.7 5679.4 5711.8 5723.2 5747.1 5571.6 5606.7 5625.0 5629.0 5670.3 4233.6 4234.1 4263.3 4272.1 4277.0 4187.2 4257.3 4260.6 4277.2 4278.6 4185.2 4217.7 4230.3 4232.7 4246.8 4181.9 4205.2 4210.5 4288.0 4349.6 3660.8 3690.3 3694.9 3724.5 3726.3 5445.5 5453.9 5459.9 5463.5 5490.3 4775.8 4786.8 4789.1 4800.0 4800.5 5593.4 5814.4 5852.9 5943.9 5961.3 3975.2 3993.5 3998.6 4001.5 4014.3 6164.1 6246.2 6256.4 6282.9 6291.2 4072.5 4081.3 4089.6 4090.8 4094.9 3897.7 3976.4 3985.2 4007.1 4144.5 4686.0 4702.1 4704.9 4712.0 4714.2 5874.7 5886.7 5890.9 5891.6 5915.3 1460.0 1478.4 1484.7 1486.8 1487.8 865.1 875.8 886.2 909.0 948.0 5699.1 5714.8 5728.3 5729.6 5740.8 6170.4 6177.5 6178.6 6184.5 6185.5 5685.0 5704.9 5706.5 5728.8 5743.3 3326.7 3369.2 3411.6 3420.3 3421.5 6131.6 6179.6 6228.8 6238.0 6239.3 6297.8 6298.8 6301.5 6304.3 6311.2 6068.1 6197.1 6210.3 6216.8 6243.8 6130.1 6143.3 6145.1 6149.4 6162.6 5997.3 6008.5 6022.7 6044.4 6058.7 6126.5 6194.9 6208.5 6232.0 6241.7 3912.8 3948.6 3971.7 3976.9 3993.5 6161.2 6182.0 6185.3 6187.1 6193.3 5978.3 5991.6 5994.7 5999.5 6034.0 5796.8 5918.4 5935.3 5944.0 5946.6 5796.7 5801.2 5804.9 5818.9 5828.1 5808.5 5876.8 5912.3 5938.8 5967.2 5742.8 5786.0 5798.2 5809.0 5815.1 02:33:55 INFO - 2015-11-26 02:33:55,609 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-26 02:33:55,611 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12132.60 Median:5531.04 stddev:14829.35 (268.1%) stddev-sans-first:14846.13 02:33:55 INFO - 2015-11-26 02:33:55,611 DEBUG : BROWSER_OUTPUT: Values: 708.6 710.8 728.6 735.0 744.9 12620.9 12820.7 12855.2 12875.1 12907.9 12809.5 13028.7 13033.5 13071.6 13076.3 634.4 658.5 810.8 824.6 826.5 802.5 805.4 818.2 819.0 829.0 842.1 850.7 851.2 851.5 860.6 665.4 682.8 828.2 831.0 852.8 620.6 620.7 620.9 621.8 622.1 12286.7 12466.9 12485.6 12491.8 12605.8 8416.8 8635.2 8887.0 8904.5 9462.8 8325.9 8420.6 8457.5 8571.5 8574.7 2612.2 2658.9 2663.1 2696.2 2731.1 41478.2 41624.8 41972.6 42309.2 42366.8 6358.5 6384.0 6545.3 6683.4 6776.2 11620.5 11856.8 11861.5 11861.7 11880.3 5527.4 5534.6 5553.9 5710.4 5835.0 3532.4 3596.2 3639.4 3669.3 3685.4 2429.8 2450.5 2451.0 2454.0 2455.1 367.4 373.9 376.8 376.9 379.8 505.4 527.9 535.5 538.1 562.5 7224.6 7265.3 7317.6 7430.0 7923.6 407.8 497.8 500.9 543.8 556.3 3181.4 3481.4 3502.6 3691.9 3765.8 51545.0 51963.0 52234.2 52753.0 52968.2 40648.0 42739.3 46059.0 49928.0 49931.3 43436.6 44059.0 44510.8 45006.5 45019.5 6807.7 6912.0 7680.8 7861.4 8110.9 31754.7 32366.0 32432.4 32488.2 32688.0 42292.6 43962.0 44857.3 44864.6 45300.3 6948.5 6976.6 7043.1 7084.5 7263.7 10120.8 10280.4 10424.4 10453.3 10560.6 8959.9 9383.4 9720.1 9837.1 9864.9 9526.0 9823.3 9896.9 10029.3 10360.5 9150.5 9182.9 9332.0 9606.3 9627.4 8265.0 8267.2 8293.8 8469.1 8516.8 8171.8 8225.3 8232.3 8305.0 8412.2 02:33:55 INFO - 2015-11-26 02:33:55,612 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:33:55 INFO - 2015-11-26 02:33:55,612 DEBUG : BROWSER_OUTPUT: 02:33:56 INFO - 2015-11-26 02:33:56,279 INFO : Browser exited with error code: 0 02:33:56 INFO - 2015-11-26 02:33:56,310 INFO : Completed test dromaeo_css (00:18:35) 02:33:56 INFO - 2015-11-26 02:33:56,310 INFO : Starting test kraken 02:33:56 INFO - 2015-11-26 02:33:56,310 DEBUG : operating with platform_type : mac_ 02:33:56 INFO - 2015-11-26 02:33:56,310 INFO : Initialising browser for kraken test... 02:33:56 INFO - 2015-11-26 02:33:56,324 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmp581ri3/profile http://localhost:49276/getInfo.html 02:33:58 INFO - 2015-11-26 02:33:58,725 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:33:58 INFO - 2015-11-26 02:33:58,725 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:33:58 INFO - 2015-11-26 02:33:58,726 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:33:58 INFO - 2015-11-26 02:33:58,726 DEBUG : BROWSER_OUTPUT: __metrics 02:33:58 INFO - 2015-11-26 02:33:58,733 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:33:59 INFO - 2015-11-26 02:33:59,469 INFO : Browser initialized. 02:33:59 INFO - 2015-11-26 02:33:59,469 INFO : Running cycle 1/1 for kraken test... 02:33:59 INFO - 2015-11-26 02:33:59,469 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmp581ri3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:34:11 INFO - 2015-11-26 02:34:11,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 202387456 02:34:11 INFO - 2015-11-26 02:34:11,415 DEBUG : BROWSER_OUTPUT: 02:34:14 INFO - 2015-11-26 02:34:14,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:14 INFO - 2015-11-26 02:34:14,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 270893056 02:34:14 INFO - 2015-11-26 02:34:14,695 DEBUG : BROWSER_OUTPUT: 02:34:17 INFO - 2015-11-26 02:34:17,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 02:34:18 INFO - 2015-11-26 02:34:18,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 284065792 02:34:18 INFO - 2015-11-26 02:34:18,163 DEBUG : BROWSER_OUTPUT: 02:34:21 INFO - 2015-11-26 02:34:21,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 02:34:21 INFO - 2015-11-26 02:34:21,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 270213120 02:34:21 INFO - 2015-11-26 02:34:21,799 DEBUG : BROWSER_OUTPUT: 02:34:23 INFO - 2015-11-26 02:34:23,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 02:34:24 INFO - 2015-11-26 02:34:24,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 270831616 02:34:24 INFO - 2015-11-26 02:34:24,543 DEBUG : BROWSER_OUTPUT: 02:34:26 INFO - 2015-11-26 02:34:26,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:27 INFO - 2015-11-26 02:34:27,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 270450688 02:34:27 INFO - 2015-11-26 02:34:27,432 DEBUG : BROWSER_OUTPUT: 02:34:30 INFO - 2015-11-26 02:34:30,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:31 INFO - 2015-11-26 02:34:31,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 271122432 02:34:31 INFO - 2015-11-26 02:34:31,316 DEBUG : BROWSER_OUTPUT: 02:34:34 INFO - 2015-11-26 02:34:34,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:35 INFO - 2015-11-26 02:34:35,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 271486976 02:34:35 INFO - 2015-11-26 02:34:35,286 DEBUG : BROWSER_OUTPUT: 02:34:38 INFO - 2015-11-26 02:34:38,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 02:34:38 INFO - 2015-11-26 02:34:38,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 270483456 02:34:38 INFO - 2015-11-26 02:34:38,988 DEBUG : BROWSER_OUTPUT: 02:34:40 INFO - 2015-11-26 02:34:40,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:41 INFO - 2015-11-26 02:34:41,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 304844800 02:34:41 INFO - 2015-11-26 02:34:41,240 DEBUG : BROWSER_OUTPUT: 02:34:43 INFO - 2015-11-26 02:34:43,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:43 INFO - 2015-11-26 02:34:43,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 307015680 02:34:43 INFO - 2015-11-26 02:34:43,778 DEBUG : BROWSER_OUTPUT: 02:34:45 INFO - 2015-11-26 02:34:45,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:46 INFO - 2015-11-26 02:34:46,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 313196544 02:34:46 INFO - 2015-11-26 02:34:46,580 DEBUG : BROWSER_OUTPUT: 02:34:49 INFO - 2015-11-26 02:34:49,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:49 INFO - 2015-11-26 02:34:49,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 314867712 02:34:49 INFO - 2015-11-26 02:34:49,945 DEBUG : BROWSER_OUTPUT: 02:34:52 INFO - 2015-11-26 02:34:52,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:53 INFO - 2015-11-26 02:34:53,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 313450496 02:34:53 INFO - 2015-11-26 02:34:53,303 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 02:34:55 INFO - 2015-11-26 02:34:55,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 372813824 02:34:55 INFO - 2015-11-26 02:34:55,362 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,362 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;114;104;107;114;112;121;123;110;120 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;144;171;187;147;163;140;197;170;141 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |2;audio-dft;177;181;180;180;179;180;174;180;181;181 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;82;95;132;74;79;80;79;123;76 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;108;148;98;100;102;135;98;99;138 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;130;129;137;129;136;130;130;130;136;135 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;140;140;140;140;140;141;140;140;140;139 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;109;112;118;116;113;113;112;118;113;112 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;67;69;71;71;71;70;79;65;63 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;70;75;73;73;75;73;73;74 02:34:55 INFO - 2015-11-26 02:34:55,363 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;91;93;92;96;99;96;92;95;97 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;142;141;145;142;139;152;146;138;136 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;163;162;163;165;165;167;161;164;151 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;73;77;77;77;78;77;76;78;77 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 02:34:55 INFO - 2015-11-26 02:34:55,364 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:34:55 INFO - 2015-11-26 02:34:55,365 DEBUG : BROWSER_OUTPUT: __startTimestamp1448534095360__endTimestamp 02:34:55 INFO - 2015-11-26 02:34:55,365 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:34:55 INFO - 2015-11-26 02:34:55,365 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:34:55 INFO - 2015-11-26 02:34:55,365 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,367 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:6.11 (5.4%) stddev-sans-first:6.47 02:34:55 INFO - 2015-11-26 02:34:55,367 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 104.0 107.0 114.0 112.0 121.0 123.0 110.0 120.0 02:34:55 INFO - 2015-11-26 02:34:55,367 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,367 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:163.00 Median:170.00 stddev:19.79 (11.6%) stddev-sans-first:20.83 02:34:55 INFO - 2015-11-26 02:34:55,367 DEBUG : BROWSER_OUTPUT: Values: 170.0 144.0 171.0 187.0 147.0 163.0 140.0 197.0 170.0 141.0 02:34:55 INFO - 2015-11-26 02:34:55,368 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,368 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:179.30 Median:180.00 stddev:2.21 (1.2%) stddev-sans-first:2.19 02:34:55 INFO - 2015-11-26 02:34:55,368 DEBUG : BROWSER_OUTPUT: Values: 177.0 181.0 180.0 180.0 179.0 180.0 174.0 180.0 181.0 181.0 02:34:55 INFO - 2015-11-26 02:34:55,368 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.50 Median:79.50 stddev:20.44 (25.7%) stddev-sans-first:21.58 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: Values: 85.0 82.0 95.0 132.0 74.0 79.0 80.0 79.0 123.0 76.0 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:113.10 Median:143.00 stddev:19.32 (13.5%) stddev-sans-first:20.27 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: Values: 105.0 108.0 148.0 98.0 100.0 102.0 135.0 98.0 99.0 138.0 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,369 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:132.20 Median:132.50 stddev:3.33 (2.5%) stddev-sans-first:3.43 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: Values: 130.0 129.0 137.0 129.0 136.0 130.0 130.0 130.0 136.0 135.0 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:140.00 Median:140.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 140.0 140.0 140.0 141.0 140.0 140.0 140.0 139.0 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.60 Median:113.00 stddev:2.88 (2.5%) stddev-sans-first:2.52 02:34:55 INFO - 2015-11-26 02:34:55,370 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 118.0 116.0 113.0 113.0 112.0 118.0 113.0 112.0 02:34:55 INFO - 2015-11-26 02:34:55,371 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,371 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.70 Median:70.50 stddev:5.08 (7.2%) stddev-sans-first:4.56 02:34:55 INFO - 2015-11-26 02:34:55,371 DEBUG : BROWSER_OUTPUT: Values: 61.0 67.0 69.0 71.0 71.0 71.0 70.0 79.0 65.0 63.0 02:34:55 INFO - 2015-11-26 02:34:55,371 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,371 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:73.00 stddev:2.81 (3.8%) stddev-sans-first:2.29 02:34:55 INFO - 2015-11-26 02:34:55,371 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 70.0 75.0 73.0 73.0 75.0 73.0 73.0 74.0 02:34:55 INFO - 2015-11-26 02:34:55,372 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,373 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:95.50 stddev:3.09 (3.2%) stddev-sans-first:2.70 02:34:55 INFO - 2015-11-26 02:34:55,373 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 93.0 92.0 96.0 99.0 96.0 92.0 95.0 97.0 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:142.00 stddev:4.75 (3.3%) stddev-sans-first:4.82 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: Values: 138.0 142.0 141.0 145.0 142.0 139.0 152.0 146.0 138.0 136.0 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:163.50 stddev:4.79 (2.9%) stddev-sans-first:4.61 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: Values: 156.0 163.0 162.0 163.0 165.0 165.0 167.0 161.0 164.0 151.0 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: 02:34:55 INFO - 2015-11-26 02:34:55,374 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:77.00 stddev:2.54 (3.3%) stddev-sans-first:1.50 02:34:55 INFO - 2015-11-26 02:34:55,375 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 77.0 77.0 77.0 78.0 77.0 76.0 78.0 77.0 02:34:55 INFO - 2015-11-26 02:34:55,375 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:34:55 INFO - 2015-11-26 02:34:55,375 DEBUG : BROWSER_OUTPUT: 02:34:56 INFO - 2015-11-26 02:34:56,036 INFO : Browser exited with error code: 0 02:34:56 INFO - 2015-11-26 02:34:56,089 INFO : Completed test kraken (00:00:59) 02:34:56 INFO - 2015-11-26 02:34:56,089 INFO : Starting test v8_7 02:34:56 INFO - 2015-11-26 02:34:56,089 DEBUG : operating with platform_type : mac_ 02:34:56 INFO - 2015-11-26 02:34:56,090 INFO : Initialising browser for v8_7 test... 02:34:56 INFO - 2015-11-26 02:34:56,104 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpyta9un/profile http://localhost:49276/getInfo.html 02:34:58 INFO - 2015-11-26 02:34:58,402 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:34:58 INFO - 2015-11-26 02:34:58,403 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:34:58 INFO - 2015-11-26 02:34:58,403 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:34:58 INFO - 2015-11-26 02:34:58,403 DEBUG : BROWSER_OUTPUT: __metrics 02:34:58 INFO - 2015-11-26 02:34:58,420 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:34:59 INFO - 2015-11-26 02:34:59,115 INFO : Browser initialized. 02:34:59 INFO - 2015-11-26 02:34:59,115 INFO : Running cycle 1/1 for v8_7 test... 02:34:59 INFO - 2015-11-26 02:34:59,116 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpyta9un/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:35:11 INFO - 2015-11-26 02:35:11,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 199004160 02:35:11 INFO - 2015-11-26 02:35:11,067 DEBUG : BROWSER_OUTPUT: 02:35:33 INFO - 2015-11-26 02:35:33,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/v8_7/run.html (next: http://localhost:49276/tests/v8_7/run.html) 02:35:34 INFO - 2015-11-26 02:35:34,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 510341120 02:35:34 INFO - 2015-11-26 02:35:34,118 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,118 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:35:34 INFO - 2015-11-26 02:35:34,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:35:34 INFO - 2015-11-26 02:35:34,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:35:34 INFO - 2015-11-26 02:35:34,119 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:35:34 INFO - 2015-11-26 02:35:34,119 DEBUG : BROWSER_OUTPUT: |0;Richards;174.45917655268667 02:35:34 INFO - 2015-11-26 02:35:34,119 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;210.34917963819942 02:35:34 INFO - 2015-11-26 02:35:34,120 DEBUG : BROWSER_OUTPUT: |2;Encrypt;353.8570417551309 02:35:34 INFO - 2015-11-26 02:35:34,120 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6483.870967741936 02:35:34 INFO - 2015-11-26 02:35:34,120 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1142.857142857143 02:35:34 INFO - 2015-11-26 02:35:34,120 DEBUG : BROWSER_OUTPUT: |5;Earley;754.1478129713424 02:35:34 INFO - 2015-11-26 02:35:34,120 DEBUG : BROWSER_OUTPUT: |6;Boyer;13794.520547945205 02:35:34 INFO - 2015-11-26 02:35:34,120 DEBUG : BROWSER_OUTPUT: |7;RegExp;32661.290322580644 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: |8;Splay;680.4333107650643 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6289.308176100629 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: __startTimestamp1448534134117__endTimestamp 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:35:34 INFO - 2015-11-26 02:35:34,121 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,122 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.46 Median:174.46 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,123 DEBUG : BROWSER_OUTPUT: Values: 174.5 02:35:34 INFO - 2015-11-26 02:35:34,123 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,123 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:210.35 Median:210.35 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,123 DEBUG : BROWSER_OUTPUT: Values: 210.3 02:35:34 INFO - 2015-11-26 02:35:34,124 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,124 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:353.86 Median:353.86 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,124 DEBUG : BROWSER_OUTPUT: Values: 353.9 02:35:34 INFO - 2015-11-26 02:35:34,124 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,124 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6483.87 Median:6483.87 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,124 DEBUG : BROWSER_OUTPUT: Values: 6483.9 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1142.86 Median:1142.86 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: Values: 1142.9 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:754.15 Median:754.15 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: Values: 754.1 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13794.52 Median:13794.52 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: Values: 13794.5 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32661.29 Median:32661.29 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: Values: 32661.3 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,125 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:680.43 Median:680.43 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,126 DEBUG : BROWSER_OUTPUT: Values: 680.4 02:35:34 INFO - 2015-11-26 02:35:34,126 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,126 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6289.31 Median:6289.31 stddev:0.00 (0.0%) 02:35:34 INFO - 2015-11-26 02:35:34,126 DEBUG : BROWSER_OUTPUT: Values: 6289.3 02:35:34 INFO - 2015-11-26 02:35:34,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:35:34 INFO - 2015-11-26 02:35:34,126 DEBUG : BROWSER_OUTPUT: 02:35:34 INFO - 2015-11-26 02:35:34,805 INFO : Browser exited with error code: 0 02:35:34 INFO - 2015-11-26 02:35:34,827 INFO : Completed test v8_7 (00:00:38) 02:35:34 INFO - 2015-11-26 02:35:34,922 INFO : Completed test suite (00:20:14) 02:35:34 INFO - 2015-11-26 02:35:34,922 DEBUG : Working with test: dromaeo_css 02:35:34 INFO - 2015-11-26 02:35:34,922 DEBUG : Generating results file: dromaeo_css 02:35:34 INFO - 2015-11-26 02:35:34,923 DEBUG : Working with test: kraken 02:35:34 INFO - 2015-11-26 02:35:34,923 DEBUG : Generating results file: kraken 02:35:34 INFO - 2015-11-26 02:35:34,923 INFO : javascript benchmark 02:35:34 INFO - 2015-11-26 02:35:34,923 DEBUG : Working with test: v8_7 02:35:34 INFO - 2015-11-26 02:35:34,923 DEBUG : Generating results file: v8_7 02:35:34 INFO - 2015-11-26 02:35:34,923 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:35:34 INFO - 2015-11-26 02:35:34,997 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:35:34 INFO - 2015-11-26 02:35:34,997 DEBUG : process_Request line: dromaeo_css 6156.24 graph.html#tests=[[72,52,55]] 02:35:34 INFO - 2015-11-26 02:35:34,998 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:35:35 INFO - 2015-11-26 02:35:35,117 DEBUG : process_Request line: kraken 1659.90 graph.html#tests=[[232,52,55]] 02:35:35 INFO - 2015-11-26 02:35:35,117 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:35:35 INFO - 2015-11-26 02:35:35,227 DEBUG : process_Request line: v8_7 18421.60 graph.html#tests=[[230,52,55]] 02:35:35 INFO - 2015-11-26 02:35:35,228 INFO : javascript benchmark 02:35:35 INFO - 2015-11-26 02:35:35,231 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [315.73320544140194, 321.19700748129674, 324.9255174512488, 326.23335162368454, 327.3583775799433, 9645.758856028602, 9985.051420115096, 11118.277311974716, 16367.0, 16798.58003549912, 10115.747106322346, 11061.778764424707, 11063.114950803916, 11361.943190284037, 11379.601713940014, 4017.3572228443527, 4119.155573107506, 4121.608447197512, 4141.875743727693, 4146.564610715876, 3308.834558272089, 3389.491576263568, 4101.0772576170275, 4390.846320378788, 4539.750313732743, 4436.755978421185, 4461.7992190351515, 4466.2184117779425, 4467.218236808546, 4486.865394038184, 4133.46264985553, 4451.421315229016, 4470.597646211841, 4533.093381323749, 4535.342375355555, 3822.1591249924973, 3826.215625796705, 3827.75119617224, 3838.963479860422, 3845.1732877431486, 11939.283642981361, 12330.136890417674, 12336.383180841012, 12573.1198816082, 12663.556775512905, 1747.6067884725962, 1754.16677078388, 1766.4044608184754, 1833.5874428253537, 1924.7978962209047, 8890.777730556723, 8924.955375223148, 8979.506127163004, 9184.770380740469, 9244.0, 1317.3610798762593, 1419.836718777333, 1441.7188648213603, 1443.487561915526, 1502.188818038258, 56759.0, 58180.709096454244, 58277.0, 58601.706991465195, 58609.70695146497, 6114.755409783559, 6127.785527506516, 6130.47890929276, 6220.284667263322, 6225.968870155711, 7116.64416779159, 7123.679434425463, 7138.643067846587, 7139.928600713926, 7189.96405017982, 5235.05768961583, 5281.0758117329315, 5330.38700549434, 5349.652272602269, 5354.143337066129, 5638.661680299195, 5698.430156984351, 5715.599908006399, 5718.313802343745, 5764.682942438122, 2713.8507382094176, 2750.573661082535, 2753.063958254203, 2763.0329384715187, 2795.8182718123257, 942.4580866002076, 956.8756061711933, 993.6273897288517, 1012.5342342522375, 1033.214756784849, 365.82988910156905, 389.91616802387625, 402.9274730548471, 404.5832792224014, 409.9877003689894, 9774.31579789408, 10426.530806113744, 10593.470326483644, 10667.83998240027, 11320.490577924013, 390.75382509019704, 398.4561074133787, 403.60245158518836, 407.5720493481891, 413.54510038957505, 5735.827925162252, 5860.648361098348, 5897.970510147507, 5901.852453688693, 5915.763369465173, 512376.0, 513787.0, 516032.0, 527358.0, 530976.0, 68656.0, 69000.0, 69335.65332173307, 69885.0, 70596.29403706, 429.83451371222304, 434.3831758902366, 434.841282931734, 436.27795997623986, 437.5952244174126, 9851.852222216528, 9983.201343892326, 10187.13409360183, 10340.793184136426, 10451.425171615634, 33406.66593334036, 34163.316733665684, 34725.652743473256, 34829.47755783716, 35087.82456087703, 45092.77453612711, 45647.543524565655, 45648.77175614101, 45702.314465283715, 45805.31292030556, 5932.7033648318275, 5954.047352423591, 5963.940360596339, 6014.6391216527145, 6024.427679370453, 10537.0, 11004.0, 11022.559097636005, 11048.723781905517, 11092.556297748, 9194.356395052282, 9279.304052195977, 9283.48940808235, 9438.858417123885, 9478.763030924281, 9166.17504424605, 9179.265658747418, 9264.0, 9277.953610231905, 9310.301727370339, 7764.867255757497, 7846.450748447553, 8168.959155204186, 8349.58252087381, 9079.364444488823, 5748.856278593069, 5767.0, 5830.475257226701, 5830.82507524775, 5840.649561026352, 9329.86005209936, 9438.764030899009, 9444.480553569345, 9548.18840398574, 9576.808463830544], "dojo.html": [2893.5659651052338, 2932.516134837752, 2947.1011341540834, 2982.985085074575, 3029.9849550400613, 4971.850844474662, 4975.179095449251, 4978.576820970217, 5021.347224860772, 5031.421386540549, 4941.728204948727, 4992.276119962603, 5034.219695947125, 5059.165237735779, 5160.974195129019, 4542.795574199153, 4678.06438712258, 4726.834560790373, 4733.621310295168, 4766.380370551823, 4659.277811939155, 4711.128441238365, 4734.763261836912, 4776.283557466373, 4807.423109226897, 4771.045790841828, 4797.352357431737, 4802.879928001793, 4803.687760295587, 4809.062232864575, 4716.481187069419, 4774.737389443597, 4781.2350023996, 4787.593054590364, 4791.736454495001, 4465.776711164429, 4576.977115114437, 4636.0727854428915, 4788.473267940559, 4801.927971080437, 5094.032133894548, 5094.235864620299, 5104.045926463936, 5106.591472682214, 5130.358705161855, 5187.688738675653, 5446.509814116709, 5475.835724928259, 5484.478974497416, 5492.945070549284, 5371.0, 5400.1899715043055, 5403.405625381205, 5474.91787623186, 5531.474509921551, 5050.116229659795, 5135.152699804527, 5146.176611742103, 5152.9742351288005, 5160.071187186268, 5399.217113518518, 5704.572157088235, 5710.391619453148, 5732.914006289909, 5733.197352370671, 5148.150555158357, 5208.765605547684, 5214.739263036833, 5280.762365693553, 5303.522682958553, 5523.033469142884, 5524.116141417354, 5534.75093620788, 5542.722863856791, 5609.607327487119, 5129.333186685707, 5441.238226648273, 5445.183222516575, 5468.425815289417, 5491.972540137273, 5194.1429664105, 5238.266642669953, 5282.81510147143, 5344.225087362311, 5347.224652425377, 4235.025944032828, 4236.724612900151, 4237.258479766028, 4263.381809637585, 4272.145570885773, 3684.1342284563107, 3865.942010869839, 3868.01365651757, 3871.903202419962, 3874.9418758718643, 4990.451050384455, 4995.225740010304, 5035.018171456604, 5056.570191533688, 5083.2375143727995, 5379.704116273564, 5404.0, 5404.108322126884, 5419.05166595852, 5490.890182196334, 4924.8030078797165, 5040.647154699136, 5046.722430266297, 5056.393232812086, 5081.339425874613, 4632.420947381577, 4660.836870709577, 4669.743164125938, 4736.73947932867, 4741.193997020515, 5508.20131080991, 5580.2745643066955, 5590.189422533791, 5593.965116453388, 5627.8593035174445, 5223.660462069954, 5541.695206763667, 5551.056320425618, 5551.528120109836, 5577.247071645438, 5396.64921780083, 5462.0, 5495.862603434946, 5512.062949298549, 5532.806351777668, 5428.321459817523, 5436.53789427903, 5457.536109430743, 5467.699276539828, 5472.616916815785, 5187.688738675692, 5578.442155784389, 5581.246531718329, 5582.302212223472, 5605.663660180402, 5253.422123566481, 5293.311869456946, 5306.628536002443, 5306.97346513265, 5357.249985002025, 5328.60035497347, 5366.2487251784005, 5374.059539580479, 5381.811636592701, 5398.541124004503, 4876.341693871424, 5271.156614941591, 5276.841694749163, 5281.366236051698, 5313.654612450178, 5221.112410890082, 5241.371035475768, 5272.86817829542, 5303.734813259244, 5355.785768569213, 5289.920651190312, 5309.7345132743985, 5311.867203319948, 5325.0, 5329.387120481194], "mootools.html": [1144.0, 1612.830652781458, 1679.319875450443, 1711.3582406597523, 1717.1929193279161, 6489.383508566684, 6939.514234003622, 7312.670929808158, 7467.962660186691, 7474.103107627078, 7206.999999999987, 7304.853902921938, 7347.66935487903, 7352.154502232245, 7380.188179300273, 1983.1472466839252, 1995.1022040081948, 1995.900204989752, 2004.1582535335194, 2006.5284658105334, 2018.8485863560218, 2031.959360812783, 2036.643587372204, 2071.8860462674547, 2080.3342930262247, 2020.8585399022002, 2022.130483891926, 2027.3613811649284, 2037.0120491561581, 2045.6931460281003, 2010.567727938493, 2018.8183063524207, 2021.191523390641, 2022.7067075274003, 2027.5336672565393, 2028.158314299564, 2036.643587372204, 2089.4671858676093, 2097.916083356664, 2100.85294029418, 6468.288488266334, 7292.343689067956, 7314.378277846389, 7326.523775954546, 7351.411887049023, 3976.76139431635, 4350.282203436429, 4470.150671372461, 4471.731696098244, 4530.0939812037395, 2604.427026054265, 2652.7877769778565, 2686.1270087221537, 2698.4198397344467, 2700.851453170075, 670.6613160354038, 772.2702046565997, 783.1541934710499, 787.1223585701958, 791.3589992106412, 9642.084002019867, 9715.0, 9754.170895473893, 9765.804683906354, 9794.069563391395, 4086.244044851712, 4095.7712686194022, 4165.312723400605, 4165.91668166641, 4181.686373521998, 8537.18896704812, 8561.48631082137, 8571.271441927382, 8577.656893724306, 8589.0, 4575.794089265991, 4584.404027476474, 4586.610138138229, 4587.4036375271, 4592.104539614743, 4188.916221675549, 4200.306949353384, 4204.600562946515, 4205.726627769246, 4211.326187809936, 3509.8596056157467, 3524.647535246455, 3540.0972751948602, 3555.982220088935, 3578.355895938756, 1114.1198453221864, 1132.020802006275, 1137.5790957345669, 1138.2260063157132, 1143.2054721968152, 978.2223132609593, 1007.0734923870057, 1163.7497937943383, 1188.5305304404712, 1190.5118901250446, 6920.134983127109, 6927.549709268881, 7021.262767409451, 7028.753993610199, 7040.929590704028, 1038.3925403638955, 1053.4153544782719, 1061.0768631290825, 1069.187417562658, 1073.9624113156, 5499.752511137009, 5510.91733623996, 5514.145307477347, 5529.419410961791, 5538.529225015919, 8666.263367613697, 8695.434796738191, 8903.287736981027, 8911.688090916787, 8946.150115738994, 7941.682332706742, 8101.068377136705, 8570.185832345916, 8790.736277911545, 8854.778630534289, 6916.896246556305, 6950.096487456598, 6971.965140174165, 6975.441964642816, 6975.9302406975285, 6835.555688880207, 6887.242403335729, 6930.0, 6931.514793964374, 6932.341427564374, 7774.611269436393, 7869.291763741291, 7893.684252629831, 7931.524108553505, 7983.281504664608, 7898.973133492609, 8078.030636323679, 8083.110857805755, 8108.3107935823755, 8211.71259005932, 6198.969005154945, 6292.590981586182, 6301.558890877594, 6306.148669929685, 6324.747010119544, 7015.929840701528, 7041.929580704333, 7043.119610048744, 7046.207316529781, 7129.0, 6535.248446428722, 6577.671116444254, 6628.502862285444, 6650.634215118215, 6668.0, 6079.878402432015, 6398.840028999312, 6480.189976252968, 6543.803685889431, 6563.015547667888, 6161.383861613803, 6391.680415979089, 6414.807555773335, 6420.036994450683, 6593.472522198117, 5786.971065144816, 5794.739236734273, 5837.6497410155525, 5845.3277873045145, 5856.970715146397, 5840.94159058404, 5924.763009479572, 5929.911051334319, 5941.524678025661, 5957.672328022], "ext.html": [517.2241637543684, 517.8575891629804, 520.7292208051813, 524.2555571089054, 550.3780727777611, 30585.54121688174, 31755.206119846986, 35221.47167792482, 35385.64614353856, 35756.463653045226, 39248.60751392485, 40048.599514004854, 40198.0, 40304.59695403045, 40348.59651403485, 7714.112877019131, 8375.623096960637, 8494.023187333443, 8500.447470914401, 8506.44708093975, 7900.288973992339, 10074.294799364048, 10230.283880128394, 10234.846477302846, 10286.331388459763, 10000.799984000316, 10027.498625068754, 10109.292349535535, 10124.544395502184, 10140.23948203884, 7932.563708996003, 8134.959325203396, 9924.354916930377, 10030.147437467824, 10107.595696172144, 9761.65834195807, 9897.851532227023, 9901.405915645084, 9989.75025624358, 10024.248181386425, 37442.0, 37872.43191352132, 37980.0, 38053.619463805284, 38104.237915241814, 2737.2190173065405, 3226.080567038406, 3299.6040475142895, 3314.8839790607453, 3338.315645292709, 25918.35204119912, 26172.8691356542, 26551.203463896112, 26784.59823102655, 27734.861325693244, 2109.156337465011, 2222.866628002325, 2224.8442609017375, 2229.9331020069426, 2244.5510897820336, 266482.0, 268305.0, 268612.0, 271852.0, 271938.0, 55289.0, 56650.0, 56748.0, 57082.429175708545, 57089.0, 68204.6589767048, 68965.0, 69525.65237173781, 69537.0, 69616.6519167411, 16312.102834344225, 16361.0, 16807.15964201785, 16814.0, 16816.663666726596, 12701.872981270253, 12705.618831435071, 12720.618381448572, 12816.102872798814, 12841.486340546273, 18863.151158197914, 19045.238190472504, 19250.22999080049, 19304.71042934357, 19347.709784353247, 7749.496282741604, 7793.454458187985, 7928.682852685828, 7970.4819186752675, 8006.9599652002535, 779.2519181585741, 822.6791551294999, 897.241830653097, 974.7222041718077, 990.9306348555676, 27119.014287274433, 27286.45427091447, 27307.31731706723, 27351.86324068367, 27540.862295688392, 894.1952242981368, 985.5170966226641, 1004.8141093897652, 1025.9743506412399, 1036.0571879589538, 11213.66359009231, 13441.529546465827, 13539.66150846217, 13609.863901361057, 13688.452461901612, 293818.0, 302084.0, 303917.0, 304589.0, 306935.0, 52300.21549676758, 52447.73776131171, 52693.209601856004, 52855.0, 53486.73256633692, 1255.6233130060946, 1261.6152073617452, 1343.7111021130504, 1343.7312537492737, 1353.059623561635, 26088.608670869573, 26700.332491687863, 26858.462830742887, 27373.178804635892, 27377.726222738314, 45148.0, 45743.77128114338, 46000.0, 46003.53996459993, 46169.76915115403, 193861.0, 410782.0, 423382.0, 424289.0, 427128.0, 28832.693384529608, 28860.134195974155, 29072.41855162927, 29802.956896508516, 30165.0, 38831.41752873766, 40930.38604420877, 40992.59007410007, 41296.1740765189, 41739.0, 34083.65916340805, 35045.29909401849, 35355.70496618276, 35389.292214156085, 35515.46726799152, 33578.546512208355, 33950.0, 34302.0, 34304.656953430145, 34307.65692343045, 33764.0, 33825.0, 34503.827480862434, 34612.307753845285, 34618.0, 26741.331466713487, 30140.397192055596, 30322.54516182215, 30326.241843954078, 30493.0, 22981.77018229796, 23095.19166829153, 23185.884070579537, 23498.765012349657, 23501.647475287544], "prototype.html": [296.69144090146244, 304.2045052188528, 311.071451716626, 311.11642934067254, 311.66963019199665, 5612.747426365813, 5679.403662615423, 5711.828645140652, 5723.198752174699, 5747.1379293106, 5571.609987300891, 5606.719664016803, 5624.971875140629, 5628.971855140719, 5670.3479099903425, 4233.555476674951, 4234.110836724276, 4263.296556068252, 4272.124214536028, 4276.978615106936, 4187.1625674865, 4257.340112282601, 4260.595243451867, 4277.2087163874785, 4278.572142785728, 4185.246655601991, 4217.683673724468, 4230.323148296273, 4232.724872883268, 4246.766427846467, 4181.874543763692, 4205.201011807762, 4210.473690788652, 4287.978560107211, 4349.565043495625, 3660.7803531788177, 3690.335739566877, 3694.9261014779554, 3724.478572999782, 3726.254749050174, 5445.50990410861, 5453.918191227135, 5459.863503412406, 5463.535599474049, 5490.286262785852, 4775.761211939389, 4786.808527658889, 4789.137955168068, 4799.976000120012, 4800.543948324904, 5593.440655934414, 5814.389489103668, 5852.882942341129, 5943.910841337383, 5961.254843144607, 3975.185087057146, 3993.4608827808165, 3998.5801490843332, 4001.5398229203724, 4014.2774300625874, 6164.106204600353, 6246.156768836195, 6256.405641464099, 6282.905756413657, 6291.213598300213, 4072.490938632671, 4081.3265811141423, 4089.5501494835544, 4090.8363665453644, 4094.9181016379507, 3897.6686981606313, 3976.3637817949566, 3985.242803867256, 4007.0783719744622, 4144.5233798113, 4686.0, 4702.059588082398, 4704.858854234379, 4712.034033023222, 4714.15145273854, 5874.73563689635, 5886.676232807236, 5890.852728681817, 5891.558133139946, 5915.260592425947, 1460.007195107316, 1478.3938585180024, 1484.665950161205, 1486.762118061105, 1487.8363380028188, 865.1132589096227, 875.7941883657336, 886.2378354615026, 908.9954550227338, 947.9952600236954, 5699.059655156935, 5714.79998200061, 5728.283964504437, 5729.627574207663, 5740.770369185269, 6170.413810687977, 6177.536684748662, 6178.598391104564, 6184.5052395808225, 6185.505159587222, 5685.0, 5704.857378565569, 5706.543476521868, 5728.77084916607, 5743.253377061039, 3326.7338612910908, 3369.1913940654067, 3411.573553305837, 3420.3330350581396, 3421.4525675891737, 6131.570790044743, 6179.567430279927, 6228.781992630236, 6238.001919692918, 6239.251289845248, 6297.779577714758, 6298.842528936813, 6301.495880329563, 6304.275008374096, 6311.242650881832, 6068.089786532056, 6197.1324014637985, 6210.254769427788, 6216.7824126155365, 6243.750249989949, 6130.141780150871, 6143.262808463013, 6145.13968044483, 6149.354317796567, 6162.630242185483, 5997.280326360865, 6008.54935879802, 6022.728977196124, 6044.395560443921, 6058.666773327509, 6126.5098792097415, 6194.876102477835, 6208.472279856082, 6232.0, 6241.687915604292, 3912.784796836201, 3948.6051394861433, 3971.6822654187017, 3976.940345894756, 3993.520777506718, 6161.199044124235, 6182.010878259457, 6185.257769067741, 6187.133801267736, 6193.349698281616, 5978.252718410199, 5991.550633702403, 5994.67029313392, 5999.460048595647, 6034.034554471264, 5796.797112101056, 5918.408159184047, 5935.317438494629, 5944.0, 5946.613470124601, 5796.710164491674, 5801.216835727291, 5804.941950580609, 5818.854528636818, 5828.067509198508, 5808.477237048517, 5876.794312199053, 5912.320083190488, 5938.762449502145, 5967.164596956516, 5742.7702891883855, 5785.971070144622, 5798.159266906359, 5808.970955145197, 5815.127730840408], "yui.html": [708.6031822179576, 710.7561766907911, 728.5774250934459, 734.963251837408, 744.8808190689489, 12620.936895315523, 12820.743585128292, 12855.22868627883, 12875.098743087987, 12907.935460322697, 12809.487620495169, 13028.674283142902, 13033.478660853554, 13071.607851764462, 13076.346182690851, 634.3783092569284, 658.4863806231148, 810.7810891059411, 824.5712229640583, 826.4917075998247, 802.5385403393043, 805.3758337288618, 818.2226884459757, 818.950862948222, 829.0, 842.0947481457428, 850.7150104714927, 851.2253848997414, 851.4805968359327, 860.5525126933991, 665.364576829127, 682.8156397772623, 828.1842385250524, 830.9875351869727, 852.7868032991752, 620.6059152438189, 620.736187120472, 620.944115029645, 621.816564113583, 622.0917460507665, 12286.692832679166, 12466.937665311707, 12485.625431237077, 12491.812622810665, 12605.810912836314, 8416.789580260482, 8635.222829945335, 8887.022427532966, 8904.51025193614, 9462.763430914214, 8325.916740832636, 8420.621072051712, 8457.450265732708, 8571.528565928871, 8574.742757717278, 2612.1771641932733, 2658.9202323930313, 2663.1477927063347, 2696.164189101365, 2731.112388473754, 41478.1704365911, 41624.79187604073, 41972.58027419748, 42309.1538169238, 42366.78816605897, 6358.491320694426, 6383.96808015957, 6545.280019197884, 6683.398494135551, 6776.220734615582, 11620.477078531487, 11856.822147667792, 11861.46623401949, 11861.703457413461, 11880.346580937958, 5527.44725527444, 5534.640248383842, 5553.944460555343, 5710.371859095496, 5835.008048631743, 3532.3818331791836, 3596.1908570571413, 3639.3813051781262, 3669.3395188865725, 3685.447182922583, 2429.781319681237, 2450.522148181123, 2450.9754902451104, 2453.987730061374, 2455.1407007547214, 367.39013238025285, 373.86914579897365, 376.8454933477261, 376.8624452074973, 379.78162556529554, 505.36071869085634, 527.862755683525, 535.5153586004672, 538.1228597386236, 562.471276999619, 7224.638768061576, 7265.273472652692, 7317.597532135677, 7429.962850185822, 7923.564203968722, 407.8225971702319, 497.8282492540068, 500.8522485866678, 543.8286939614009, 556.3018411893129, 3181.427343078222, 3481.408160612702, 3502.5972013218297, 3691.8523259069875, 3765.7740535567955, 51545.0, 51963.0, 52234.21648675273, 52753.0, 52968.20547691788, 40648.0, 42739.29042838252, 46059.0, 49927.99999999927, 49931.25103123456, 43436.56563434325, 44059.0, 44510.77744611321, 45006.549934500894, 45019.54980450219, 6807.693653785493, 6911.965440172767, 7680.846383072419, 7861.410394220571, 8110.918890811253, 31754.682453175174, 32366.0, 32432.35135297328, 32488.187795305308, 32688.0, 42292.577074228866, 43962.0, 44857.32714009358, 44864.55135448735, 45300.32049519326, 6948.478864085113, 6976.5814051157095, 7043.119610048744, 7084.468664850054, 7263.745768898063, 10120.797584048425, 10280.383177009404, 10424.374537527772, 10453.268271221246, 10560.630377936735, 8959.865602016105, 9383.390079644802, 9720.125188733047, 9837.065478779505, 9864.852027219455, 9526.0, 9823.263255256028, 9896.851547226941, 10029.29794914349, 10360.481975901326, 9150.535914253687, 9182.862257066283, 9332.0, 9606.327557070937, 9627.422354658744, 8265.0, 8267.173282671685, 8293.83412331762, 8469.110743371857, 8516.829663406821, 8171.7548473545885, 8225.259726624632, 8232.259096681328, 8305.0, 8412.200840920103]}, "summary": {"suite": 6156.236327986098, "subtests": {"jquery.html": {"filtered": 6123.946649844534, "value": 6123.946649844534}, "dojo.html": {"filtered": 5027.331286562571, "value": 5027.331286562571}, "mootools.html": {"filtered": 4167.443266176828, "value": 4167.443266176828}, "ext.html": {"filtered": 17920.562132051527, "value": 17920.562132051527}, "prototype.html": {"filtered": 4424.195080345108, "value": 4424.195080345108}, "yui.html": {"filtered": 5350.882464109001, "value": 5350.882464109001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0037"}, "testrun": {"date": 1448532920, "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": "20151126004035", "branch": "Mozilla-Aurora", "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806"}}, {"talos_counters": {}, "results": {"audio-dft": [177.0, 181.0, 180.0, 180.0, 179.0, 180.0, 174.0, 180.0, 181.0, 181.0], "ai-astar": [113.0, 114.0, 104.0, 107.0, 114.0, 112.0, 121.0, 123.0, 110.0, 120.0], "imaging-gaussian-blur": [130.0, 129.0, 137.0, 129.0, 136.0, 130.0, 130.0, 130.0, 136.0, 135.0], "audio-beat-detection": [170.0, 144.0, 171.0, 187.0, 147.0, 163.0, 140.0, 197.0, 170.0, 141.0], "json-stringify-tinderbox": [67.0, 68.0, 70.0, 75.0, 73.0, 73.0, 75.0, 73.0, 73.0, 74.0], "stanford-crypto-pbkdf2": [156.0, 163.0, 162.0, 163.0, 165.0, 165.0, 167.0, 161.0, 164.0, 151.0], "json-parse-financial": [61.0, 67.0, 69.0, 71.0, 71.0, 71.0, 70.0, 79.0, 65.0, 63.0], "stanford-crypto-sha256-iterative": [70.0, 73.0, 77.0, 77.0, 77.0, 78.0, 77.0, 76.0, 78.0, 77.0], "audio-fft": [85.0, 82.0, 95.0, 132.0, 74.0, 79.0, 80.0, 79.0, 123.0, 76.0], "imaging-darkroom": [140.0, 140.0, 140.0, 140.0, 140.0, 141.0, 140.0, 140.0, 140.0, 139.0], "stanford-crypto-ccm": [138.0, 142.0, 141.0, 145.0, 142.0, 139.0, 152.0, 146.0, 138.0, 136.0], "audio-oscillator": [105.0, 108.0, 148.0, 98.0, 100.0, 102.0, 135.0, 98.0, 99.0, 138.0], "stanford-crypto-aes": [89.0, 91.0, 93.0, 92.0, 96.0, 99.0, 96.0, 92.0, 95.0, 97.0], "imaging-desaturate": [109.0, 112.0, 118.0, 116.0, 113.0, 113.0, 112.0, 118.0, 113.0, 112.0]}, "summary": {"suite": 1659.9, "subtests": {"audio-fft": {"filtered": 90.5, "value": 90.5}, "stanford-crypto-pbkdf2": {"filtered": 161.7, "value": 161.7}, "audio-beat-detection": {"filtered": 163.0, "value": 163.0}, "stanford-crypto-ccm": {"filtered": 141.9, "value": 141.9}, "imaging-darkroom": {"filtered": 140.0, "value": 140.0}, "json-parse-financial": {"filtered": 68.7, "value": 68.7}, "audio-oscillator": {"filtered": 113.1, "value": 113.1}, "ai-astar": {"filtered": 113.8, "value": 113.8}, "audio-dft": {"filtered": 179.3, "value": 179.3}, "stanford-crypto-sha256-iterative": {"filtered": 76.0, "value": 76.0}, "json-stringify-tinderbox": {"filtered": 72.1, "value": 72.1}, "imaging-gaussian-blur": {"filtered": 132.2, "value": 132.2}, "stanford-crypto-aes": {"filtered": 94.0, "value": 94.0}, "imaging-desaturate": {"filtered": 113.6, "value": 113.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0037"}, "testrun": {"date": 1448532920, "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": "20151126004035", "branch": "Mozilla-Aurora", "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806"}}, {"talos_counters": {}, "results": {"DeltaBlue": [210.34917963819942], "Encrypt": [353.8570417551309], "NavierStokes": [6289.308176100629], "Decrypt": [6483.870967741936], "Splay": [680.4333107650643], "Richards": [174.45917655268667], "RegExp": [32661.290322580644], "Earley": [754.1478129713424], "Boyer": [13794.520547945205], "RayTrace": [1142.857142857143]}, "summary": {"suite": 18421.60301841531, "subtests": {"DeltaBlue": {"filtered": 314.3249719999999, "value": 314.3249719999999}, "Encrypt": {"filtered": 752.2275059999998, "value": 752.2275059999998}, "NavierStokes": {"filtered": 235.95599999999985, "value": 235.95599999999985}, "Decrypt": {"filtered": 41.05279104477611, "value": 41.05279104477611}, "Splay": {"filtered": 119.76339004975127, "value": 119.76339004975127}, "RegExp": {"filtered": 27.891886419753106, "value": 27.891886419753106}, "Richards": {"filtered": 202.35106400000004, "value": 202.35106400000004}, "Earley": {"filtered": 883.7299379999995, "value": 883.7299379999995}, "Boyer": {"filtered": 48.31360377358492, "value": 48.31360377358492}, "RayTrace": {"filtered": 647.4903750000001, "value": 647.4903750000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0037"}, "testrun": {"date": 1448532920, "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": "20151126004035", "branch": "Mozilla-Aurora", "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806"}}] 02:35:35 INFO - RETURN: dromaeo_css: 6156.24 02:35:35 INFO - RETURN: kraken: 1659.90 02:35:35 INFO - RETURN: v8_7: 18421.60 02:35:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18421.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1659.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6156.24"}}} 02:35:35 INFO - Return code: 0 02:35:35 INFO - # TBPL SUCCESS # 02:35:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:35:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:35:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:35:35 INFO - 2015-11-26 02:35:35.356 screenresolution[1758:15763] starting screenresolution argv=screenresolution get 02:35:35 INFO - 2015-11-26 02:35:35.359 screenresolution[1758:15763] Display 0: 1600x1200x32@60 02:35:35 INFO - 2015-11-26 02:35:35.365 screenresolution[1759:15766] starting screenresolution argv=screenresolution list 02:35:35 INFO - Available Modes on Display 0 02:35:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:35:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:35:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:35:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:35:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:35:35 INFO - Intel HD Graphics 3000: 02:35:35 INFO - Chipset Model: Intel HD Graphics 3000 02:35:35 INFO - Type: GPU 02:35:35 INFO - Bus: Built-In 02:35:35 INFO - VRAM (Total): 512 MB 02:35:35 INFO - VRAM (Dynamic, Max): 10 02:35:35 INFO - Vendor: Intel (0x8086) 02:35:35 INFO - Device ID: 0x0116 02:35:35 INFO - Revision ID: 0x0009 02:35:35 INFO - Displays: 02:35:35 INFO - Display: 02:35:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:35:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:35:35 INFO - Display Serial Number: 1600x1200 60 02:35:35 INFO - Main Display: Yes 02:35:35 INFO - Mirror: Off 02:35:35 INFO - Online: Yes 02:35:35 INFO - Rotation: Supported 02:35:35 INFO - Return code: 0 02:35:35 INFO - Running post-action listener: _resource_record_post_action 02:35:35 INFO - Running post-run listener: _resource_record_post_run 02:35:36 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 38634496; Write bytes: 688130048; Read time: 4134; Write time: 51774 02:35:36 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 341041664; Write bytes: 336834560; Read time: 34976; Write time: 5169 02:35:36 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 36611072; Write bytes: 340965376; Read time: 3569; Write time: 45738 02:35:36 INFO - Running post-run listener: _upload_blobber_files 02:35:36 INFO - Blob upload gear active. 02:35:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:35:36 INFO - Copying logs to upload dir... 02:35:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.246317 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-26 02:35:36.793616) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 02:35:36.797038) ========= 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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010173 build_url: 'https://queue.taskcluster.net/v1/task/npr6-sqFRHqj6_42AWkfeg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.20 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 02:35:37.008893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:35:37.009531) ========= 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.zY2dBsz8WC/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.5soXi29NNA/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.005437 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 02:35:37.032718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 02:35:37.033254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 02:35:37.034363) ========= ========= Total master_lag: 0.99 =========