builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0006 starttime: 1446517055.03 results: success (0) buildid: 20151102152508 builduid: dc9bd91f3f9a4b11b49d7e9b177d1c42 revision: cb41b90cd72f67ea8abda60551d1af6f79888c42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.030047) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.030641) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.030967) ========= 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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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.006325 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.083796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.084359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.118196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.118773) ========= 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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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.029006 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.170674) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.171365) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.172107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.172759) ========= 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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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-02 18:17:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|: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.13G=0s 2015-11-02 18:17:35 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.222633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.413017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.413375) ========= 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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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.194161 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.625678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:35.626531) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cb41b90cd72f67ea8abda60551d1af6f79888c42 --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 cb41b90cd72f67ea8abda60551d1af6f79888c42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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-02 18:17:35,713 truncating revision to first 12 chars 2015-11-02 18:17:35,713 Setting DEBUG logging. 2015-11-02 18:17:35,713 attempt 1/10 2015-11-02 18:17:35,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cb41b90cd72f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-02 18:17:36,002 unpacking tar archive at: mozilla-aurora-cb41b90cd72f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581018 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:36.225961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:36.226338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:36.239543) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:36.239841) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 18:17:36.241829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-02 18:17:36.242774) ========= /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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:17:36 INFO - MultiFileLogger online at 20151102 18:17:36 in /builds/slave/test 18:17:36 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 18:17:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:17:36 INFO - {'append_to_log': False, 18:17:36 INFO - 'base_work_dir': '/builds/slave/test', 18:17:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:17:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:17:36 INFO - 'branch': 'Mozilla-Aurora', 18:17:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:17:36 INFO - 'config_files': ('talos/mac_config.py',), 18:17:36 INFO - 'default_actions': ('clobber', 18:17:36 INFO - 'read-buildbot-config', 18:17:36 INFO - 'download-and-extract', 18:17:36 INFO - 'populate-webroot', 18:17:36 INFO - 'create-virtualenv', 18:17:36 INFO - 'install', 18:17:36 INFO - 'run-tests'), 18:17:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:17:36 INFO - 'download_minidump_stackwalk': True, 18:17:36 INFO - 'download_symbols': 'ondemand', 18:17:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:17:36 INFO - 'tooltool.py': '/tools/tooltool.py', 18:17:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:17:36 INFO - '/tools/misc-python/virtualenv.py')}, 18:17:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:17:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:17:36 INFO - 'installer_path': 'installer.exe', 18:17:36 INFO - 'log_level': 'info', 18:17:36 INFO - 'log_name': 'talos', 18:17:36 INFO - 'log_to_console': True, 18:17:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:17:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:17:36 INFO - 'opt_config_files': (), 18:17:36 INFO - 'pip_index': False, 18:17:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:17:36 INFO - 'cmd': ('bash', 18:17:36 INFO - '-c', 18:17:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:17:36 INFO - 'enabled': True, 18:17:36 INFO - 'halt_on_failure': False, 18:17:36 INFO - 'name': 'check_screen_resolution'},), 18:17:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:17:36 INFO - 'cmd': ('bash', 18:17:36 INFO - '-c', 18:17:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:17:36 INFO - 'enabled': True, 18:17:36 INFO - 'halt_on_failure': False, 18:17:36 INFO - 'name': 'check_screen_resolution'},), 18:17:36 INFO - 'run_cmd_checks_enabled': True, 18:17:36 INFO - 'sps_profile': False, 18:17:36 INFO - 'sps_profile_interval': 0, 18:17:36 INFO - 'suite': 'dromaeojs', 18:17:36 INFO - 'system_bits': '64', 18:17:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:17:36 INFO - 'title': 't-yosemite-r5-0006', 18:17:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:17:36 INFO - 'use_talos_json': True, 18:17:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:17:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:17:36 INFO - 'work_dir': 'build'} 18:17:36 INFO - ##### 18:17:36 INFO - ##### Running clobber step. 18:17:36 INFO - ##### 18:17:36 INFO - Running pre-action listener: _resource_record_pre_action 18:17:36 INFO - Running main action method: clobber 18:17:36 INFO - rmtree: /builds/slave/test/build 18:17:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:17:43 INFO - Running post-action listener: _resource_record_post_action 18:17:43 INFO - ##### 18:17:43 INFO - ##### Running read-buildbot-config step. 18:17:43 INFO - ##### 18:17:43 INFO - Running pre-action listener: _resource_record_pre_action 18:17:43 INFO - Running main action method: read_buildbot_config 18:17:43 INFO - Using buildbot properties: 18:17:43 INFO - { 18:17:43 INFO - "properties": { 18:17:43 INFO - "buildnumber": 254, 18:17:43 INFO - "product": "firefox", 18:17:43 INFO - "script_repo_revision": "production", 18:17:43 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 18:17:43 INFO - "repository": "", 18:17:43 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 18:17:43 INFO - "buildid": "20151102152508", 18:17:43 INFO - "slavename": "t-yosemite-r5-0006", 18:17:43 INFO - "pgo_build": "False", 18:17:43 INFO - "basedir": "/builds/slave/test", 18:17:43 INFO - "project": "", 18:17:43 INFO - "platform": "yosemite", 18:17:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:17:43 INFO - "slavebuilddir": "test", 18:17:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:17:43 INFO - "branch": "mozilla-aurora", 18:17:43 INFO - "repo_path": "releases/mozilla-aurora", 18:17:43 INFO - "stage_platform": "macosx64", 18:17:43 INFO - "builduid": "dc9bd91f3f9a4b11b49d7e9b177d1c42", 18:17:43 INFO - "revision": "cb41b90cd72f67ea8abda60551d1af6f79888c42" 18:17:43 INFO - }, 18:17:43 INFO - "sourcestamp": { 18:17:43 INFO - "repository": "", 18:17:43 INFO - "hasPatch": false, 18:17:43 INFO - "project": "", 18:17:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 18:17:43 INFO - "changes": [ 18:17:43 INFO - { 18:17:43 INFO - "category": null, 18:17:43 INFO - "files": [ 18:17:43 INFO - { 18:17:43 INFO - "url": null, 18:17:43 INFO - "name": "https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 18:17:43 INFO - } 18:17:43 INFO - ], 18:17:43 INFO - "repository": "", 18:17:43 INFO - "rev": "cb41b90cd72f67ea8abda60551d1af6f79888c42", 18:17:43 INFO - "who": "mozilla@noorenberghe.ca", 18:17:43 INFO - "when": 1446512681, 18:17:43 INFO - "number": 6612180, 18:17:43 INFO - "comments": "Bug 1220884 - Friendlier string for the notification upgrade UI. r=kitcambridge a=sylvestre l10n=before-freeze", 18:17:43 INFO - "project": "", 18:17:43 INFO - "at": "Mon 02 Nov 2015 17:04:41", 18:17:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 18:17:43 INFO - "revlink": "", 18:17:43 INFO - "properties": [ 18:17:43 INFO - [ 18:17:43 INFO - "buildid", 18:17:43 INFO - "20151102152508", 18:17:43 INFO - "Change" 18:17:43 INFO - ], 18:17:43 INFO - [ 18:17:43 INFO - "builduid", 18:17:43 INFO - "dc9bd91f3f9a4b11b49d7e9b177d1c42", 18:17:43 INFO - "Change" 18:17:43 INFO - ], 18:17:43 INFO - [ 18:17:43 INFO - "pgo_build", 18:17:43 INFO - "False", 18:17:43 INFO - "Change" 18:17:43 INFO - ] 18:17:43 INFO - ], 18:17:43 INFO - "revision": "cb41b90cd72f67ea8abda60551d1af6f79888c42" 18:17:43 INFO - } 18:17:43 INFO - ], 18:17:43 INFO - "revision": "cb41b90cd72f67ea8abda60551d1af6f79888c42" 18:17:43 INFO - } 18:17:43 INFO - } 18:17:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 18:17:43 INFO - Running post-action listener: _resource_record_post_action 18:17:43 INFO - ##### 18:17:43 INFO - ##### Running download-and-extract step. 18:17:43 INFO - ##### 18:17:43 INFO - Running pre-action listener: _resource_record_pre_action 18:17:43 INFO - Running main action method: download_and_extract 18:17:43 INFO - mkdir: /builds/slave/test/build/tests 18:17:43 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')]} 18:17:43 INFO - https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/test_packages.json 18:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/test_packages.json 18:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:17:44 INFO - Downloaded 1149 bytes. 18:17:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:17:44 INFO - Using the following test package requirements: 18:17:44 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 18:17:44 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 18:17:44 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'jsshell-mac.zip'], 18:17:44 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 18:17:44 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 18:17:44 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 18:17:44 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 18:17:44 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 18:17:44 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 18:17:44 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:17:44 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 18:17:44 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:44 INFO - https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:17:45 INFO - Downloaded 17445372 bytes. 18:17:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:17:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:17:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 18:17:52 INFO - Return code: 0 18:17:52 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 18:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:52 INFO - https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:17:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:17:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:17:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:17:53 INFO - Downloaded 17445372 bytes. 18:17:53 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 18:17:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:17:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 18:17:59 INFO - Return code: 0 18:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:59 INFO - https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:18:00 INFO - Downloaded 11131307 bytes. 18:18:00 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 18:18:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:18:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:18:00 INFO - Return code: 0 18:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:00 INFO - https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 18:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 18:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:18:05 INFO - Downloaded 107719843 bytes. 18:18:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:18:05 INFO - mkdir: /builds/slave/test/properties 18:18:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:05 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:05 INFO - Contents: 18:18:05 INFO - build_url:https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:18:05 INFO - Running post-action listener: _resource_record_post_action 18:18:05 INFO - Running post-action listener: set_extra_try_arguments 18:18:05 INFO - ##### 18:18:05 INFO - ##### Running populate-webroot step. 18:18:05 INFO - ##### 18:18:05 INFO - Running pre-action listener: _resource_record_pre_action 18:18:05 INFO - Running main action method: populate_webroot 18:18:05 INFO - Guessing talos json url... 18:18:05 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')]} 18:18:05 INFO - https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 18:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 18:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 18:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 18:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OqfqRtxQQQCintmoG-5jzg/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 18:18:05 INFO - Downloaded 107 bytes. 18:18:05 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 18:18:05 INFO - Contents: 18:18:05 INFO - 20151102152508 18:18:05 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/cb41b90cd72f67ea8abda60551d1af6f79888c42 18:18:05 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')]} 18:18:05 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/cb41b90cd7/testing/talos/talos.json 18:18:05 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/cb41b90cd7/testing/talos/talos.json to /builds/slave/test/build/talos.json 18:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/cb41b90cd7/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 18:18:06 INFO - Downloaded 4264 bytes. 18:18:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:18:06 INFO - '../fennec_ids.txt'], 18:18:06 INFO - 'tests': ['tcheck2']}, 18:18:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:06 INFO - '--tppagecycles', 18:18:06 INFO - '7'], 18:18:06 INFO - 'tests': ['tsvgm']}}, 18:18:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:18:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:18:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:18:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'tests': ['damp', 'tps']}, 18:18:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['damp', 'tps']}, 18:18:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:18:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:06 INFO - 'other': {'tests': ['a11yr', 18:18:06 INFO - 'ts_paint', 18:18:06 INFO - 'tpaint', 18:18:06 INFO - 'sessionrestore', 18:18:06 INFO - 'sessionrestore_no_auto_restore']}, 18:18:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['a11yr', 18:18:06 INFO - 'ts_paint', 18:18:06 INFO - 'tpaint', 18:18:06 INFO - 'sessionrestore', 18:18:06 INFO - 'sessionrestore_no_auto_restore']}, 18:18:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['a11yr', 18:18:06 INFO - 'ts_paint', 18:18:06 INFO - 'tpaint', 18:18:06 INFO - 'sessionrestore', 18:18:06 INFO - 'sessionrestore_no_auto_restore']}, 18:18:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['a11yr', 18:18:06 INFO - 'ts_paint', 18:18:06 INFO - 'tpaint', 18:18:06 INFO - 'sessionrestore', 18:18:06 INFO - 'sessionrestore_no_auto_restore']}, 18:18:06 INFO - 'other_l64': {'tests': ['a11yr', 18:18:06 INFO - 'ts_paint', 18:18:06 INFO - 'tpaint', 18:18:06 INFO - 'sessionrestore', 18:18:06 INFO - 'sessionrestore_no_auto_restore']}, 18:18:06 INFO - 'other_nol64': {'tests': ['a11yr', 18:18:06 INFO - 'ts_paint', 18:18:06 INFO - 'tpaint', 18:18:06 INFO - 'sessionrestore', 18:18:06 INFO - 'sessionrestore_no_auto_restore']}, 18:18:06 INFO - 'svgr': {'tests': ['tsvgx', 18:18:06 INFO - 'tsvgr_opacity', 18:18:06 INFO - 'tart', 18:18:06 INFO - 'tscrollx', 18:18:06 INFO - 'cart']}, 18:18:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['tsvgx', 18:18:06 INFO - 'tsvgr_opacity', 18:18:06 INFO - 'tart', 18:18:06 INFO - 'tscrollx', 18:18:06 INFO - 'cart']}, 18:18:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'tests': ['tp5o']}, 18:18:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'talos_options': ['--e10s'], 18:18:06 INFO - 'tests': ['tp5o']}, 18:18:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'talos_options': ['--xperf_path', 18:18:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:06 INFO - 'tests': ['tp5n']}, 18:18:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:06 INFO - 'talos_options': ['--e10s', 18:18:06 INFO - '--xperf_path', 18:18:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 18:18:06 INFO - 'C:/slave/talos-data/talos/xperf.config'], 18:18:06 INFO - 'tests': ['tp5n']}}, 18:18:06 INFO - 'talos.zip': {'path': '', 18:18:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:06 INFO - Running post-action listener: _resource_record_post_action 18:18:06 INFO - ##### 18:18:06 INFO - ##### Running create-virtualenv step. 18:18:06 INFO - ##### 18:18:06 INFO - Running pre-action listener: _resource_record_pre_action 18:18:06 INFO - Running main action method: create_virtualenv 18:18:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:06 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 18:18:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:06 INFO - Using real prefix '/tools/python27' 18:18:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:07 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:10 INFO - Installing pip.................done. 18:18:10 INFO - Return code: 0 18:18:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:18:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:10 INFO - 'HOME': '/Users/cltbld', 18:18:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:10 INFO - 'LOGNAME': 'cltbld', 18:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:10 INFO - 'MOZ_NO_REMOTE': '1', 18:18:10 INFO - 'NO_EM_RESTART': '1', 18:18:10 INFO - 'PAGER': '/bin/cat', 18:18:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:10 INFO - 'PWD': '/builds/slave/test', 18:18:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:10 INFO - 'SHELL': '/bin/bash', 18:18:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:10 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:10 INFO - 'USER': 'cltbld', 18:18:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:10 INFO - 'XPC_FLAGS': '0x0', 18:18:10 INFO - 'XPC_SERVICE_NAME': '0', 18:18:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:11 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 18:18:11 INFO - Cleaning up... 18:18:11 INFO - Return code: 0 18:18:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:18:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:11 INFO - 'HOME': '/Users/cltbld', 18:18:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:11 INFO - 'LOGNAME': 'cltbld', 18:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:11 INFO - 'MOZ_NO_REMOTE': '1', 18:18:11 INFO - 'NO_EM_RESTART': '1', 18:18:11 INFO - 'PAGER': '/bin/cat', 18:18:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:11 INFO - 'PWD': '/builds/slave/test', 18:18:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:11 INFO - 'SHELL': '/bin/bash', 18:18:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:11 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:11 INFO - 'USER': 'cltbld', 18:18:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:11 INFO - 'XPC_FLAGS': '0x0', 18:18:11 INFO - 'XPC_SERVICE_NAME': '0', 18:18:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:11 INFO - Downloading/unpacking psutil>=0.7.1 18:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:18:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:14 INFO - Installing collected packages: psutil 18:18:14 INFO - Running setup.py install for psutil 18:18:14 INFO - building 'psutil._psutil_osx' extension 18:18:14 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 18:18:16 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 18:18: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:18:17 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 18:18:17 INFO - building 'psutil._psutil_posix' extension 18:18:17 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 18:18:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:18:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:18:17 INFO - ^ 18:18:17 INFO - 1 warning generated. 18:18:17 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 18:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:17 INFO - Successfully installed psutil 18:18:17 INFO - Cleaning up... 18:18:18 INFO - Return code: 0 18:18:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:18 INFO - 'HOME': '/Users/cltbld', 18:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:18 INFO - 'LOGNAME': 'cltbld', 18:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:18 INFO - 'MOZ_NO_REMOTE': '1', 18:18:18 INFO - 'NO_EM_RESTART': '1', 18:18:18 INFO - 'PAGER': '/bin/cat', 18:18:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:18 INFO - 'PWD': '/builds/slave/test', 18:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:18 INFO - 'SHELL': '/bin/bash', 18:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:18 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:18 INFO - 'USER': 'cltbld', 18:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:18 INFO - 'XPC_FLAGS': '0x0', 18:18:18 INFO - 'XPC_SERVICE_NAME': '0', 18:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:18:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:18:20 INFO - Installing collected packages: mozsystemmonitor 18:18:20 INFO - Running setup.py install for mozsystemmonitor 18:18:20 INFO - Successfully installed mozsystemmonitor 18:18:20 INFO - Cleaning up... 18:18:21 INFO - Return code: 0 18:18:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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', '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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:18: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 blobuploader==1.2.4 18:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:21 INFO - 'HOME': '/Users/cltbld', 18:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:21 INFO - 'LOGNAME': 'cltbld', 18:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:21 INFO - 'MOZ_NO_REMOTE': '1', 18:18:21 INFO - 'NO_EM_RESTART': '1', 18:18:21 INFO - 'PAGER': '/bin/cat', 18:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:21 INFO - 'PWD': '/builds/slave/test', 18:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:21 INFO - 'SHELL': '/bin/bash', 18:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:21 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:21 INFO - 'USER': 'cltbld', 18:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:21 INFO - 'XPC_FLAGS': '0x0', 18:18:21 INFO - 'XPC_SERVICE_NAME': '0', 18:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:21 INFO - Downloading/unpacking blobuploader==1.2.4 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:23 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:23 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 18:18:23 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 18:18:23 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 18:18:23 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 18:18:23 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 18:18:23 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 18:18:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:25 INFO - Downloading docopt-0.6.1.tar.gz 18:18:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:25 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:25 INFO - Running setup.py install for blobuploader 18:18:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:25 INFO - Running setup.py install for requests 18:18:25 INFO - Running setup.py install for docopt 18:18:26 INFO - Successfully installed blobuploader requests docopt 18:18:26 INFO - Cleaning up... 18:18:26 INFO - Return code: 0 18:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:26 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')]} 18:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:26 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')]} 18:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:26 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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18:26 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 18:18:26 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 18:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:26 INFO - 'HOME': '/Users/cltbld', 18:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:26 INFO - 'LOGNAME': 'cltbld', 18:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:26 INFO - 'MOZ_NO_REMOTE': '1', 18:18:26 INFO - 'NO_EM_RESTART': '1', 18:18:26 INFO - 'PAGER': '/bin/cat', 18:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:26 INFO - 'PWD': '/builds/slave/test', 18:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:26 INFO - 'SHELL': '/bin/bash', 18:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:26 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:26 INFO - 'USER': 'cltbld', 18:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:26 INFO - 'XPC_FLAGS': '0x0', 18:18:26 INFO - 'XPC_SERVICE_NAME': '0', 18:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:26 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-PGqMkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:26 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-FlNmeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:26 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-ocUYPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:26 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-b9uuZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:26 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-aiawMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-oUK90e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-ekSiuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-tsaJdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-1Hq5Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-gAC5HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-IIuqZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-9aMdiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:27 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-rHSUOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:28 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-3u5Zi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:28 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-niq24d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:28 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-5zQIZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:28 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-mdmmWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:28 INFO - Running setup.py install for manifestparser 18:18:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:28 INFO - Running setup.py install for mozcrash 18:18:28 INFO - Running setup.py install for mozdebug 18:18:29 INFO - Running setup.py install for mozdevice 18:18:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Running setup.py install for mozfile 18:18:29 INFO - Running setup.py install for mozhttpd 18:18:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Running setup.py install for mozinfo 18:18:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Running setup.py install for mozInstall 18:18:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:29 INFO - Running setup.py install for mozleak 18:18:30 INFO - Running setup.py install for mozlog 18:18:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:30 INFO - Running setup.py install for moznetwork 18:18:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:30 INFO - Running setup.py install for mozprocess 18:18:30 INFO - Running setup.py install for mozprofile 18:18:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:30 INFO - Running setup.py install for mozrunner 18:18:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:31 INFO - Running setup.py install for mozscreenshot 18:18:31 INFO - Running setup.py install for moztest 18:18:31 INFO - Running setup.py install for mozversion 18:18:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:31 INFO - Cleaning up... 18:18:31 INFO - Return code: 0 18:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 18:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 18:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:31 INFO - 'HOME': '/Users/cltbld', 18:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:31 INFO - 'LOGNAME': 'cltbld', 18:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:31 INFO - 'MOZ_NO_REMOTE': '1', 18:18:31 INFO - 'NO_EM_RESTART': '1', 18:18:31 INFO - 'PAGER': '/bin/cat', 18:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:31 INFO - 'PWD': '/builds/slave/test', 18:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:31 INFO - 'SHELL': '/bin/bash', 18:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:31 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:31 INFO - 'USER': 'cltbld', 18:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:31 INFO - 'XPC_FLAGS': '0x0', 18:18:31 INFO - 'XPC_SERVICE_NAME': '0', 18:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:31 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-JjOd7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-LucRjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-OCWP4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-Z_HR9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-kiS1Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-GZ0R4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-fqAUkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-3i7WQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:32 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)) 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:32 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-GZZP8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-2YOO2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-LXABgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-c8_Jbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-v3Ng__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-qZeW6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-fuJyAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-OPFhgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:33 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)) 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:33 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-qVKSSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:34 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)) 18:18:34 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)) 18:18:34 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)) 18:18:34 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)) 18:18:34 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)) 18:18:34 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)) 18:18:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:36 INFO - Downloading blessings-1.5.1.tar.gz 18:18:36 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 18:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:36 INFO - Installing collected packages: blessings 18:18:36 INFO - Running setup.py install for blessings 18:18:36 INFO - Successfully installed blessings 18:18:36 INFO - Cleaning up... 18:18:36 INFO - Return code: 0 18:18:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:37 INFO - Reading from file tmpfile_stdout 18:18:37 INFO - Current package versions: 18:18:37 INFO - blessings == 1.5.1 18:18:37 INFO - blobuploader == 1.2.4 18:18:37 INFO - docopt == 0.6.1 18:18:37 INFO - manifestparser == 1.1 18:18:37 INFO - mozInstall == 1.12 18:18:37 INFO - mozcrash == 0.16 18:18:37 INFO - mozdebug == 0.1 18:18:37 INFO - mozdevice == 0.46 18:18:37 INFO - mozfile == 1.2 18:18:37 INFO - mozhttpd == 0.7 18:18:37 INFO - mozinfo == 0.8 18:18:37 INFO - mozleak == 0.1 18:18:37 INFO - mozlog == 3.0 18:18:37 INFO - moznetwork == 0.27 18:18:37 INFO - mozprocess == 0.22 18:18:37 INFO - mozprofile == 0.27 18:18:37 INFO - mozrunner == 6.11 18:18:37 INFO - mozscreenshot == 0.1 18:18:37 INFO - mozsystemmonitor == 0.0 18:18:37 INFO - moztest == 0.7 18:18:37 INFO - mozversion == 1.4 18:18:37 INFO - psutil == 3.1.1 18:18:37 INFO - requests == 1.2.3 18:18:37 INFO - wsgiref == 0.1.2 18:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:37 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')]} 18:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 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')]} 18:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10772b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1f01a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, '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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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 18:18:37 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 18:18:37 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 18:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:37 INFO - 'HOME': '/Users/cltbld', 18:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:37 INFO - 'LOGNAME': 'cltbld', 18:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:37 INFO - 'MOZ_NO_REMOTE': '1', 18:18:37 INFO - 'NO_EM_RESTART': '1', 18:18:37 INFO - 'PAGER': '/bin/cat', 18:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:37 INFO - 'PWD': '/builds/slave/test', 18:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:37 INFO - 'SHELL': '/bin/bash', 18:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:18:37 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:37 INFO - 'USER': 'cltbld', 18:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:37 INFO - 'XPC_FLAGS': '0x0', 18:18:37 INFO - 'XPC_SERVICE_NAME': '0', 18:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 INFO - Cleaning up... 18:18:37 INFO - Return code: 0 18:18:37 INFO - Running post-action listener: _resource_record_post_action 18:18:37 INFO - Running post-action listener: _start_resource_monitoring 18:18:37 INFO - Starting resource monitoring. 18:18:37 INFO - ##### 18:18:37 INFO - ##### Running install step. 18:18:37 INFO - ##### 18:18:37 INFO - Running pre-action listener: _resource_record_pre_action 18:18:37 INFO - Running main action method: install 18:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:38 INFO - Reading from file tmpfile_stdout 18:18:38 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:38 INFO - Reading from file tmpfile_stdout 18:18:38 INFO - Output received: 18:18:38 INFO - Usage: mozinstall [options] installer 18:18:38 INFO - Options: 18:18:38 INFO - -h, --help show this help message and exit 18:18:38 INFO - -d DEST, --destination=DEST 18:18:38 INFO - Directory to install application into. [default: 18:18:38 INFO - "/builds/slave/test"] 18:18:38 INFO - --app=APP Application being installed. [default: firefox] 18:18:38 INFO - mkdir: /builds/slave/test/build/application 18:18:38 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'] 18:18:38 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 18:19:16 INFO - Reading from file tmpfile_stdout 18:19:16 INFO - Output received: 18:19:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:19:16 INFO - Running post-action listener: _resource_record_post_action 18:19:16 INFO - ##### 18:19:16 INFO - ##### Running run-tests step. 18:19:16 INFO - ##### 18:19:16 INFO - Running pre-action listener: _resource_record_pre_action 18:19:16 INFO - Running main action method: run_tests 18:19:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:19:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:19:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:19:16 INFO - 2015-11-02 18:19:16.288 screenresolution[1635:7531] starting screenresolution argv=screenresolution get 18:19:16 INFO - 2015-11-02 18:19:16.291 screenresolution[1635:7531] Display 0: 1600x1200x32@60 18:19:16 INFO - 2015-11-02 18:19:16.297 screenresolution[1636:7533] starting screenresolution argv=screenresolution list 18:19:16 INFO - Available Modes on Display 0 18:19:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:19:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:19:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:19:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:19:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:19:16 INFO - Intel HD Graphics 3000: 18:19:16 INFO - Chipset Model: Intel HD Graphics 3000 18:19:16 INFO - Type: GPU 18:19:16 INFO - Bus: Built-In 18:19:16 INFO - VRAM (Total): 512 MB 18:19:16 INFO - VRAM (Dynamic, Max): 10 18:19:16 INFO - Vendor: Intel (0x8086) 18:19:16 INFO - Device ID: 0x0116 18:19:16 INFO - Revision ID: 0x0009 18:19:16 INFO - Displays: 18:19:16 INFO - Display: 18:19:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:19:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:19:16 INFO - Display Serial Number: 1600x1200 60 18:19:16 INFO - Main Display: Yes 18:19:16 INFO - Mirror: Off 18:19:16 INFO - Online: Yes 18:19:16 INFO - Rotation: Supported 18:19:16 INFO - Return code: 0 18:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:16 INFO - Python 2.7.3 18:19:16 INFO - Return code: 0 18:19:16 INFO - grabbing minidump binary from tooltool 18:19:16 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')]} 18:19:16 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 0x1076739f0>, '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 0x1073d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10763d990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:16 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 18:19:16 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 18:19:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:16 INFO - Return code: 0 18:19:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:19:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:19:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:16 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/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0006', '--webServer', 'localhost'] in /builds/slave/test/build 18:19:16 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/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0006 --webServer localhost 18:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8L7kS2PRPT/Render', 18:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:16 INFO - 'HOME': '/Users/cltbld', 18:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:16 INFO - 'LOGNAME': 'cltbld', 18:19:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:16 INFO - 'MOZ_NO_REMOTE': '1', 18:19:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:16 INFO - 'NO_EM_RESTART': '1', 18:19:16 INFO - 'PAGER': '/bin/cat', 18:19:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:16 INFO - 'PWD': '/builds/slave/test', 18:19:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:16 INFO - 'SHELL': '/bin/bash', 18:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0xfqLc6e6/Listeners', 18:19:16 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 18:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:16 INFO - 'USER': 'cltbld', 18:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:16 INFO - 'XPC_FLAGS': '0x0', 18:19:16 INFO - 'XPC_SERVICE_NAME': '0', 18:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:19:16 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/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0006', '--webServer', 'localhost'] with output_timeout 3600 18:19:17 INFO - mozversion INFO | application_buildid: 20151102152508 18:19:17 INFO - mozversion INFO | application_changeset: cb41b90cd72f67ea8abda60551d1af6f79888c42 18:19:17 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 18:19:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:17 INFO - mozversion INFO | application_name: Firefox 18:19:17 INFO - mozversion INFO | application_remotingname: firefox-dev 18:19:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:19:17 INFO - mozversion INFO | application_vendor: Mozilla 18:19:17 INFO - mozversion INFO | application_version: 44.0a2 18:19:17 INFO - mozversion INFO | platform_buildid: 20151102152508 18:19:17 INFO - mozversion INFO | platform_changeset: cb41b90cd72f67ea8abda60551d1af6f79888c42 18:19:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:19:17 INFO - mozversion INFO | platform_version: 44.0a2 18:19:17 INFO - 2015-11-02 18:19:17,057 DEBUG : using testdate: 1446517157 18:19:17 INFO - 2015-11-02 18:19:17,057 DEBUG : actual date: 1446517157 18:19:17 INFO - 2015-11-02 18:19:17,066 INFO : starting webserver on 'localhost:49280' 18:19:17 INFO - 2015-11-02 18:19:17,067 INFO : Starting test suite t-yosemite-r5-0006 18:19:17 INFO - 2015-11-02 18:19:17,067 INFO : Starting test dromaeo_css 18:19:17 INFO - 2015-11-02 18:19:17,067 DEBUG : operating with platform_type : mac_ 18:19:17 INFO - 2015-11-02 18:19:17,070 INFO : Initialising browser for dromaeo_css test... 18:19:17 INFO - 2015-11-02 18:19:17,105 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpngxFdk/profile http://localhost:49280/getInfo.html 18:19:19 INFO - 2015-11-02 18:19:19,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:19:19 INFO - 2015-11-02 18:19:19,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:19:19 INFO - 2015-11-02 18:19:19,760 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:19:19 INFO - 2015-11-02 18:19:19,760 DEBUG : BROWSER_OUTPUT: __metrics 18:19:19 INFO - 2015-11-02 18:19:19,776 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:20 INFO - 2015-11-02 18:19:20,486 INFO : Browser initialized. 18:19:20 INFO - 2015-11-02 18:19:20,486 INFO : Running cycle 1/1 for dromaeo_css test... 18:19:20 INFO - 2015-11-02 18:19:20,486 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpngxFdk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:19:32 INFO - 2015-11-02 18:19:32,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 201056256 18:19:32 INFO - 2015-11-02 18:19:32,397 DEBUG : BROWSER_OUTPUT: 18:20:23 INFO - 2015-11-02 18:20:23,952 DEBUG : BROWSER_OUTPUT: 1446517223949 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] 18:22:34 INFO - 2015-11-02 18:22:34,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 18:22:36 INFO - 2015-11-02 18:22:36,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 338161664 18:22:36 INFO - 2015-11-02 18:22:36,206 DEBUG : BROWSER_OUTPUT: 18:25:38 INFO - 2015-11-02 18:25:38,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 18:25:39 INFO - 2015-11-02 18:25:39,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 341082112 18:25:39 INFO - 2015-11-02 18:25:39,314 DEBUG : BROWSER_OUTPUT: 18:28:41 INFO - 2015-11-02 18:28:41,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 18:28:42 INFO - 2015-11-02 18:28:42,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 316940288 18:28:42 INFO - 2015-11-02 18:28:42,136 DEBUG : BROWSER_OUTPUT: 18:31:44 INFO - 2015-11-02 18:31:44,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 18:31:44 INFO - 2015-11-02 18:31:44,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 299847680 18:31:44 INFO - 2015-11-02 18:31:44,634 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-11-02 18:34:47,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 18:34:48 INFO - 2015-11-02 18:34:48,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 299114496 18:34:48 INFO - 2015-11-02 18:34:48,207 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 18:37:51 INFO - 2015-11-02 18:37:51,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 345300992 18:37:51 INFO - 2015-11-02 18:37:51,425 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,426 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:37:51 INFO - 2015-11-02 18:37:51,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:37:51 INFO - 2015-11-02 18:37:51,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:37:51 INFO - 2015-11-02 18:37:51,426 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:37:51 INFO - 2015-11-02 18:37:51,427 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3226.1934516370907;3309.619393769716;3320.950185747213;3334.4998250262443;3347.732181425486;5578.693171875545;5581.246531718217;5589.608727389084;5597.412271711472;5601.551875849932;5481.068218402871;5562.805301814437;5589.972050139743;5596.944030559694;5621.241132447119;5004.8999020019755;5131.153359695646;5179.197224430201;5184.351956005499;5252.6323157379;5150.562202212816;5190.844274671766;5205.349331333583;5267;5291.656042357254;5146.691198528081;5162.716050617215;5182.974085129569;5183.974080129594;5229.7385130743505;5121.641485096045;5224.843254702365;5359.115745901902;5367.624266301322;5448.318960129984;5338.46615338463;5355.3305836770405;5369.81205657804;5385.138377859524;5386.78452861885;5357.624966252364;5496.31296087989;5634.830955071355;5719.370869204384;5729.5702822288495;5803.071508558653;5847.239858818369;5863.58954873159;5885.941140588582;5897.498712609433;6058.1518587397795;6130.233720784902;6138.60099093562;6143.262808463013;6200.038993955944;5404.108322126884;5495.780168793203;5523.392426833045;5722.599418040739;5790.073588225906;6098.69506524672;6127.234095738033;6156.415140561639;6158.04550294705;6227.06594010902;5841.591088623755;5879.52963762898;5889.5877288590245;5953.1367951647635;5980.102984552265;5764.5676574257095;5950.553708471882;5952.970235148797;6003.459688628044;6109.633421994695;5788;5914.615549989237;5919.881602367928;5953.9878220702585;5973.044312909914;5910.113482977587;5923.940760592425;5932.139839723216;5965.55258355625;6003;4441.511433742286;4532.229520981441;4627.907441851212;4660.997885454643;4661.137689527448;4247.362895565628;4249.383839343278;4263.445752052214;4267.466566679165;4329.1341731653165;5715.399883012307;5724.599278050579;5766.913496297559;5779.988502012131;5811.360750317462;5699.658020518782;5827.88344233113;5861.794837180678;5909.763609455574;6218.378162183836;5637.23897273871;5735.1684005818925;5747.5689323300085;5751.22358481608;5831.3877042910735;5391.137418013099;5406.486383793612;5408.891822163535;5441.564674826004;5448.318960129984;5754.971225143931;5822.883542329045;5868.061110222344;6001.549883758648;6181.876362472725;6102.046825947346;6116.5718399711595;6116.571839971337;6139.785107521216;6145.29037144807;6129.601575897553;6142.201513803177;6178.876422471615;6204.255489341127;6245.594036387621;5657.12314591239;5777.45114214149;5857.882842343214;5898.8230353089475;6046.1535385045245;5978.730957106854;6108.664023478751;6131.264248290056;6163.137160797402;6167.167432396748;5895.086261629454;5903.321118071477;5981.222441082806;5982.49148822355;6011.519078473799;5667.40492248308;5686.147077938343;5735.340435849764;5804.564657650778;5919.526437885045;5656.85857853557;5704.657720536781;5704.828855134353;5722.198892155018;5756.7409466574945;5814.709264536841;5834.27071616048;5847.8245652630485;5848.2689663792025;5863.501602363847;5532.612717109763;5592.077307244259;5657.915131272952;5708.372079071216;5725.141228815711 18:37:51 INFO - 2015-11-02 18:37:51,429 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.690691272826;583.4894467341077;587.4331270324137;592.7569696424467;595.2737660054734;33623.15942101449;38864.80567597161;39073;39102.41346379807;39144.41283380752;43839.78080109595;44523;44594;44641;44658.77670611643;8813.515256660914;9007.774805629846;9460.999999999984;9707.029297070272;11132.833007504894;11403.771924561504;11433.028192603639;11472.196946213768;11492.42537873103;11524.481398337095;11425.42872856358;11531.769364612745;11578.710532236677;11580.884191158066;11594.362310072942;9181.678641247558;9377.953110234439;11641.18511704181;11818.290902545874;11897.345645989468;11229.831552526719;11331.03686186675;11336.659900203007;11372.03337716295;11408.771824563462;41117.38323925144;41468;41604.37593436101;41606;41632.37551436731;3064.2033071401374;3121.5161649944293;3319;3363.4954756786433;3462.7576069675133;28496.430071398456;28631.713682863112;29229.70770292291;29291.414171716446;29378.8522530069;2419.2742177346727;2468.9135880244107;2491.9626205606933;2509.2723110297993;2572.9485410291877;286186;286274;286508;286941;287250;56614.7169264151;58368.124478132864;65321.67339163369;74125;75294.24705752982;66915;67457.66271168711;67684.93890366594;67732.66133669399;67743.66128169328;18458.81541184598;18647.81352186461;18665.533361665795;18674.813251867577;18675.813241867407;14039.85960140406;14112.153270803785;14161.645958850904;14182;14217.85782142186;21043;21093.894530527556;21270.042848071873;21343.25298614541;21399.46501337448;8484.490930544187;8673.436226645248;8751.606177722018;8836.734897953073;8889.555522223864;920.3557509743073;960.7357976556364;1007.5717819926502;1049.223574554824;1091.8525998990194;30404.239894002385;30414;30416;30432.087037388912;30597;1026.1175389165312;1103.1175059952006;1103.266327891959;1136.6817291158488;1201.483362154282;15852.365905363657;16438.260278287507;16469;16592.917035414746;16672.916635416987;347500;355738;356133;356595;356794;50858.237126443135;51555.74222128865;59427;63060;63569.68215158987;1436.5259464376732;1453.6075259679826;1469.992650036743;1470.4485817818104;1474.9410023598937;26339.341516462242;28510.65954366136;29994.550081748355;30560.694393055786;30649.387012260075;53081.20378194253;53523;53540;53638;53694;271466;273023;273464;273792;273881;33396.165095871824;34158.65841341555;34226;34232.657673422946;34271;43643.345349819145;43827.561724383624;43881;43884.341734873364;44296.55703442924;36624.45063323999;37098.8145059273;37585.2482950334;37843.81078094592;38107.618923810405;37095.814520927226;37236.06909827276;37577.59635920946;37593.87218383453;37939.430908536946;37712.81143594265;38294.2341153181;38669.806650967694;38766.2246755069;38770.6122938767;29510.262243444085;31260.843695781376;31404.371912561164;31435.214119647193;31508.527372088978;24126.75873241245;25537.23388298354;26670;26761.44866806299;27073.59389609118 18:37:51 INFO - 2015-11-02 18:37:51,432 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.46860429126264;354.4169840612193;360.065629690952;362.6138162856559;364.7428562863181;15057;15205.543833685007;17814.732779008325;17992.910035449822;18622.81377186228;12416.130870839022;12733.172343797647;15604.609884752887;18781.812181878176;18821.929587745337;4546.681732278734;4650.558196971282;4655.185342565038;4655.324977878206;4659.161350956826;3675.356812557805;3756.417755247941;4602.355670206174;4807.399075115611;4935.407751069876;4967.155583550805;4980;4980.551750342468;4989.550940415362;4990.351254336932;4867.391576053011;4989.3513843200335;5009.824656137018;5014.172661510846;5018.5232402921665;4273.914521709579;4274.252005898987;4274.487061552602;4288.678349123828;4292.0772034012525;13563.864361356358;13720.313984300845;14112.153270803681;14117.64705882351;14119.85880141206;1736.3835838277355;1746.737989301615;1944.7569053868267;1952.3069310394746;1961.7547806524185;10145.797084058277;10185.490725463696;10362.948185259102;10364.533595988123;10498.79002419955;1626.4470080172798;1628.4300494826834;1639.114877965897;1652.6446813934942;1664.3342662934801;59672.403275967554;60122.791404601696;62851.37148628501;63200;63202;6739.797806065826;6833.3166683332265;6931.376176144171;6976;6992.650367481708;7923.16806735296;8013.6794528218215;8033.1163572007035;8038.598070096472;8044.195580442026;5728.856778580485;5800.9419905800405;5801.6519008859605;5828.795992140254;5842.036064049469;5867.706614669335;5921.703914804242;6090.756369745249;6125.908111378333;6173.81478555644;2913.0969399486225;3105.9844700776353;3119.407312610597;3129.4523458394688;3147.118806734118;1088.4815682123551;1099.6591056772427;1105.5467258424007;1116.0736588631416;1140.663504266227;444.6242924728599;446.32604766802365;467.632908167094;469.9342092107108;473.93601863747955;10582.470876456146;11226.101911847032;11481.196316257949;12026.27842329463;12116.333601651993;478.8371953535815;482.45482604656513;483.29439019031906;487.26666367117264;511.59583928696657;6464.709088091047;6669.299723529057;6690.632015239111;6696.06255124283;6744.527883048139;619784;653816;655750;656260;660756;75583.62208189034;76302.61848690832;76712.23287767051;76999.61500192463;78214.60892695613;525.5401523666792;530.8540151458303;530.8619758862646;531.6650510178563;532.4249810205047;11331.886681133083;11399.08807295431;11578.189526733047;11611.361375124448;11618.825717614074;36343.27313453769;36917.26165476729;36943.63056369509;37331;37573;49215.26177107275;49245.75377123091;49603.50396495989;50071.499285006685;50989.745051274505;6542;6664.666766661744;6670.266270710121;6675;6691.364320389555;12236.69408264765;12273.938630306791;12585.93707031459;12591.93704031474;12639.431225595054;10633.468326583794;10636.89363106359;10795.514201861091;10820.621278255223;10981.231313807957;10035.14701250402;10489.475526223505;10575.841362379724;10606.946965265124;10774.299670521392;8222.465539739898;8740.125987401208;8749.956250218707;10648.740503798543;10879.45602719845;6500.252470965899;6553.5084868634085;6556.8360790978695;6623.304553022056;6629.7348106075215;10214.693559193236;10566.788664226826;10681.19891008193;10782.08352290064;10821.891781082088 18:37:51 INFO - 2015-11-02 18:37:51,434 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1376.4700590272741;1744.2761254079558;1810.7696265658703;1846.8060853610361;1875.4467432107526;7146.249643787399;7478.214787447321;7561.432892533055;7575.242475752422;7586.393088552916;7291;7489.588072656002;7499.662515186816;7501.324880760731;7514.3237108660205;2198.692183094368;2212;2215.9335219943428;2216.645336746121;2216.833737469688;2191.7041199438113;2213.0483891926465;2227.6435770276757;2228.0864845413385;2234.832387570939;2184.4975655599224;2210.491586935006;2216.5345277491747;2227.6213043782514;2230.609643312422;2178.3900507857825;2198.5822693688147;2206.6248737714627;2214.1032881682945;2217.5454031923496;2232.598132336179;2243.921462748796;2244.012634440841;2246.33733048751;2251.3358559225067;7108.502404831664;7364.079490063742;7391.260873912565;7444.404447644176;7450.85098298031;4439.356293337448;4698.3187437821325;4706.3411122442885;4711.316859055418;4716.339712440261;2763.6821765497025;2840.4461130079644;2853.7288957549;2872.2532141643323;2875.7411832934927;836.2348451167236;841.3899922556097;842.5492361586522;843.439112989861;854.9786255343604;10595.84106238407;10668.62659806903;10683.46582670871;10691;10705.518251678694;4399.890002749957;4411.272140096912;4447.177272204653;4455.22033644111;4482.372467854503;9343.34596578233;9417.152456278967;9424.811503770023;9437.339386243035;9463.76340591477;4978.925316120261;4989.501049894981;4999.800007999712;5000.499950004971;5012.874678133076;4515.277555591089;4567.269236922143;4571.245744452128;4573.382593349856;4582.702124361906;3599.6681227945305;3639.94540081899;3641.2353405785084;3647.215848592565;3691.224842782992;1133.7109037195462;1165.8076417391205;1170.104869774623;1173.3957012138756;1177.9222011859054;1100.5047728522197;1133.1388145009853;1231.1382032577233;1338.1903948111253;1356.6879617687987;7647.120581133129;7664.540127592362;7677.23227677239;7746.535207887545;7747.38020958322;1085.039739830256;1103.2828661370174;1177.2759752752168;1186.5016692988966;1187.7825229140028;5565.0817615093865;6040.516758659297;6070.7875224366935;6123.357047510036;6139.26328840542;8343.332533397313;9031.27749780016;9257.398269112486;9264.073592640681;9281.814363712689;9207.355485115977;9318.30112741547;9353.719388418358;9477.526123693788;9503.19222866064;7550.320471157622;7632.847343053108;7640.083190017233;7652.69389224436;7654.885176722353;7087.220405755466;7130.572165670076;7171.713131474683;7183.20984691694;7255.528390654802;7842.803929901798;7916.881246781418;7923.960380198062;7925.128235894163;8341.916580834113;8311.833763324821;8432.409731318994;8434.536100514286;8443.113473085483;8795.956020219857;7676.692932282646;7720.922790772021;7722.266384693445;7760.495567788075;7764.107127680389;7663.846723065619;7708.997830282027;7738.303552680286;7770.300672939463;7797.025371828521;7006.194287656781;7011.3339232772805;7104.076470058859;7215.2063273038875;7279.381252593589;7042.471814614027;7048.718051277891;7108.07595012645;7212.459065570209;7235.529690570306;7309.597972111585;7356.595387253538;7388.556686598821;7392.667329970057;7398.852022959403;6571.408573228432;6600.53796234259;6616.636085015371;6650.866982660223;6658.034584985053;6772.288909664611;6802.897956530755;6829.4877884157895;6848.623325717133;6854.246032936473 18:37:51 INFO - 2015-11-02 18:37:51,436 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.1905528931266;316.9381970515749;318.4411358066593;318.87563850098456;323.0309072781655;6060.1212824140475;6109.083637454384;6173.228346456693;6293.653849038301;6294.9999999999945;6030.457258846703;6124.448799608045;6164.938350616492;6169.845753856156;6173.197484327043;4558.293464513005;4648.930266046012;4707.05858828234;4715.575598196162;4725.740084295362;4660.883477913046;4716.316134160545;4744.786484608184;4745.810167593292;4747.1929771938685;4644.9535504644855;4656.208444564432;4666.743329116897;4680.976595117019;4703.059388122372;4657.534246575349;4678.976605116953;4687.250039993619;4689.835855745049;4694.201985662446;3905.9218815623813;3991.102002049545;4003.559608443069;4009.158076803875;4018.959810401888;5979.701014949279;5985.880282394328;5995.7901473448655;5998.7600495980105;6040.607360521596;5195.662281951699;5195.9480405195845;5201.375834899798;5202.08963431398;5217.713025783581;6157.692115394212;6287.245530536319;6293.653849038301;6383.234011918599;6412.39082287182;4213.726107803013;4220.767857767822;4229.78851057449;4235.978820105911;4245.596668316505;6626.138601981712;6682.264950855402;6697.464202863759;6699.296573859772;6709.664516774142;4183.5398106208295;4290.764007979591;4298.914021719548;4306.354046892991;4306.375575541529;4416.580424859633;4418.293073108352;4419.469663640384;4420.381146639473;4426.336049592587;5179.7928082877015;5188.299579556787;5193.870153246199;5197.7141257231215;5202.739863006835;6481.513886458534;6481.805545833632;6506.284308726036;6507.381798729113;6530.60816351011;1586.3813112885985;1608.332541995059;1610.1627153880152;1613.3869129730626;1637.3777964373462;1032.5250384822916;1070.0583486531957;1077.8922107789315;1078.7357097511003;1093.9562417503212;6176.413240742122;6202.317745048041;6205.627662340274;6222.968885155546;6230.034344676583;6644.036614690939;6644.767433139914;6647.634380109141;6648.335166483313;6648.601083934979;6123.632582045091;6257.2804127525915;6270.592411493239;6273.65494897785;6281.96859015702;3686.4470329450796;3728.55257369112;3733.104055026774;3733.328000959799;3749.1564398010228;6819.556728812611;6838.042674025641;6839.076724642209;6840.213375461885;6868.896966545406;6891.931080689129;6899.517033807686;6907.792766217021;6909.239983601799;6923.4807389446;6639.336066393322;6747.797566073025;6839.658017099126;6869.244383117853;6895.172579290517;6655.767048153291;6686.53194276396;6716.1604799400075;6733.797986060426;6739.6967136478;6534.444572211225;6566.573172743756;6580.638064906476;6581.045748366364;6595.373439523238;6637.502187335873;6769.864602708017;6781.152355955505;6793.320667933167;6798.93201067983;4227.725197862129;4258.723182993095;4268.381084742757;4277.2087163874785;4300.053988122608;6787.626680532618;6794.252632210354;6806.115205023315;6823.965880170567;6836.5214434989075;6382.329855365306;6558.1802274715665;6564.376384243489;6571.80284591463;6612.768553100618;6576.736930522917;6585.440237579859;6591.6374599397495;6596.571222870498;6599.175103112111;6416.069669897745;6424.357564243725;6440.420362167428;6444.709988050643;6448.451881590117;6403.8719225614295;6589.967050164719;6596.208454985433;6598.90101648466;6599;6457.257415397289;6483.157189565326;6486.481081513562;6494.64279464634;6521.576097553644 18:37:51 INFO - 2015-11-02 18:37:51,439 DEBUG : BROWSER_OUTPUT: |5;yui.html;669.9397054265115;696.9442444604431;718.96405179741;720.1789959446236;756.3344257053793;14431.556844315563;14500.999999999987;14753.11481311122;14756.999999999987;14771.113733176016;13661;13751.243681597509;13766.24285664288;13799.93100034501;13800.585982420544;743.3867059675762;754.9018627578407;924.089771574998;929.372673445425;951.3816019587255;928.9349745517817;929.5677509957868;940.47333493244;940.952952352383;941.3316545252878;984.5372674842812;995.0944640377259;995.6266400099962;995.8157740817971;996.3523709588753;779.283059585183;789.9131095579481;959.5873774277059;976.4873441443228;978.8629591857145;725.1986554856912;725.2855936902147;725.3471875312208;725.5102805606194;725.8657148427558;14565;14703.19132447715;14709.190994495299;14717.969742118055;14726.33731482086;12229.327386993711;12565;12580.811287830598;12809.231446113263;12935.805962910565;9634.9518252409;9851.113399793981;9860.370098573976;10089.596416143346;10625.628103016357;3329.8501567429525;3409.2840503494294;3470.6529347065343;3483.7213022958103;3487.494313324554;50605.746971265275;51132.48867511352;51462.74268628633;51815;51844.740776296254;9080.591373388213;9447.897188149522;9479.383840050376;9520;9527.142557169887;19748.210071596975;19877.204911803365;19905.900470497556;19916.800831991495;20024.39926802198;7196.280371962762;7378.631068446556;7406.666699998405;7450.776476705708;7473.439492038119;3886.7279290449396;3967.3255546557157;4019.2966230909474;4025.1547175092974;4027.6979226558124;3032.6815684353264;3050.176452357851;3077.5999120114243;3079.1070589528786;3089.3203495231014;448.89002194462563;451.7154192858478;453.76857802520954;454.4977799531536;458.8531669865611;544.3087279155451;546.6392181160495;576.4466112531933;598.6109029131013;621.8041316985226;6999.790006299819;7568.205338439495;7693.884591731128;7839.333656639135;7849.175836537195;527.6016607461343;570.2273419516496;587.1926101610286;604.2326245667977;606.9757209711651;3767.811609419518;3801.201747632973;4093.672506199497;4135;4218.535961044283;59873;59937.100943485886;59939.100913486334;60186;60233.69883150644;49009.50990490049;50216;50584.49415505872;50736.49263507391;51039.489605103474;43297;43516.3472547912;45282;47322.763386183535;48222.27666585004;8249.752507424786;8405.915940840758;8565.61454734526;8593.097724738813;8803.603837827184;32638;33866.49200261949;35348.82325588356;35828.283434330646;37878.62121378751;48440.5155948436;49096;49407.75296123496;49650;50008.249876252616;7994.2805147537;7995.480293780885;8173.18268173178;8348.165183481604;8548.529830859114;11155.81783500241;11498.195126341076;11649.242799218024;11925.045996320447;12240.877591223974;10292.228082893664;10375.533101010322;10542.10392116648;11094.611688590861;11109.555617775522;10722.839157412489;10971.122310215003;10981.61564345244;11201.495932683212;11684.70788230301;10034.347767395097;10047.145992590711;10479.528421221215;10499.107575856138;10662.520186591777;8385;8890.06654301289;8930.776730581787;9082.863757043782;9111.589978450853;8612.741617751477;9441.575129119068;9490.810183796148;9521.857172142561;9676.85484717744 18:37:51 INFO - 2015-11-02 18:37:51,439 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:37:51 INFO - 2015-11-02 18:37:51,439 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:37:51 INFO - 2015-11-02 18:37:51,439 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 18:37:51 INFO - 2015-11-02 18:37:51,440 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:37:51 INFO - 2015-11-02 18:37:51,440 DEBUG : BROWSER_OUTPUT: __startTimestamp1446518271424__endTimestamp 18:37:51 INFO - 2015-11-02 18:37:51,440 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,440 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:37:51 INFO - 2015-11-02 18:37:51,440 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:37:51 INFO - 2015-11-02 18:37:51,441 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,441 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5591.31 Median:5747.57 stddev:590.68 (10.3%) stddev-sans-first:562.60 18:37:51 INFO - 2015-11-02 18:37:51,441 DEBUG : BROWSER_OUTPUT: Values: 3226.2 3309.6 3321.0 3334.5 3347.7 5578.7 5581.2 5589.6 5597.4 5601.6 5481.1 5562.8 5590.0 5596.9 5621.2 5004.9 5131.2 5179.2 5184.4 5252.6 5150.6 5190.8 5205.3 5267.0 5291.7 5146.7 5162.7 5183.0 5184.0 5229.7 5121.6 5224.8 5359.1 5367.6 5448.3 5338.5 5355.3 5369.8 5385.1 5386.8 5357.6 5496.3 5634.8 5719.4 5729.6 5803.1 5847.2 5863.6 5885.9 5897.5 6058.2 6130.2 6138.6 6143.3 6200.0 5404.1 5495.8 5523.4 5722.6 5790.1 6098.7 6127.2 6156.4 6158.0 6227.1 5841.6 5879.5 5889.6 5953.1 5980.1 5764.6 5950.6 5953.0 6003.5 6109.6 5788.0 5914.6 5919.9 5954.0 5973.0 5910.1 5923.9 5932.1 5965.6 6003.0 4441.5 4532.2 4627.9 4661.0 4661.1 4247.4 4249.4 4263.4 4267.5 4329.1 5715.4 5724.6 5766.9 5780.0 5811.4 5699.7 5827.9 5861.8 5909.8 6218.4 5637.2 5735.2 5747.6 5751.2 5831.4 5391.1 5406.5 5408.9 5441.6 5448.3 5755.0 5822.9 5868.1 6001.5 6181.9 6102.0 6116.6 6116.6 6139.8 6145.3 6129.6 6142.2 6178.9 6204.3 6245.6 5657.1 5777.5 5857.9 5898.8 6046.2 5978.7 6108.7 6131.3 6163.1 6167.2 5895.1 5903.3 5981.2 5982.5 6011.5 5667.4 5686.1 5735.3 5804.6 5919.5 5656.9 5704.7 5704.8 5722.2 5756.7 5814.7 5834.3 5847.8 5848.3 5863.5 5532.6 5592.1 5657.9 5708.4 5725.1 18:37:51 INFO - 2015-11-02 18:37:51,441 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,441 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48992.31 Median:31332.61 stddev:80154.55 (255.8%) stddev-sans-first:80296.87 18:37:51 INFO - 2015-11-02 18:37:51,442 DEBUG : BROWSER_OUTPUT: Values: 545.7 583.5 587.4 592.8 595.3 33623.2 38864.8 39073.0 39102.4 39144.4 43839.8 44523.0 44594.0 44641.0 44658.8 8813.5 9007.8 9461.0 9707.0 11132.8 11403.8 11433.0 11472.2 11492.4 11524.5 11425.4 11531.8 11578.7 11580.9 11594.4 9181.7 9378.0 11641.2 11818.3 11897.3 11229.8 11331.0 11336.7 11372.0 11408.8 41117.4 41468.0 41604.4 41606.0 41632.4 3064.2 3121.5 3319.0 3363.5 3462.8 28496.4 28631.7 29229.7 29291.4 29378.9 2419.3 2468.9 2492.0 2509.3 2572.9 286186.0 286274.0 286508.0 286941.0 287250.0 56614.7 58368.1 65321.7 74125.0 75294.2 66915.0 67457.7 67684.9 67732.7 67743.7 18458.8 18647.8 18665.5 18674.8 18675.8 14039.9 14112.2 14161.6 14182.0 14217.9 21043.0 21093.9 21270.0 21343.3 21399.5 8484.5 8673.4 8751.6 8836.7 8889.6 920.4 960.7 1007.6 1049.2 1091.9 30404.2 30414.0 30416.0 30432.1 30597.0 1026.1 1103.1 1103.3 1136.7 1201.5 15852.4 16438.3 16469.0 16592.9 16672.9 347500.0 355738.0 356133.0 356595.0 356794.0 50858.2 51555.7 59427.0 63060.0 63569.7 1436.5 1453.6 1470.0 1470.4 1474.9 26339.3 28510.7 29994.6 30560.7 30649.4 53081.2 53523.0 53540.0 53638.0 53694.0 271466.0 273023.0 273464.0 273792.0 273881.0 33396.2 34158.7 34226.0 34232.7 34271.0 43643.3 43827.6 43881.0 43884.3 44296.6 36624.5 37098.8 37585.2 37843.8 38107.6 37095.8 37236.1 37577.6 37593.9 37939.4 37712.8 38294.2 38669.8 38766.2 38770.6 29510.3 31260.8 31404.4 31435.2 31508.5 24126.8 25537.2 26670.0 26761.4 27073.6 18:37:51 INFO - 2015-11-02 18:37:51,442 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,443 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30214.39 Median:2496.50 stddev:106311.43 (4258.4%) stddev-sans-first:106585.99 18:37:51 INFO - 2015-11-02 18:37:51,443 DEBUG : BROWSER_OUTPUT: Values: 338.5 354.4 360.1 362.6 364.7 15057.0 15205.5 17814.7 17992.9 18622.8 12416.1 12733.2 15604.6 18781.8 18821.9 4546.7 4650.6 4655.2 4655.3 4659.2 3675.4 3756.4 4602.4 4807.4 4935.4 4967.2 4980.0 4980.6 4989.6 4990.4 4867.4 4989.4 5009.8 5014.2 5018.5 4273.9 4274.3 4274.5 4288.7 4292.1 13563.9 13720.3 14112.2 14117.6 14119.9 1736.4 1746.7 1944.8 1952.3 1961.8 10145.8 10185.5 10362.9 10364.5 10498.8 1626.4 1628.4 1639.1 1652.6 1664.3 59672.4 60122.8 62851.4 63200.0 63202.0 6739.8 6833.3 6931.4 6976.0 6992.7 7923.2 8013.7 8033.1 8038.6 8044.2 5728.9 5800.9 5801.7 5828.8 5842.0 5867.7 5921.7 6090.8 6125.9 6173.8 2913.1 3106.0 3119.4 3129.5 3147.1 1088.5 1099.7 1105.5 1116.1 1140.7 444.6 446.3 467.6 469.9 473.9 10582.5 11226.1 11481.2 12026.3 12116.3 478.8 482.5 483.3 487.3 511.6 6464.7 6669.3 6690.6 6696.1 6744.5 619784.0 653816.0 655750.0 656260.0 660756.0 75583.6 76302.6 76712.2 76999.6 78214.6 525.5 530.9 530.9 531.7 532.4 11331.9 11399.1 11578.2 11611.4 11618.8 36343.3 36917.3 36943.6 37331.0 37573.0 49215.3 49245.8 49603.5 50071.5 50989.7 6542.0 6664.7 6670.3 6675.0 6691.4 12236.7 12273.9 12585.9 12591.9 12639.4 10633.5 10636.9 10795.5 10820.6 10981.2 10035.1 10489.5 10575.8 10606.9 10774.3 8222.5 8740.1 8750.0 10648.7 10879.5 6500.3 6553.5 6556.8 6623.3 6629.7 10214.7 10566.8 10681.2 10782.1 10821.9 18:37:51 INFO - 2015-11-02 18:37:51,444 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,444 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5516.63 Median:6787.59 stddev:2843.57 (41.9%) stddev-sans-first:2834.51 18:37:51 INFO - 2015-11-02 18:37:51,445 DEBUG : BROWSER_OUTPUT: Values: 1376.5 1744.3 1810.8 1846.8 1875.4 7146.2 7478.2 7561.4 7575.2 7586.4 7291.0 7489.6 7499.7 7501.3 7514.3 2198.7 2212.0 2215.9 2216.6 2216.8 2191.7 2213.0 2227.6 2228.1 2234.8 2184.5 2210.5 2216.5 2227.6 2230.6 2178.4 2198.6 2206.6 2214.1 2217.5 2232.6 2243.9 2244.0 2246.3 2251.3 7108.5 7364.1 7391.3 7444.4 7450.9 4439.4 4698.3 4706.3 4711.3 4716.3 2763.7 2840.4 2853.7 2872.3 2875.7 836.2 841.4 842.5 843.4 855.0 10595.8 10668.6 10683.5 10691.0 10705.5 4399.9 4411.3 4447.2 4455.2 4482.4 9343.3 9417.2 9424.8 9437.3 9463.8 4978.9 4989.5 4999.8 5000.5 5012.9 4515.3 4567.3 4571.2 4573.4 4582.7 3599.7 3639.9 3641.2 3647.2 3691.2 1133.7 1165.8 1170.1 1173.4 1177.9 1100.5 1133.1 1231.1 1338.2 1356.7 7647.1 7664.5 7677.2 7746.5 7747.4 1085.0 1103.3 1177.3 1186.5 1187.8 5565.1 6040.5 6070.8 6123.4 6139.3 8343.3 9031.3 9257.4 9264.1 9281.8 9207.4 9318.3 9353.7 9477.5 9503.2 7550.3 7632.8 7640.1 7652.7 7654.9 7087.2 7130.6 7171.7 7183.2 7255.5 7842.8 7916.9 7924.0 7925.1 8341.9 8311.8 8432.4 8434.5 8443.1 8796.0 7676.7 7720.9 7722.3 7760.5 7764.1 7663.8 7709.0 7738.3 7770.3 7797.0 7006.2 7011.3 7104.1 7215.2 7279.4 7042.5 7048.7 7108.1 7212.5 7235.5 7309.6 7356.6 7388.6 7392.7 7398.9 6571.4 6600.5 6616.6 6650.9 6658.0 6772.3 6802.9 6829.5 6848.6 6854.2 18:37:51 INFO - 2015-11-02 18:37:51,445 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,446 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5387.47 Median:6189.37 stddev:1658.05 (26.8%) stddev-sans-first:1618.26 18:37:51 INFO - 2015-11-02 18:37:51,447 DEBUG : BROWSER_OUTPUT: Values: 307.2 316.9 318.4 318.9 323.0 6060.1 6109.1 6173.2 6293.7 6295.0 6030.5 6124.4 6164.9 6169.8 6173.2 4558.3 4648.9 4707.1 4715.6 4725.7 4660.9 4716.3 4744.8 4745.8 4747.2 4645.0 4656.2 4666.7 4681.0 4703.1 4657.5 4679.0 4687.3 4689.8 4694.2 3905.9 3991.1 4003.6 4009.2 4019.0 5979.7 5985.9 5995.8 5998.8 6040.6 5195.7 5195.9 5201.4 5202.1 5217.7 6157.7 6287.2 6293.7 6383.2 6412.4 4213.7 4220.8 4229.8 4236.0 4245.6 6626.1 6682.3 6697.5 6699.3 6709.7 4183.5 4290.8 4298.9 4306.4 4306.4 4416.6 4418.3 4419.5 4420.4 4426.3 5179.8 5188.3 5193.9 5197.7 5202.7 6481.5 6481.8 6506.3 6507.4 6530.6 1586.4 1608.3 1610.2 1613.4 1637.4 1032.5 1070.1 1077.9 1078.7 1094.0 6176.4 6202.3 6205.6 6223.0 6230.0 6644.0 6644.8 6647.6 6648.3 6648.6 6123.6 6257.3 6270.6 6273.7 6282.0 3686.4 3728.6 3733.1 3733.3 3749.2 6819.6 6838.0 6839.1 6840.2 6868.9 6891.9 6899.5 6907.8 6909.2 6923.5 6639.3 6747.8 6839.7 6869.2 6895.2 6655.8 6686.5 6716.2 6733.8 6739.7 6534.4 6566.6 6580.6 6581.0 6595.4 6637.5 6769.9 6781.2 6793.3 6798.9 4227.7 4258.7 4268.4 4277.2 4300.1 6787.6 6794.3 6806.1 6824.0 6836.5 6382.3 6558.2 6564.4 6571.8 6612.8 6576.7 6585.4 6591.6 6596.6 6599.2 6416.1 6424.4 6440.4 6444.7 6448.5 6403.9 6590.0 6596.2 6598.9 6599.0 6457.3 6483.2 6486.5 6494.6 6521.6 18:37:51 INFO - 2015-11-02 18:37:51,447 DEBUG : BROWSER_OUTPUT: 18:37:51 INFO - 2015-11-02 18:37:51,447 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13936.21 Median:50671.12 stddev:16589.01 (32.7%) stddev-sans-first:16605.64 18:37:51 INFO - 2015-11-02 18:37:51,448 DEBUG : BROWSER_OUTPUT: Values: 669.9 696.9 719.0 720.2 756.3 14431.6 14501.0 14753.1 14757.0 14771.1 13661.0 13751.2 13766.2 13799.9 13800.6 743.4 754.9 924.1 929.4 951.4 928.9 929.6 940.5 941.0 941.3 984.5 995.1 995.6 995.8 996.4 779.3 789.9 959.6 976.5 978.9 725.2 725.3 725.3 725.5 725.9 14565.0 14703.2 14709.2 14718.0 14726.3 12229.3 12565.0 12580.8 12809.2 12935.8 9635.0 9851.1 9860.4 10089.6 10625.6 3329.9 3409.3 3470.7 3483.7 3487.5 50605.7 51132.5 51462.7 51815.0 51844.7 9080.6 9447.9 9479.4 9520.0 9527.1 19748.2 19877.2 19905.9 19916.8 20024.4 7196.3 7378.6 7406.7 7450.8 7473.4 3886.7 3967.3 4019.3 4025.2 4027.7 3032.7 3050.2 3077.6 3079.1 3089.3 448.9 451.7 453.8 454.5 458.9 544.3 546.6 576.4 598.6 621.8 6999.8 7568.2 7693.9 7839.3 7849.2 527.6 570.2 587.2 604.2 607.0 3767.8 3801.2 4093.7 4135.0 4218.5 59873.0 59937.1 59939.1 60186.0 60233.7 49009.5 50216.0 50584.5 50736.5 51039.5 43297.0 43516.3 45282.0 47322.8 48222.3 8249.8 8405.9 8565.6 8593.1 8803.6 32638.0 33866.5 35348.8 35828.3 37878.6 48440.5 49096.0 49407.8 49650.0 50008.2 7994.3 7995.5 8173.2 8348.2 8548.5 11155.8 11498.2 11649.2 11925.0 12240.9 10292.2 10375.5 10542.1 11094.6 11109.6 10722.8 10971.1 10981.6 11201.5 11684.7 10034.3 10047.1 10479.5 10499.1 10662.5 8385.0 8890.1 8930.8 9082.9 9111.6 8612.7 9441.6 9490.8 9521.9 9676.9 18:37:51 INFO - 2015-11-02 18:37:51,449 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:37:51 INFO - 2015-11-02 18:37:51,449 DEBUG : BROWSER_OUTPUT: 18:37:52 INFO - 2015-11-02 18:37:52,134 INFO : Browser exited with error code: 0 18:37:52 INFO - 2015-11-02 18:37:52,162 INFO : Completed test dromaeo_css (00:18:35) 18:37:52 INFO - 2015-11-02 18:37:52,162 INFO : Starting test kraken 18:37:52 INFO - 2015-11-02 18:37:52,162 DEBUG : operating with platform_type : mac_ 18:37:52 INFO - 2015-11-02 18:37:52,162 INFO : Initialising browser for kraken test... 18:37:52 INFO - 2015-11-02 18:37:52,175 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpWjgbbE/profile http://localhost:49280/getInfo.html 18:37:54 INFO - 2015-11-02 18:37:54,309 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:37:54 INFO - 2015-11-02 18:37:54,309 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:37:54 INFO - 2015-11-02 18:37:54,310 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:37:54 INFO - 2015-11-02 18:37:54,310 DEBUG : BROWSER_OUTPUT: __metrics 18:37:54 INFO - 2015-11-02 18:37:54,325 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:37:55 INFO - 2015-11-02 18:37:55,010 INFO : Browser initialized. 18:37:55 INFO - 2015-11-02 18:37:55,010 INFO : Running cycle 1/1 for kraken test... 18:37:55 INFO - 2015-11-02 18:37:55,010 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpWjgbbE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:38:06 INFO - 2015-11-02 18:38:06,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 199827456 18:38:06 INFO - 2015-11-02 18:38:06,811 DEBUG : BROWSER_OUTPUT: 18:38:09 INFO - 2015-11-02 18:38:09,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:09 INFO - 2015-11-02 18:38:09,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 264245248 18:38:09 INFO - 2015-11-02 18:38:09,960 DEBUG : BROWSER_OUTPUT: 18:38:12 INFO - 2015-11-02 18:38:12,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 18:38:13 INFO - 2015-11-02 18:38:13,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 276807680 18:38:13 INFO - 2015-11-02 18:38:13,128 DEBUG : BROWSER_OUTPUT: 18:38:15 INFO - 2015-11-02 18:38:15,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 18:38:16 INFO - 2015-11-02 18:38:16,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 265105408 18:38:16 INFO - 2015-11-02 18:38:16,520 DEBUG : BROWSER_OUTPUT: 18:38:18 INFO - 2015-11-02 18:38:18,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 18:38:19 INFO - 2015-11-02 18:38:19,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 266104832 18:38:19 INFO - 2015-11-02 18:38:19,144 DEBUG : BROWSER_OUTPUT: 18:38:21 INFO - 2015-11-02 18:38:21,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:21 INFO - 2015-11-02 18:38:21,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 264933376 18:38:21 INFO - 2015-11-02 18:38:21,879 DEBUG : BROWSER_OUTPUT: 18:38:24 INFO - 2015-11-02 18:38:24,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:25 INFO - 2015-11-02 18:38:25,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 264499200 18:38:25 INFO - 2015-11-02 18:38:25,498 DEBUG : BROWSER_OUTPUT: 18:38:28 INFO - 2015-11-02 18:38:28,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:29 INFO - 2015-11-02 18:38:29,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 266854400 18:38:29 INFO - 2015-11-02 18:38:29,190 DEBUG : BROWSER_OUTPUT: 18:38:32 INFO - 2015-11-02 18:38:32,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 18:38:32 INFO - 2015-11-02 18:38:32,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 267100160 18:38:32 INFO - 2015-11-02 18:38:32,597 DEBUG : BROWSER_OUTPUT: 18:38:34 INFO - 2015-11-02 18:38:34,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:34 INFO - 2015-11-02 18:38:34,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 299196416 18:38:34 INFO - 2015-11-02 18:38:34,755 DEBUG : BROWSER_OUTPUT: 18:38:36 INFO - 2015-11-02 18:38:36,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:37 INFO - 2015-11-02 18:38:37,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 301441024 18:38:37 INFO - 2015-11-02 18:38:37,182 DEBUG : BROWSER_OUTPUT: 18:38:39 INFO - 2015-11-02 18:38:39,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:39 INFO - 2015-11-02 18:38:39,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 306978816 18:38:39 INFO - 2015-11-02 18:38:39,802 DEBUG : BROWSER_OUTPUT: 18:38:42 INFO - 2015-11-02 18:38:42,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:42 INFO - 2015-11-02 18:38:42,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 310099968 18:38:42 INFO - 2015-11-02 18:38:42,870 DEBUG : BROWSER_OUTPUT: 18:38:45 INFO - 2015-11-02 18:38:45,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:45 INFO - 2015-11-02 18:38:45,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 307331072 18:38:45 INFO - 2015-11-02 18:38:45,981 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 18:38:47 INFO - 2015-11-02 18:38:47,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 367394816 18:38:47 INFO - 2015-11-02 18:38:47,934 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;102;106;110;109;99;108;97;107 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;126;156;149;125;145;123;155;150;124 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;160;160;160;161;161;161;161 18:38:47 INFO - 2015-11-02 18:38:47,936 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;82;77;119;66;68;68;69;130;66 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;98;133;88;88;90;123;87;86;124 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;120;114;120;120;120;120;120;120;113 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;124;124;124;124;124;124;124;124;124 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;100;101;101;100;100;100;100;100;100 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;61;62;61;61;62;61;70;56;56 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;67;68;67;67;67;66;67;67 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;81;83;82;81;81;82;83;86 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;121;125;115;125;121;120;117;119;118 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;142;141;141;144;146;143;144;142;144 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;67;68;69;67;67;67;68 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,874 18:38:47 INFO - 2015-11-02 18:38:47,937 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:38:47 INFO - 2015-11-02 18:38:47,938 DEBUG : BROWSER_OUTPUT: __startTimestamp1446518327935__endTimestamp 18:38:47 INFO - 2015-11-02 18:38:47,938 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.50 Median:109.00 stddev:4.55 (4.2%) stddev-sans-first:4.74 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 102.0 106.0 110.0 109.0 99.0 108.0 97.0 107.0 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.40 Median:149.50 stddev:14.03 (9.4%) stddev-sans-first:14.35 18:38:47 INFO - 2015-11-02 18:38:47,941 DEBUG : BROWSER_OUTPUT: Values: 151.0 126.0 156.0 149.0 125.0 145.0 123.0 155.0 150.0 124.0 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 160.0 160.0 160.0 161.0 161.0 161.0 161.0 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:68.50 stddev:23.06 (33.7%) stddev-sans-first:24.41 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: Values: 78.0 82.0 77.0 119.0 66.0 68.0 68.0 69.0 130.0 66.0 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.60 Median:88.00 stddev:18.03 (20.5%) stddev-sans-first:19.10 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: Values: 99.0 98.0 133.0 88.0 88.0 90.0 123.0 87.0 86.0 124.0 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:120.00 stddev:2.75 (2.3%) stddev-sans-first:2.88 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 114.0 120.0 120.0 120.0 120.0 120.0 120.0 113.0 18:38:47 INFO - 2015-11-02 18:38:47,942 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.00 Median:124.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.20 Median:100.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: Values: 100.0 100.0 101.0 101.0 100.0 100.0 100.0 100.0 100.0 100.0 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:3.97 (6.5%) stddev-sans-first:4.08 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: Values: 58.0 61.0 62.0 61.0 61.0 62.0 61.0 70.0 56.0 56.0 18:38:47 INFO - 2015-11-02 18:38:47,943 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 68.0 67.0 67.0 67.0 66.0 67.0 67.0 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.70 (2.1%) stddev-sans-first:1.64 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 81.0 83.0 82.0 81.0 81.0 82.0 83.0 86.0 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,944 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.50 stddev:3.20 (2.7%) stddev-sans-first:3.37 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 125.0 115.0 125.0 121.0 120.0 117.0 119.0 118.0 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:143.50 stddev:1.56 (1.1%) stddev-sans-first:1.66 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: Values: 143.0 142.0 141.0 141.0 144.0 146.0 143.0 144.0 142.0 144.0 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 67.0 68.0 69.0 67.0 67.0 67.0 68.0 18:38:47 INFO - 2015-11-02 18:38:47,945 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:38:47 INFO - 2015-11-02 18:38:47,946 DEBUG : BROWSER_OUTPUT: 18:38:48 INFO - 2015-11-02 18:38:48,552 INFO : Browser exited with error code: 0 18:38:48 INFO - 2015-11-02 18:38:48,599 INFO : Completed test kraken (00:00:56) 18:38:48 INFO - 2015-11-02 18:38:48,600 INFO : Starting test v8_7 18:38:48 INFO - 2015-11-02 18:38:48,600 DEBUG : operating with platform_type : mac_ 18:38:48 INFO - 2015-11-02 18:38:48,600 INFO : Initialising browser for v8_7 test... 18:38:48 INFO - 2015-11-02 18:38:48,613 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpuqHQff/profile http://localhost:49280/getInfo.html 18:38:50 INFO - 2015-11-02 18:38:50,675 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:38:50 INFO - 2015-11-02 18:38:50,675 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:38:50 INFO - 2015-11-02 18:38:50,676 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:38:50 INFO - 2015-11-02 18:38:50,676 DEBUG : BROWSER_OUTPUT: __metrics 18:38:50 INFO - 2015-11-02 18:38:50,696 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:51 INFO - 2015-11-02 18:38:51,369 INFO : Browser initialized. 18:38:51 INFO - 2015-11-02 18:38:51,370 INFO : Running cycle 1/1 for v8_7 test... 18:38:51 INFO - 2015-11-02 18:38:51,370 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpuqHQff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:03 INFO - 2015-11-02 18:39:03,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 200249344 18:39:03 INFO - 2015-11-02 18:39:03,193 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/v8_7/run.html (next: http://localhost:49280/tests/v8_7/run.html) 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 522031104 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:39:24 INFO - 2015-11-02 18:39:24,862 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.22256039566292 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.0975292587776 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5731.428571428572 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1016.260162601626 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |5;Earley;669.3440428380187 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |7;RegExp;29171.428571428572 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |8;Splay;579.0387955993051 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: __startTimestamp1446518364859__endTimestamp 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:39:24 INFO - 2015-11-02 18:39:24,863 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: Values: 165.8 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: Values: 190.2 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.10 Median:325.10 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: Values: 325.1 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,864 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5731.43 Median:5731.43 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: Values: 5731.4 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1016.26 Median:1016.26 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: Values: 1016.3 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:669.34 Median:669.34 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: Values: 669.3 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: Values: 12256.1 18:39:24 INFO - 2015-11-02 18:39:24,865 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29171.43 Median:29171.43 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: Values: 29171.4 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:579.04 Median:579.04 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: Values: 579.0 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: Values: 5797.7 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:39:24 INFO - 2015-11-02 18:39:24,866 DEBUG : BROWSER_OUTPUT: 18:39:25 INFO - 2015-11-02 18:39:25,504 INFO : Browser exited with error code: 0 18:39:25 INFO - 2015-11-02 18:39:25,524 INFO : Completed test v8_7 (00:00:36) 18:39:25 INFO - 2015-11-02 18:39:25,538 INFO : Completed test suite (00:20:08) 18:39:25 INFO - 2015-11-02 18:39:25,539 DEBUG : Working with test: dromaeo_css 18:39:25 INFO - 2015-11-02 18:39:25,539 DEBUG : Generating results file: dromaeo_css 18:39:25 INFO - 2015-11-02 18:39:25,539 DEBUG : Working with test: kraken 18:39:25 INFO - 2015-11-02 18:39:25,540 DEBUG : Generating results file: kraken 18:39:25 INFO - 2015-11-02 18:39:25,540 INFO : javascript benchmark 18:39:25 INFO - 2015-11-02 18:39:25,540 DEBUG : Working with test: v8_7 18:39:25 INFO - 2015-11-02 18:39:25,540 DEBUG : Generating results file: v8_7 18:39:25 INFO - 2015-11-02 18:39:25,540 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:25 INFO - 2015-11-02 18:39:25,597 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 18:39:25 INFO - 2015-11-02 18:39:25,597 DEBUG : process_Request line: dromaeo_css 6856.68 graph.html#tests=[[72,52,55]] 18:39:25 INFO - 2015-11-02 18:39:25,597 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:25 INFO - 2015-11-02 18:39:25,629 DEBUG : process_Request line: kraken 1473.30 graph.html#tests=[[232,52,55]] 18:39:25 INFO - 2015-11-02 18:39:25,629 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:25 INFO - 2015-11-02 18:39:25,666 DEBUG : process_Request line: v8_7 20490.64 graph.html#tests=[[230,52,55]] 18:39:25 INFO - 2015-11-02 18:39:25,667 INFO : javascript benchmark 18:39:25 INFO - 2015-11-02 18:39:25,669 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [338.46860429126264, 354.4169840612193, 360.065629690952, 362.6138162856559, 364.7428562863181, 15057.0, 15205.543833685007, 17814.732779008325, 17992.910035449822, 18622.81377186228, 12416.130870839022, 12733.172343797647, 15604.609884752887, 18781.812181878176, 18821.929587745337, 4546.681732278734, 4650.558196971282, 4655.185342565038, 4655.324977878206, 4659.161350956826, 3675.356812557805, 3756.417755247941, 4602.355670206174, 4807.399075115611, 4935.407751069876, 4967.155583550805, 4980.0, 4980.551750342468, 4989.550940415362, 4990.351254336932, 4867.391576053011, 4989.3513843200335, 5009.824656137018, 5014.172661510846, 5018.5232402921665, 4273.914521709579, 4274.252005898987, 4274.487061552602, 4288.678349123828, 4292.0772034012525, 13563.864361356358, 13720.313984300845, 14112.153270803681, 14117.64705882351, 14119.85880141206, 1736.3835838277355, 1746.737989301615, 1944.7569053868267, 1952.3069310394746, 1961.7547806524185, 10145.797084058277, 10185.490725463696, 10362.948185259102, 10364.533595988123, 10498.79002419955, 1626.4470080172798, 1628.4300494826834, 1639.114877965897, 1652.6446813934942, 1664.3342662934801, 59672.403275967554, 60122.791404601696, 62851.37148628501, 63200.0, 63202.0, 6739.797806065826, 6833.3166683332265, 6931.376176144171, 6976.0, 6992.650367481708, 7923.16806735296, 8013.6794528218215, 8033.1163572007035, 8038.598070096472, 8044.195580442026, 5728.856778580485, 5800.9419905800405, 5801.6519008859605, 5828.795992140254, 5842.036064049469, 5867.706614669335, 5921.703914804242, 6090.756369745249, 6125.908111378333, 6173.81478555644, 2913.0969399486225, 3105.9844700776353, 3119.407312610597, 3129.4523458394688, 3147.118806734118, 1088.4815682123551, 1099.6591056772427, 1105.5467258424007, 1116.0736588631416, 1140.663504266227, 444.6242924728599, 446.32604766802365, 467.632908167094, 469.9342092107108, 473.93601863747955, 10582.470876456146, 11226.101911847032, 11481.196316257949, 12026.27842329463, 12116.333601651993, 478.8371953535815, 482.45482604656513, 483.29439019031906, 487.26666367117264, 511.59583928696657, 6464.709088091047, 6669.299723529057, 6690.632015239111, 6696.06255124283, 6744.527883048139, 619784.0, 653816.0, 655750.0, 656260.0, 660756.0, 75583.62208189034, 76302.61848690832, 76712.23287767051, 76999.61500192463, 78214.60892695613, 525.5401523666792, 530.8540151458303, 530.8619758862646, 531.6650510178563, 532.4249810205047, 11331.886681133083, 11399.08807295431, 11578.189526733047, 11611.361375124448, 11618.825717614074, 36343.27313453769, 36917.26165476729, 36943.63056369509, 37331.0, 37573.0, 49215.26177107275, 49245.75377123091, 49603.50396495989, 50071.499285006685, 50989.745051274505, 6542.0, 6664.666766661744, 6670.266270710121, 6675.0, 6691.364320389555, 12236.69408264765, 12273.938630306791, 12585.93707031459, 12591.93704031474, 12639.431225595054, 10633.468326583794, 10636.89363106359, 10795.514201861091, 10820.621278255223, 10981.231313807957, 10035.14701250402, 10489.475526223505, 10575.841362379724, 10606.946965265124, 10774.299670521392, 8222.465539739898, 8740.125987401208, 8749.956250218707, 10648.740503798543, 10879.45602719845, 6500.252470965899, 6553.5084868634085, 6556.8360790978695, 6623.304553022056, 6629.7348106075215, 10214.693559193236, 10566.788664226826, 10681.19891008193, 10782.08352290064, 10821.891781082088], "dojo.html": [3226.1934516370907, 3309.619393769716, 3320.950185747213, 3334.4998250262443, 3347.732181425486, 5578.693171875545, 5581.246531718217, 5589.608727389084, 5597.412271711472, 5601.551875849932, 5481.068218402871, 5562.805301814437, 5589.972050139743, 5596.944030559694, 5621.241132447119, 5004.8999020019755, 5131.153359695646, 5179.197224430201, 5184.351956005499, 5252.6323157379, 5150.562202212816, 5190.844274671766, 5205.349331333583, 5267.0, 5291.656042357254, 5146.691198528081, 5162.716050617215, 5182.974085129569, 5183.974080129594, 5229.7385130743505, 5121.641485096045, 5224.843254702365, 5359.115745901902, 5367.624266301322, 5448.318960129984, 5338.46615338463, 5355.3305836770405, 5369.81205657804, 5385.138377859524, 5386.78452861885, 5357.624966252364, 5496.31296087989, 5634.830955071355, 5719.370869204384, 5729.5702822288495, 5803.071508558653, 5847.239858818369, 5863.58954873159, 5885.941140588582, 5897.498712609433, 6058.1518587397795, 6130.233720784902, 6138.60099093562, 6143.262808463013, 6200.038993955944, 5404.108322126884, 5495.780168793203, 5523.392426833045, 5722.599418040739, 5790.073588225906, 6098.69506524672, 6127.234095738033, 6156.415140561639, 6158.04550294705, 6227.06594010902, 5841.591088623755, 5879.52963762898, 5889.5877288590245, 5953.1367951647635, 5980.102984552265, 5764.5676574257095, 5950.553708471882, 5952.970235148797, 6003.459688628044, 6109.633421994695, 5788.0, 5914.615549989237, 5919.881602367928, 5953.9878220702585, 5973.044312909914, 5910.113482977587, 5923.940760592425, 5932.139839723216, 5965.55258355625, 6003.0, 4441.511433742286, 4532.229520981441, 4627.907441851212, 4660.997885454643, 4661.137689527448, 4247.362895565628, 4249.383839343278, 4263.445752052214, 4267.466566679165, 4329.1341731653165, 5715.399883012307, 5724.599278050579, 5766.913496297559, 5779.988502012131, 5811.360750317462, 5699.658020518782, 5827.88344233113, 5861.794837180678, 5909.763609455574, 6218.378162183836, 5637.23897273871, 5735.1684005818925, 5747.5689323300085, 5751.22358481608, 5831.3877042910735, 5391.137418013099, 5406.486383793612, 5408.891822163535, 5441.564674826004, 5448.318960129984, 5754.971225143931, 5822.883542329045, 5868.061110222344, 6001.549883758648, 6181.876362472725, 6102.046825947346, 6116.5718399711595, 6116.571839971337, 6139.785107521216, 6145.29037144807, 6129.601575897553, 6142.201513803177, 6178.876422471615, 6204.255489341127, 6245.594036387621, 5657.12314591239, 5777.45114214149, 5857.882842343214, 5898.8230353089475, 6046.1535385045245, 5978.730957106854, 6108.664023478751, 6131.264248290056, 6163.137160797402, 6167.167432396748, 5895.086261629454, 5903.321118071477, 5981.222441082806, 5982.49148822355, 6011.519078473799, 5667.40492248308, 5686.147077938343, 5735.340435849764, 5804.564657650778, 5919.526437885045, 5656.85857853557, 5704.657720536781, 5704.828855134353, 5722.198892155018, 5756.7409466574945, 5814.709264536841, 5834.27071616048, 5847.8245652630485, 5848.2689663792025, 5863.501602363847, 5532.612717109763, 5592.077307244259, 5657.915131272952, 5708.372079071216, 5725.141228815711], "mootools.html": [1376.4700590272741, 1744.2761254079558, 1810.7696265658703, 1846.8060853610361, 1875.4467432107526, 7146.249643787399, 7478.214787447321, 7561.432892533055, 7575.242475752422, 7586.393088552916, 7291.0, 7489.588072656002, 7499.662515186816, 7501.324880760731, 7514.3237108660205, 2198.692183094368, 2212.0, 2215.9335219943428, 2216.645336746121, 2216.833737469688, 2191.7041199438113, 2213.0483891926465, 2227.6435770276757, 2228.0864845413385, 2234.832387570939, 2184.4975655599224, 2210.491586935006, 2216.5345277491747, 2227.6213043782514, 2230.609643312422, 2178.3900507857825, 2198.5822693688147, 2206.6248737714627, 2214.1032881682945, 2217.5454031923496, 2232.598132336179, 2243.921462748796, 2244.012634440841, 2246.33733048751, 2251.3358559225067, 7108.502404831664, 7364.079490063742, 7391.260873912565, 7444.404447644176, 7450.85098298031, 4439.356293337448, 4698.3187437821325, 4706.3411122442885, 4711.316859055418, 4716.339712440261, 2763.6821765497025, 2840.4461130079644, 2853.7288957549, 2872.2532141643323, 2875.7411832934927, 836.2348451167236, 841.3899922556097, 842.5492361586522, 843.439112989861, 854.9786255343604, 10595.84106238407, 10668.62659806903, 10683.46582670871, 10691.0, 10705.518251678694, 4399.890002749957, 4411.272140096912, 4447.177272204653, 4455.22033644111, 4482.372467854503, 9343.34596578233, 9417.152456278967, 9424.811503770023, 9437.339386243035, 9463.76340591477, 4978.925316120261, 4989.501049894981, 4999.800007999712, 5000.499950004971, 5012.874678133076, 4515.277555591089, 4567.269236922143, 4571.245744452128, 4573.382593349856, 4582.702124361906, 3599.6681227945305, 3639.94540081899, 3641.2353405785084, 3647.215848592565, 3691.224842782992, 1133.7109037195462, 1165.8076417391205, 1170.104869774623, 1173.3957012138756, 1177.9222011859054, 1100.5047728522197, 1133.1388145009853, 1231.1382032577233, 1338.1903948111253, 1356.6879617687987, 7647.120581133129, 7664.540127592362, 7677.23227677239, 7746.535207887545, 7747.38020958322, 1085.039739830256, 1103.2828661370174, 1177.2759752752168, 1186.5016692988966, 1187.7825229140028, 5565.0817615093865, 6040.516758659297, 6070.7875224366935, 6123.357047510036, 6139.26328840542, 8343.332533397313, 9031.27749780016, 9257.398269112486, 9264.073592640681, 9281.814363712689, 9207.355485115977, 9318.30112741547, 9353.719388418358, 9477.526123693788, 9503.19222866064, 7550.320471157622, 7632.847343053108, 7640.083190017233, 7652.69389224436, 7654.885176722353, 7087.220405755466, 7130.572165670076, 7171.713131474683, 7183.20984691694, 7255.528390654802, 7842.803929901798, 7916.881246781418, 7923.960380198062, 7925.128235894163, 8341.916580834113, 8311.833763324821, 8432.409731318994, 8434.536100514286, 8443.113473085483, 8795.956020219857, 7676.692932282646, 7720.922790772021, 7722.266384693445, 7760.495567788075, 7764.107127680389, 7663.846723065619, 7708.997830282027, 7738.303552680286, 7770.300672939463, 7797.025371828521, 7006.194287656781, 7011.3339232772805, 7104.076470058859, 7215.2063273038875, 7279.381252593589, 7042.471814614027, 7048.718051277891, 7108.07595012645, 7212.459065570209, 7235.529690570306, 7309.597972111585, 7356.595387253538, 7388.556686598821, 7392.667329970057, 7398.852022959403, 6571.408573228432, 6600.53796234259, 6616.636085015371, 6650.866982660223, 6658.034584985053, 6772.288909664611, 6802.897956530755, 6829.4877884157895, 6848.623325717133, 6854.246032936473], "ext.html": [545.690691272826, 583.4894467341077, 587.4331270324137, 592.7569696424467, 595.2737660054734, 33623.15942101449, 38864.80567597161, 39073.0, 39102.41346379807, 39144.41283380752, 43839.78080109595, 44523.0, 44594.0, 44641.0, 44658.77670611643, 8813.515256660914, 9007.774805629846, 9460.999999999984, 9707.029297070272, 11132.833007504894, 11403.771924561504, 11433.028192603639, 11472.196946213768, 11492.42537873103, 11524.481398337095, 11425.42872856358, 11531.769364612745, 11578.710532236677, 11580.884191158066, 11594.362310072942, 9181.678641247558, 9377.953110234439, 11641.18511704181, 11818.290902545874, 11897.345645989468, 11229.831552526719, 11331.03686186675, 11336.659900203007, 11372.03337716295, 11408.771824563462, 41117.38323925144, 41468.0, 41604.37593436101, 41606.0, 41632.37551436731, 3064.2033071401374, 3121.5161649944293, 3319.0, 3363.4954756786433, 3462.7576069675133, 28496.430071398456, 28631.713682863112, 29229.70770292291, 29291.414171716446, 29378.8522530069, 2419.2742177346727, 2468.9135880244107, 2491.9626205606933, 2509.2723110297993, 2572.9485410291877, 286186.0, 286274.0, 286508.0, 286941.0, 287250.0, 56614.7169264151, 58368.124478132864, 65321.67339163369, 74125.0, 75294.24705752982, 66915.0, 67457.66271168711, 67684.93890366594, 67732.66133669399, 67743.66128169328, 18458.81541184598, 18647.81352186461, 18665.533361665795, 18674.813251867577, 18675.813241867407, 14039.85960140406, 14112.153270803785, 14161.645958850904, 14182.0, 14217.85782142186, 21043.0, 21093.894530527556, 21270.042848071873, 21343.25298614541, 21399.46501337448, 8484.490930544187, 8673.436226645248, 8751.606177722018, 8836.734897953073, 8889.555522223864, 920.3557509743073, 960.7357976556364, 1007.5717819926502, 1049.223574554824, 1091.8525998990194, 30404.239894002385, 30414.0, 30416.0, 30432.087037388912, 30597.0, 1026.1175389165312, 1103.1175059952006, 1103.266327891959, 1136.6817291158488, 1201.483362154282, 15852.365905363657, 16438.260278287507, 16469.0, 16592.917035414746, 16672.916635416987, 347500.0, 355738.0, 356133.0, 356595.0, 356794.0, 50858.237126443135, 51555.74222128865, 59427.0, 63060.0, 63569.68215158987, 1436.5259464376732, 1453.6075259679826, 1469.992650036743, 1470.4485817818104, 1474.9410023598937, 26339.341516462242, 28510.65954366136, 29994.550081748355, 30560.694393055786, 30649.387012260075, 53081.20378194253, 53523.0, 53540.0, 53638.0, 53694.0, 271466.0, 273023.0, 273464.0, 273792.0, 273881.0, 33396.165095871824, 34158.65841341555, 34226.0, 34232.657673422946, 34271.0, 43643.345349819145, 43827.561724383624, 43881.0, 43884.341734873364, 44296.55703442924, 36624.45063323999, 37098.8145059273, 37585.2482950334, 37843.81078094592, 38107.618923810405, 37095.814520927226, 37236.06909827276, 37577.59635920946, 37593.87218383453, 37939.430908536946, 37712.81143594265, 38294.2341153181, 38669.806650967694, 38766.2246755069, 38770.6122938767, 29510.262243444085, 31260.843695781376, 31404.371912561164, 31435.214119647193, 31508.527372088978, 24126.75873241245, 25537.23388298354, 26670.0, 26761.44866806299, 27073.59389609118], "prototype.html": [307.1905528931266, 316.9381970515749, 318.4411358066593, 318.87563850098456, 323.0309072781655, 6060.1212824140475, 6109.083637454384, 6173.228346456693, 6293.653849038301, 6294.9999999999945, 6030.457258846703, 6124.448799608045, 6164.938350616492, 6169.845753856156, 6173.197484327043, 4558.293464513005, 4648.930266046012, 4707.05858828234, 4715.575598196162, 4725.740084295362, 4660.883477913046, 4716.316134160545, 4744.786484608184, 4745.810167593292, 4747.1929771938685, 4644.9535504644855, 4656.208444564432, 4666.743329116897, 4680.976595117019, 4703.059388122372, 4657.534246575349, 4678.976605116953, 4687.250039993619, 4689.835855745049, 4694.201985662446, 3905.9218815623813, 3991.102002049545, 4003.559608443069, 4009.158076803875, 4018.959810401888, 5979.701014949279, 5985.880282394328, 5995.7901473448655, 5998.7600495980105, 6040.607360521596, 5195.662281951699, 5195.9480405195845, 5201.375834899798, 5202.08963431398, 5217.713025783581, 6157.692115394212, 6287.245530536319, 6293.653849038301, 6383.234011918599, 6412.39082287182, 4213.726107803013, 4220.767857767822, 4229.78851057449, 4235.978820105911, 4245.596668316505, 6626.138601981712, 6682.264950855402, 6697.464202863759, 6699.296573859772, 6709.664516774142, 4183.5398106208295, 4290.764007979591, 4298.914021719548, 4306.354046892991, 4306.375575541529, 4416.580424859633, 4418.293073108352, 4419.469663640384, 4420.381146639473, 4426.336049592587, 5179.7928082877015, 5188.299579556787, 5193.870153246199, 5197.7141257231215, 5202.739863006835, 6481.513886458534, 6481.805545833632, 6506.284308726036, 6507.381798729113, 6530.60816351011, 1586.3813112885985, 1608.332541995059, 1610.1627153880152, 1613.3869129730626, 1637.3777964373462, 1032.5250384822916, 1070.0583486531957, 1077.8922107789315, 1078.7357097511003, 1093.9562417503212, 6176.413240742122, 6202.317745048041, 6205.627662340274, 6222.968885155546, 6230.034344676583, 6644.036614690939, 6644.767433139914, 6647.634380109141, 6648.335166483313, 6648.601083934979, 6123.632582045091, 6257.2804127525915, 6270.592411493239, 6273.65494897785, 6281.96859015702, 3686.4470329450796, 3728.55257369112, 3733.104055026774, 3733.328000959799, 3749.1564398010228, 6819.556728812611, 6838.042674025641, 6839.076724642209, 6840.213375461885, 6868.896966545406, 6891.931080689129, 6899.517033807686, 6907.792766217021, 6909.239983601799, 6923.4807389446, 6639.336066393322, 6747.797566073025, 6839.658017099126, 6869.244383117853, 6895.172579290517, 6655.767048153291, 6686.53194276396, 6716.1604799400075, 6733.797986060426, 6739.6967136478, 6534.444572211225, 6566.573172743756, 6580.638064906476, 6581.045748366364, 6595.373439523238, 6637.502187335873, 6769.864602708017, 6781.152355955505, 6793.320667933167, 6798.93201067983, 4227.725197862129, 4258.723182993095, 4268.381084742757, 4277.2087163874785, 4300.053988122608, 6787.626680532618, 6794.252632210354, 6806.115205023315, 6823.965880170567, 6836.5214434989075, 6382.329855365306, 6558.1802274715665, 6564.376384243489, 6571.80284591463, 6612.768553100618, 6576.736930522917, 6585.440237579859, 6591.6374599397495, 6596.571222870498, 6599.175103112111, 6416.069669897745, 6424.357564243725, 6440.420362167428, 6444.709988050643, 6448.451881590117, 6403.8719225614295, 6589.967050164719, 6596.208454985433, 6598.90101648466, 6599.0, 6457.257415397289, 6483.157189565326, 6486.481081513562, 6494.64279464634, 6521.576097553644], "yui.html": [669.9397054265115, 696.9442444604431, 718.96405179741, 720.1789959446236, 756.3344257053793, 14431.556844315563, 14500.999999999987, 14753.11481311122, 14756.999999999987, 14771.113733176016, 13661.0, 13751.243681597509, 13766.24285664288, 13799.93100034501, 13800.585982420544, 743.3867059675762, 754.9018627578407, 924.089771574998, 929.372673445425, 951.3816019587255, 928.9349745517817, 929.5677509957868, 940.47333493244, 940.952952352383, 941.3316545252878, 984.5372674842812, 995.0944640377259, 995.6266400099962, 995.8157740817971, 996.3523709588753, 779.283059585183, 789.9131095579481, 959.5873774277059, 976.4873441443228, 978.8629591857145, 725.1986554856912, 725.2855936902147, 725.3471875312208, 725.5102805606194, 725.8657148427558, 14565.0, 14703.19132447715, 14709.190994495299, 14717.969742118055, 14726.33731482086, 12229.327386993711, 12565.0, 12580.811287830598, 12809.231446113263, 12935.805962910565, 9634.9518252409, 9851.113399793981, 9860.370098573976, 10089.596416143346, 10625.628103016357, 3329.8501567429525, 3409.2840503494294, 3470.6529347065343, 3483.7213022958103, 3487.494313324554, 50605.746971265275, 51132.48867511352, 51462.74268628633, 51815.0, 51844.740776296254, 9080.591373388213, 9447.897188149522, 9479.383840050376, 9520.0, 9527.142557169887, 19748.210071596975, 19877.204911803365, 19905.900470497556, 19916.800831991495, 20024.39926802198, 7196.280371962762, 7378.631068446556, 7406.666699998405, 7450.776476705708, 7473.439492038119, 3886.7279290449396, 3967.3255546557157, 4019.2966230909474, 4025.1547175092974, 4027.6979226558124, 3032.6815684353264, 3050.176452357851, 3077.5999120114243, 3079.1070589528786, 3089.3203495231014, 448.89002194462563, 451.7154192858478, 453.76857802520954, 454.4977799531536, 458.8531669865611, 544.3087279155451, 546.6392181160495, 576.4466112531933, 598.6109029131013, 621.8041316985226, 6999.790006299819, 7568.205338439495, 7693.884591731128, 7839.333656639135, 7849.175836537195, 527.6016607461343, 570.2273419516496, 587.1926101610286, 604.2326245667977, 606.9757209711651, 3767.811609419518, 3801.201747632973, 4093.672506199497, 4135.0, 4218.535961044283, 59873.0, 59937.100943485886, 59939.100913486334, 60186.0, 60233.69883150644, 49009.50990490049, 50216.0, 50584.49415505872, 50736.49263507391, 51039.489605103474, 43297.0, 43516.3472547912, 45282.0, 47322.763386183535, 48222.27666585004, 8249.752507424786, 8405.915940840758, 8565.61454734526, 8593.097724738813, 8803.603837827184, 32638.0, 33866.49200261949, 35348.82325588356, 35828.283434330646, 37878.62121378751, 48440.5155948436, 49096.0, 49407.75296123496, 49650.0, 50008.249876252616, 7994.2805147537, 7995.480293780885, 8173.18268173178, 8348.165183481604, 8548.529830859114, 11155.81783500241, 11498.195126341076, 11649.242799218024, 11925.045996320447, 12240.877591223974, 10292.228082893664, 10375.533101010322, 10542.10392116648, 11094.611688590861, 11109.555617775522, 10722.839157412489, 10971.122310215003, 10981.61564345244, 11201.495932683212, 11684.70788230301, 10034.347767395097, 10047.145992590711, 10479.528421221215, 10499.107575856138, 10662.520186591777, 8385.0, 8890.06654301289, 8930.776730581787, 9082.863757043782, 9111.589978450853, 8612.741617751477, 9441.575129119068, 9490.810183796148, 9521.857172142561, 9676.85484717744]}, "summary": {"suite": 6856.68550142052, "subtests": {"jquery.html": {"filtered": 6963.416938507276, "value": 6963.416938507276}, "dojo.html": {"filtered": 5554.353049768241, "value": 5554.353049768241}, "mootools.html": {"filtered": 4518.333133159384, "value": 4518.333133159384}, "ext.html": {"filtered": 19748.02821197986, "value": 19748.02821197986}, "prototype.html": {"filtered": 4838.650165979522, "value": 4838.650165979522}, "yui.html": {"filtered": 6222.502984021742, "value": 6222.502984021742}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0006"}, "testrun": {"date": 1446517157, "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": "20151102152508", "branch": "Mozilla-Aurora", "revision": "cb41b90cd72f67ea8abda60551d1af6f79888c42"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 159.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0], "ai-astar": [108.0, 109.0, 102.0, 106.0, 110.0, 109.0, 99.0, 108.0, 97.0, 107.0], "imaging-gaussian-blur": [120.0, 120.0, 114.0, 120.0, 120.0, 120.0, 120.0, 120.0, 120.0, 113.0], "audio-beat-detection": [151.0, 126.0, 156.0, 149.0, 125.0, 145.0, 123.0, 155.0, 150.0, 124.0], "json-stringify-tinderbox": [66.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [143.0, 142.0, 141.0, 141.0, 144.0, 146.0, 143.0, 144.0, 142.0, 144.0], "json-parse-financial": [58.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 70.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 68.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0, 68.0], "audio-fft": [78.0, 82.0, 77.0, 119.0, 66.0, 68.0, 68.0, 69.0, 130.0, 66.0], "imaging-darkroom": [124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0], "stanford-crypto-ccm": [119.0, 121.0, 125.0, 115.0, 125.0, 121.0, 120.0, 117.0, 119.0, 118.0], "audio-oscillator": [99.0, 98.0, 133.0, 88.0, 88.0, 90.0, 123.0, 87.0, 86.0, 124.0], "stanford-crypto-aes": [80.0, 81.0, 81.0, 83.0, 82.0, 81.0, 81.0, 82.0, 83.0, 86.0], "imaging-desaturate": [100.0, 100.0, 101.0, 101.0, 100.0, 100.0, 100.0, 100.0, 100.0, 100.0]}, "summary": {"suite": 1473.3, "subtests": {"audio-fft": {"filtered": 82.3, "value": 82.3}, "stanford-crypto-pbkdf2": {"filtered": 143.0, "value": 143.0}, "audio-beat-detection": {"filtered": 140.4, "value": 140.4}, "stanford-crypto-ccm": {"filtered": 120.0, "value": 120.0}, "imaging-darkroom": {"filtered": 124.0, "value": 124.0}, "json-parse-financial": {"filtered": 60.8, "value": 60.8}, "audio-oscillator": {"filtered": 101.6, "value": 101.6}, "ai-astar": {"filtered": 105.5, "value": 105.5}, "audio-dft": {"filtered": 160.4, "value": 160.4}, "stanford-crypto-sha256-iterative": {"filtered": 67.6, "value": 67.6}, "json-stringify-tinderbox": {"filtered": 66.8, "value": 66.8}, "imaging-gaussian-blur": {"filtered": 118.7, "value": 118.7}, "stanford-crypto-aes": {"filtered": 82.0, "value": 82.0}, "imaging-desaturate": {"filtered": 100.2, "value": 100.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0006"}, "testrun": {"date": 1446517157, "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": "20151102152508", "branch": "Mozilla-Aurora", "revision": "cb41b90cd72f67ea8abda60551d1af6f79888c42"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.22256039566292], "Encrypt": [325.0975292587776], "NavierStokes": [5797.687861271676], "Decrypt": [5731.428571428572], "Splay": [579.0387955993051], "Richards": [165.80998176090202], "RegExp": [29171.428571428572], "Earley": [669.3440428380187], "Boyer": [12256.09756097561], "RayTrace": [1016.260162601626]}, "summary": {"suite": 20490.63512900831, "subtests": {"DeltaBlue": {"filtered": 347.58232600000014, "value": 347.58232600000014}, "Encrypt": {"filtered": 818.7727560000003, "value": 818.7727560000003}, "NavierStokes": {"filtered": 255.96410767696923, "value": 255.96410767696923}, "Decrypt": {"filtered": 46.44234795613162, "value": 46.44234795613162}, "Splay": {"filtered": 140.73495699999998, "value": 140.73495699999998}, "RegExp": {"filtered": 31.228672869735533, "value": 31.228672869735533}, "Richards": {"filtered": 212.90636200000006, "value": 212.90636200000006}, "Earley": {"filtered": 995.6957220000003, "value": 995.6957220000003}, "Boyer": {"filtered": 54.378075621890574, "value": 54.378075621890574}, "RayTrace": {"filtered": 728.149176, "value": 728.149176}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0006"}, "testrun": {"date": 1446517157, "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": "20151102152508", "branch": "Mozilla-Aurora", "revision": "cb41b90cd72f67ea8abda60551d1af6f79888c42"}}] 18:39:25 INFO - RETURN: dromaeo_css: 6856.68 18:39:25 INFO - RETURN: kraken: 1473.30 18:39:25 INFO - RETURN: v8_7: 20490.64 18:39:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20490.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1473.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6856.68"}}} 18:39:25 INFO - Return code: 0 18:39:25 INFO - # TBPL SUCCESS # 18:39:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:39:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:39:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:39:25 INFO - 2015-11-02 18:39:25.770 screenresolution[1662:9792] starting screenresolution argv=screenresolution get 18:39:25 INFO - 2015-11-02 18:39:25.774 screenresolution[1662:9792] Display 0: 1600x1200x32@60 18:39:25 INFO - 2015-11-02 18:39:25.780 screenresolution[1663:9795] starting screenresolution argv=screenresolution list 18:39:25 INFO - Available Modes on Display 0 18:39:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:39:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:39:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:39:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:39:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:39:26 INFO - Intel HD Graphics 3000: 18:39:26 INFO - Chipset Model: Intel HD Graphics 3000 18:39:26 INFO - Type: GPU 18:39:26 INFO - Bus: Built-In 18:39:26 INFO - VRAM (Total): 512 MB 18:39:26 INFO - VRAM (Dynamic, Max): 10 18:39:26 INFO - Vendor: Intel (0x8086) 18:39:26 INFO - Device ID: 0x0116 18:39:26 INFO - Revision ID: 0x0009 18:39:26 INFO - Displays: 18:39:26 INFO - Display: 18:39:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:39:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:39:26 INFO - Display Serial Number: 1600x1200 60 18:39:26 INFO - Main Display: Yes 18:39:26 INFO - Mirror: Off 18:39:26 INFO - Online: Yes 18:39:26 INFO - Rotation: Supported 18:39:26 INFO - Return code: 0 18:39:26 INFO - Running post-action listener: _resource_record_post_action 18:39:26 INFO - Running post-run listener: _resource_record_post_run 18:39:27 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 35561472; Write bytes: 686208000; Read time: 6511; Write time: 36913 18:39:27 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 337940992; Write bytes: 334913536; Read time: 33704; Write time: 6904 18:39:27 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 33615872; Write bytes: 340194304; Read time: 5628; Write time: 29667 18:39:27 INFO - Running post-run listener: _upload_blobber_files 18:39:27 INFO - Blob upload gear active. 18:39:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:39:27 INFO - Copying logs to upload dir... 18:39:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.908780 ========= master_lag: 1.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-02 18:39:28.559113) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 18:39:28.562929) ========= 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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010168 build_url: 'https://queue.taskcluster.net/v1/task/OqfqRtxQQQCintmoG-5jzg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 18:39:28.597400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:39:28.598056) ========= 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.8L7kS2PRPT/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.k0xfqLc6e6/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/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.005146 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 18:39:28.744790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 18:39:28.745163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 18:39:28.745588) ========= ========= Total master_lag: 1.70 =========