builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0003 starttime: 1448489675.0 results: success (0) buildid: 20151125131130 builduid: f9c161b428474296b798ce3812128b53 revision: 1f88b627ee6a78de1536beaab4b1a7c04a992806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:35.001608) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:35.002065) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:35.002344) ========= 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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.005781 basedir: '/builds/slave/test' ========= master_lag: 0.50 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:35.504074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:35.504348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:35.536138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-11-25 14:14:35.536424) ========= 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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.031538 ========= master_lag: 2.62 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-11-25 14:14:38.189685) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.190294) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.190724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.191023) ========= 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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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-25 14:14:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.15M=0.001s 2015-11-25 14:14:38 (9.15 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.265465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.473300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.473673) ========= 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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.138062 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.622879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:38.623190) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1f88b627ee6a78de1536beaab4b1a7c04a992806 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1f88b627ee6a78de1536beaab4b1a7c04a992806 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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-25 14:14:38,740 truncating revision to first 12 chars 2015-11-25 14:14:38,741 Setting DEBUG logging. 2015-11-25 14:14:38,741 attempt 1/10 2015-11-25 14:14:38,741 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1f88b627ee6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 14:14:39,002 unpacking tar archive at: mozilla-aurora-1f88b627ee6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:39.383934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:39.384253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:39.393430) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:39.394005) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 14:14:39.394490) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-25 14:14:39.394794) ========= /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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:14:39 INFO - MultiFileLogger online at 20151125 14:14:39 in /builds/slave/test 14:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:14:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:39 INFO - {'append_to_log': False, 14:14:39 INFO - 'base_work_dir': '/builds/slave/test', 14:14:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:39 INFO - 'branch': 'Mozilla-Aurora', 14:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:39 INFO - 'config_files': ('talos/mac_config.py',), 14:14:39 INFO - 'default_actions': ('clobber', 14:14:39 INFO - 'read-buildbot-config', 14:14:39 INFO - 'download-and-extract', 14:14:39 INFO - 'populate-webroot', 14:14:39 INFO - 'create-virtualenv', 14:14:39 INFO - 'install', 14:14:39 INFO - 'run-tests'), 14:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:39 INFO - 'download_minidump_stackwalk': True, 14:14:39 INFO - 'download_symbols': 'ondemand', 14:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:39 INFO - 'installer_path': 'installer.exe', 14:14:39 INFO - 'log_level': 'info', 14:14:39 INFO - 'log_name': 'talos', 14:14:39 INFO - 'log_to_console': True, 14:14:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:14:39 INFO - 'opt_config_files': (), 14:14:39 INFO - 'pip_index': False, 14:14:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:14:39 INFO - 'cmd': ('bash', 14:14:39 INFO - '-c', 14:14:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:14:39 INFO - 'enabled': True, 14:14:39 INFO - 'halt_on_failure': False, 14:14:39 INFO - 'name': 'check_screen_resolution'},), 14:14:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:14:39 INFO - 'cmd': ('bash', 14:14:39 INFO - '-c', 14:14:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:14:39 INFO - 'enabled': True, 14:14:39 INFO - 'halt_on_failure': False, 14:14:39 INFO - 'name': 'check_screen_resolution'},), 14:14:39 INFO - 'run_cmd_checks_enabled': True, 14:14:39 INFO - 'sps_profile': False, 14:14:39 INFO - 'sps_profile_interval': 0, 14:14:39 INFO - 'suite': 'dromaeojs', 14:14:39 INFO - 'system_bits': '64', 14:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:39 INFO - 'title': 't-yosemite-r5-0003', 14:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:39 INFO - 'use_talos_json': True, 14:14:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:39 INFO - 'work_dir': 'build'} 14:14:39 INFO - ##### 14:14:39 INFO - ##### Running clobber step. 14:14:39 INFO - ##### 14:14:39 INFO - Running pre-action listener: _resource_record_pre_action 14:14:39 INFO - Running main action method: clobber 14:14:39 INFO - rmtree: /builds/slave/test/build 14:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:45 INFO - Running post-action listener: _resource_record_post_action 14:14:45 INFO - ##### 14:14:45 INFO - ##### Running read-buildbot-config step. 14:14:45 INFO - ##### 14:14:45 INFO - Running pre-action listener: _resource_record_pre_action 14:14:45 INFO - Running main action method: read_buildbot_config 14:14:45 INFO - Using buildbot properties: 14:14:45 INFO - { 14:14:45 INFO - "properties": { 14:14:45 INFO - "buildnumber": 439, 14:14:45 INFO - "product": "firefox", 14:14:45 INFO - "script_repo_revision": "production", 14:14:45 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 14:14:45 INFO - "repository": "", 14:14:45 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 14:14:45 INFO - "buildid": "20151125131130", 14:14:45 INFO - "slavename": "t-yosemite-r5-0003", 14:14:45 INFO - "pgo_build": "False", 14:14:45 INFO - "basedir": "/builds/slave/test", 14:14:45 INFO - "project": "", 14:14:45 INFO - "platform": "yosemite", 14:14:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:14:45 INFO - "slavebuilddir": "test", 14:14:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:14:45 INFO - "branch": "mozilla-aurora", 14:14:45 INFO - "repo_path": "releases/mozilla-aurora", 14:14:45 INFO - "stage_platform": "macosx64", 14:14:45 INFO - "builduid": "f9c161b428474296b798ce3812128b53", 14:14:45 INFO - "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806" 14:14:45 INFO - }, 14:14:45 INFO - "sourcestamp": { 14:14:45 INFO - "repository": "", 14:14:45 INFO - "hasPatch": false, 14:14:45 INFO - "project": "", 14:14:45 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:14:45 INFO - "changes": [ 14:14:45 INFO - { 14:14:45 INFO - "category": null, 14:14:45 INFO - "files": [ 14:14:45 INFO - { 14:14:45 INFO - "url": null, 14:14:45 INFO - "name": "https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 14:14:45 INFO - } 14:14:45 INFO - ], 14:14:45 INFO - "repository": "", 14:14:45 INFO - "rev": "1f88b627ee6a78de1536beaab4b1a7c04a992806", 14:14:45 INFO - "who": "georg.fritzsche@googlemail.com", 14:14:45 INFO - "when": 1448489642, 14:14:45 INFO - "number": 6707713, 14:14:45 INFO - "comments": "Bug 1227579 - Change the main about:healthreport URL to the v4 content. r=dexter, a=lizzard", 14:14:45 INFO - "project": "", 14:14:45 INFO - "at": "Wed 25 Nov 2015 14:14:02", 14:14:45 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:14:45 INFO - "revlink": "", 14:14:45 INFO - "properties": [ 14:14:45 INFO - [ 14:14:45 INFO - "buildid", 14:14:45 INFO - "20151125131130", 14:14:45 INFO - "Change" 14:14:45 INFO - ], 14:14:45 INFO - [ 14:14:45 INFO - "builduid", 14:14:45 INFO - "f9c161b428474296b798ce3812128b53", 14:14:45 INFO - "Change" 14:14:45 INFO - ], 14:14:45 INFO - [ 14:14:45 INFO - "pgo_build", 14:14:45 INFO - "False", 14:14:45 INFO - "Change" 14:14:45 INFO - ] 14:14:45 INFO - ], 14:14:45 INFO - "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806" 14:14:45 INFO - } 14:14:45 INFO - ], 14:14:45 INFO - "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806" 14:14:45 INFO - } 14:14:45 INFO - } 14:14:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 14:14:45 INFO - Running post-action listener: _resource_record_post_action 14:14:45 INFO - ##### 14:14:45 INFO - ##### Running download-and-extract step. 14:14:45 INFO - ##### 14:14:45 INFO - Running pre-action listener: _resource_record_pre_action 14:14:45 INFO - Running main action method: download_and_extract 14:14:45 INFO - mkdir: /builds/slave/test/build/tests 14:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:45 INFO - https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/test_packages.json 14:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/test_packages.json 14:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:14:45 INFO - Downloaded 1149 bytes. 14:14:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:14:45 INFO - Using the following test package requirements: 14:14:45 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:14:45 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 14:14:45 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'jsshell-mac.zip'], 14:14:45 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 14:14:45 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:14:45 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 14:14:45 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 14:14:45 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 14:14:45 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:14:45 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:14:45 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 14:14:45 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:45 INFO - https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:14:47 INFO - Downloaded 17448002 bytes. 14:14:47 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 14:14:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:14:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:14:52 INFO - Return code: 0 14:14: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 14:14: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')]} 14:14:52 INFO - https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:14:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:14:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:14:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:14:55 INFO - Downloaded 17448002 bytes. 14:14:55 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 14:14:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:14:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:15:00 INFO - Return code: 0 14:15: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')]} 14:15:00 INFO - https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:15:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:15:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:15:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:15:01 INFO - Downloaded 11131307 bytes. 14:15:01 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 14:15:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:15:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:15:02 INFO - Return code: 0 14:15:02 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')]} 14:15:02 INFO - https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 14:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:15:06 INFO - Downloaded 107808563 bytes. 14:15:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:15:06 INFO - mkdir: /builds/slave/test/properties 14:15:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:06 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:06 INFO - Contents: 14:15:06 INFO - build_url:https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:15:06 INFO - Running post-action listener: _resource_record_post_action 14:15:06 INFO - Running post-action listener: set_extra_try_arguments 14:15:06 INFO - ##### 14:15:06 INFO - ##### Running populate-webroot step. 14:15:06 INFO - ##### 14:15:06 INFO - Running pre-action listener: _resource_record_pre_action 14:15:06 INFO - Running main action method: populate_webroot 14:15:06 INFO - Guessing talos json url... 14:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:06 INFO - https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 14:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XE076HUcSHKebawwHdnxWQ/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 14:15:07 INFO - Downloaded 107 bytes. 14:15:07 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:15:07 INFO - Contents: 14:15:07 INFO - 20151125131130 14:15:07 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/1f88b627ee6a78de1536beaab4b1a7c04a992806 14:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:07 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1f88b627ee/testing/talos/talos.json 14:15:07 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1f88b627ee/testing/talos/talos.json to /builds/slave/test/build/talos.json 14:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1f88b627ee/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 14:15:07 INFO - Downloaded 4264 bytes. 14:15:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:15:07 INFO - '../fennec_ids.txt'], 14:15:07 INFO - 'tests': ['tcheck2']}, 14:15:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:07 INFO - '--tppagecycles', 14:15:07 INFO - '7'], 14:15:07 INFO - 'tests': ['tsvgm']}}, 14:15:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:15:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:15:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:15:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'tests': ['damp', 'tps']}, 14:15:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['damp', 'tps']}, 14:15:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:15:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:07 INFO - 'other': {'tests': ['a11yr', 14:15:07 INFO - 'ts_paint', 14:15:07 INFO - 'tpaint', 14:15:07 INFO - 'sessionrestore', 14:15:07 INFO - 'sessionrestore_no_auto_restore']}, 14:15:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['a11yr', 14:15:07 INFO - 'ts_paint', 14:15:07 INFO - 'tpaint', 14:15:07 INFO - 'sessionrestore', 14:15:07 INFO - 'sessionrestore_no_auto_restore']}, 14:15:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['a11yr', 14:15:07 INFO - 'ts_paint', 14:15:07 INFO - 'tpaint', 14:15:07 INFO - 'sessionrestore', 14:15:07 INFO - 'sessionrestore_no_auto_restore']}, 14:15:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['a11yr', 14:15:07 INFO - 'ts_paint', 14:15:07 INFO - 'tpaint', 14:15:07 INFO - 'sessionrestore', 14:15:07 INFO - 'sessionrestore_no_auto_restore']}, 14:15:07 INFO - 'other_l64': {'tests': ['a11yr', 14:15:07 INFO - 'ts_paint', 14:15:07 INFO - 'tpaint', 14:15:07 INFO - 'sessionrestore', 14:15:07 INFO - 'sessionrestore_no_auto_restore']}, 14:15:07 INFO - 'other_nol64': {'tests': ['a11yr', 14:15:07 INFO - 'ts_paint', 14:15:07 INFO - 'tpaint', 14:15:07 INFO - 'sessionrestore', 14:15:07 INFO - 'sessionrestore_no_auto_restore']}, 14:15:07 INFO - 'svgr': {'tests': ['tsvgx', 14:15:07 INFO - 'tsvgr_opacity', 14:15:07 INFO - 'tart', 14:15:07 INFO - 'tscrollx', 14:15:07 INFO - 'cart']}, 14:15:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['tsvgx', 14:15:07 INFO - 'tsvgr_opacity', 14:15:07 INFO - 'tart', 14:15:07 INFO - 'tscrollx', 14:15:07 INFO - 'cart']}, 14:15:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'tests': ['tp5o']}, 14:15:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'talos_options': ['--e10s'], 14:15:07 INFO - 'tests': ['tp5o']}, 14:15:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'talos_options': ['--xperf_path', 14:15:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:07 INFO - 'tests': ['tp5n']}, 14:15:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:07 INFO - 'talos_options': ['--e10s', 14:15:07 INFO - '--xperf_path', 14:15:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 14:15:07 INFO - 'C:/slave/talos-data/talos/xperf.config'], 14:15:07 INFO - 'tests': ['tp5n']}}, 14:15:07 INFO - 'talos.zip': {'path': '', 14:15:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:07 INFO - Running post-action listener: _resource_record_post_action 14:15:07 INFO - ##### 14:15:07 INFO - ##### Running create-virtualenv step. 14:15:07 INFO - ##### 14:15:07 INFO - Running pre-action listener: _resource_record_pre_action 14:15:07 INFO - Running main action method: create_virtualenv 14:15:07 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:07 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 14:15:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:08 INFO - Using real prefix '/tools/python27' 14:15:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:13 INFO - Installing pip.................done. 14:15:13 INFO - Return code: 0 14:15:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:13 INFO - 'HOME': '/Users/cltbld', 14:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:13 INFO - 'LOGNAME': 'cltbld', 14:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:13 INFO - 'MOZ_NO_REMOTE': '1', 14:15:13 INFO - 'NO_EM_RESTART': '1', 14:15:13 INFO - 'PAGER': '/bin/cat', 14:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:13 INFO - 'PWD': '/builds/slave/test', 14:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:13 INFO - 'SHELL': '/bin/bash', 14:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:13 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:13 INFO - 'USER': 'cltbld', 14:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:13 INFO - 'XPC_FLAGS': '0x0', 14:15:13 INFO - 'XPC_SERVICE_NAME': '0', 14:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:15:14 INFO - Cleaning up... 14:15:14 INFO - Return code: 0 14:15:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:14 INFO - 'HOME': '/Users/cltbld', 14:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:14 INFO - 'LOGNAME': 'cltbld', 14:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:14 INFO - 'MOZ_NO_REMOTE': '1', 14:15:14 INFO - 'NO_EM_RESTART': '1', 14:15:14 INFO - 'PAGER': '/bin/cat', 14:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:14 INFO - 'PWD': '/builds/slave/test', 14:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:14 INFO - 'SHELL': '/bin/bash', 14:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:14 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:14 INFO - 'USER': 'cltbld', 14:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:14 INFO - 'XPC_FLAGS': '0x0', 14:15:14 INFO - 'XPC_SERVICE_NAME': '0', 14:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:14 INFO - Downloading/unpacking psutil>=0.7.1 14:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:15:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:17 INFO - Installing collected packages: psutil 14:15:17 INFO - Running setup.py install for psutil 14:15:17 INFO - building 'psutil._psutil_osx' extension 14:15:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:15:19 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 14:15:19 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 14:15:19 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 14:15:19 INFO - building 'psutil._psutil_posix' extension 14:15:19 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 14:15:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:15:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:15:19 INFO - ^ 14:15:20 INFO - 1 warning generated. 14:15:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:15:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:20 INFO - Successfully installed psutil 14:15:20 INFO - Cleaning up... 14:15:20 INFO - Return code: 0 14:15:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:20 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 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:20 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 14:15:20 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 14:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:20 INFO - 'HOME': '/Users/cltbld', 14:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:20 INFO - 'LOGNAME': 'cltbld', 14:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:20 INFO - 'MOZ_NO_REMOTE': '1', 14:15:20 INFO - 'NO_EM_RESTART': '1', 14:15:20 INFO - 'PAGER': '/bin/cat', 14:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:20 INFO - 'PWD': '/builds/slave/test', 14:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:20 INFO - 'SHELL': '/bin/bash', 14:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:20 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:20 INFO - 'USER': 'cltbld', 14:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:20 INFO - 'XPC_FLAGS': '0x0', 14:15:20 INFO - 'XPC_SERVICE_NAME': '0', 14:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:15:20 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 14:15:20 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 14:15:20 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 14:15:20 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 14:15:20 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 14:15:20 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 14:15:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:15:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:15:23 INFO - Installing collected packages: mozsystemmonitor 14:15:23 INFO - Running setup.py install for mozsystemmonitor 14:15:23 INFO - Successfully installed mozsystemmonitor 14:15:23 INFO - Cleaning up... 14:15:23 INFO - Return code: 0 14:15:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:23 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 14:15:23 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 14:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:23 INFO - 'HOME': '/Users/cltbld', 14:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:23 INFO - 'LOGNAME': 'cltbld', 14:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:23 INFO - 'MOZ_NO_REMOTE': '1', 14:15:23 INFO - 'NO_EM_RESTART': '1', 14:15:23 INFO - 'PAGER': '/bin/cat', 14:15:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:23 INFO - 'PWD': '/builds/slave/test', 14:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:23 INFO - 'SHELL': '/bin/bash', 14:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:23 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:23 INFO - 'USER': 'cltbld', 14:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:23 INFO - 'XPC_FLAGS': '0x0', 14:15:23 INFO - 'XPC_SERVICE_NAME': '0', 14:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:28 INFO - Downloading docopt-0.6.1.tar.gz 14:15:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:28 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:28 INFO - Running setup.py install for blobuploader 14:15:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:28 INFO - Running setup.py install for requests 14:15:28 INFO - Running setup.py install for docopt 14:15:29 INFO - Successfully installed blobuploader requests docopt 14:15:29 INFO - Cleaning up... 14:15:29 INFO - Return code: 0 14:15:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:29 INFO - 'HOME': '/Users/cltbld', 14:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:29 INFO - 'LOGNAME': 'cltbld', 14:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:29 INFO - 'MOZ_NO_REMOTE': '1', 14:15:29 INFO - 'NO_EM_RESTART': '1', 14:15:29 INFO - 'PAGER': '/bin/cat', 14:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:29 INFO - 'PWD': '/builds/slave/test', 14:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:29 INFO - 'SHELL': '/bin/bash', 14:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:29 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:29 INFO - 'USER': 'cltbld', 14:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:29 INFO - 'XPC_FLAGS': '0x0', 14:15:29 INFO - 'XPC_SERVICE_NAME': '0', 14:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:29 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-lq8ws_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:29 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-3QdkgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:29 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-HHve4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:29 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-C5ygVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-qb2IMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-8WTrGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-IS0ieE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-cUr8w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-BzkihQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-IS5Y7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:30 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-jO3FKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:31 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-Iw7win-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:31 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-DP1RDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:31 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-FXmtSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:31 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-JyPf3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:31 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-ssRWsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:31 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-RUq3E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:31 INFO - Running setup.py install for manifestparser 14:15:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:32 INFO - Running setup.py install for mozcrash 14:15:32 INFO - Running setup.py install for mozdebug 14:15:32 INFO - Running setup.py install for mozdevice 14:15:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:32 INFO - Running setup.py install for mozfile 14:15:32 INFO - Running setup.py install for mozhttpd 14:15:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:32 INFO - Running setup.py install for mozinfo 14:15:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Running setup.py install for mozInstall 14:15:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Running setup.py install for mozleak 14:15:33 INFO - Running setup.py install for mozlog 14:15:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Running setup.py install for moznetwork 14:15:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:33 INFO - Running setup.py install for mozprocess 14:15:34 INFO - Running setup.py install for mozprofile 14:15:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:34 INFO - Running setup.py install for mozrunner 14:15:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:34 INFO - Running setup.py install for mozscreenshot 14:15:34 INFO - Running setup.py install for moztest 14:15:34 INFO - Running setup.py install for mozversion 14:15:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:35 INFO - Cleaning up... 14:15:35 INFO - Return code: 0 14:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:35 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 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:35 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 14:15:35 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 14:15:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:35 INFO - 'HOME': '/Users/cltbld', 14:15:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:35 INFO - 'LOGNAME': 'cltbld', 14:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:35 INFO - 'MOZ_NO_REMOTE': '1', 14:15:35 INFO - 'NO_EM_RESTART': '1', 14:15:35 INFO - 'PAGER': '/bin/cat', 14:15:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:35 INFO - 'PWD': '/builds/slave/test', 14:15:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:35 INFO - 'SHELL': '/bin/bash', 14:15:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:35 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:35 INFO - 'USER': 'cltbld', 14:15:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:35 INFO - 'XPC_FLAGS': '0x0', 14:15:35 INFO - 'XPC_SERVICE_NAME': '0', 14:15:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:35 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-kQtxNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:35 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)) 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:35 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-nIvVZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:35 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-iqKRuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:35 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-v9_EF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:35 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-XPxZ2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:36 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)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-TdEsne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:36 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)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-tDY9lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:36 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)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-C1oqwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:36 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)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-kKckRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:36 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)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-Qu_0Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-XQbkp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:36 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-w_eAx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:37 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-AvEyVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:37 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-ECqNy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:37 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-dHXEwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:37 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-JGg56v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:37 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-GySuDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:37 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)) 14:15:37 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)) 14:15: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:37 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)) 14:15:37 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)) 14:15:37 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)) 14:15:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:37 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 14:15:37 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 14:15:37 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 14:15:37 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 14:15:37 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 14:15:37 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 14:15:40 INFO - Downloading blessings-1.5.1.tar.gz 14:15:40 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 14:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:40 INFO - Installing collected packages: blessings 14:15:40 INFO - Running setup.py install for blessings 14:15:40 INFO - Successfully installed blessings 14:15:40 INFO - Cleaning up... 14:15:40 INFO - Return code: 0 14:15:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:41 INFO - Reading from file tmpfile_stdout 14:15:41 INFO - Current package versions: 14:15:41 INFO - blessings == 1.5.1 14:15:41 INFO - blobuploader == 1.2.4 14:15:41 INFO - docopt == 0.6.1 14:15:41 INFO - manifestparser == 1.1 14:15:41 INFO - mozInstall == 1.12 14:15:41 INFO - mozcrash == 0.16 14:15:41 INFO - mozdebug == 0.1 14:15:41 INFO - mozdevice == 0.46 14:15:41 INFO - mozfile == 1.2 14:15:41 INFO - mozhttpd == 0.7 14:15:41 INFO - mozinfo == 0.8 14:15:41 INFO - mozleak == 0.1 14:15:41 INFO - mozlog == 3.0 14:15:41 INFO - moznetwork == 0.27 14:15:41 INFO - mozprocess == 0.22 14:15:41 INFO - mozprofile == 0.27 14:15:41 INFO - mozrunner == 6.11 14:15:41 INFO - mozscreenshot == 0.1 14:15:41 INFO - mozsystemmonitor == 0.0 14:15:41 INFO - moztest == 0.7 14:15:41 INFO - mozversion == 1.4 14:15:41 INFO - psutil == 3.1.1 14:15:41 INFO - requests == 1.2.3 14:15:41 INFO - wsgiref == 0.1.2 14:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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 0x10447aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f41c98100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, '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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 14:15:41 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 14:15:41 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 14:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:41 INFO - 'HOME': '/Users/cltbld', 14:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:41 INFO - 'LOGNAME': 'cltbld', 14:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:41 INFO - 'MOZ_NO_REMOTE': '1', 14:15:41 INFO - 'NO_EM_RESTART': '1', 14:15:41 INFO - 'PAGER': '/bin/cat', 14:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:41 INFO - 'PWD': '/builds/slave/test', 14:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:41 INFO - 'SHELL': '/bin/bash', 14:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:15:41 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:41 INFO - 'USER': 'cltbld', 14:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:41 INFO - 'XPC_FLAGS': '0x0', 14:15:41 INFO - 'XPC_SERVICE_NAME': '0', 14:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 INFO - Cleaning up... 14:15:41 INFO - Return code: 0 14:15:41 INFO - Running post-action listener: _resource_record_post_action 14:15:41 INFO - Running post-action listener: _start_resource_monitoring 14:15:41 INFO - Starting resource monitoring. 14:15:41 INFO - ##### 14:15:41 INFO - ##### Running install step. 14:15:41 INFO - ##### 14:15:41 INFO - Running pre-action listener: _resource_record_pre_action 14:15:41 INFO - Running main action method: install 14:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:41 INFO - Reading from file tmpfile_stdout 14:15:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:42 INFO - Reading from file tmpfile_stdout 14:15:42 INFO - Output received: 14:15:42 INFO - Usage: mozinstall [options] installer 14:15:42 INFO - Options: 14:15:42 INFO - -h, --help show this help message and exit 14:15:42 INFO - -d DEST, --destination=DEST 14:15:42 INFO - Directory to install application into. [default: 14:15:42 INFO - "/builds/slave/test"] 14:15:42 INFO - --app=APP Application being installed. [default: firefox] 14:15:42 INFO - mkdir: /builds/slave/test/build/application 14:15:42 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'] 14:15:42 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 14:16:23 INFO - Reading from file tmpfile_stdout 14:16:23 INFO - Output received: 14:16:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:16:23 INFO - Running post-action listener: _resource_record_post_action 14:16:23 INFO - ##### 14:16:23 INFO - ##### Running run-tests step. 14:16:23 INFO - ##### 14:16:23 INFO - Running pre-action listener: _resource_record_pre_action 14:16:23 INFO - Running main action method: run_tests 14:16:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:23 INFO - 2015-11-25 14:16:23.426 screenresolution[1660:12984] starting screenresolution argv=screenresolution get 14:16:23 INFO - 2015-11-25 14:16:23.430 screenresolution[1660:12984] Display 0: 1600x1200x32@60 14:16:23 INFO - 2015-11-25 14:16:23.437 screenresolution[1661:12986] starting screenresolution argv=screenresolution list 14:16:23 INFO - Available Modes on Display 0 14:16:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:23 INFO - Intel HD Graphics 3000: 14:16:23 INFO - Chipset Model: Intel HD Graphics 3000 14:16:23 INFO - Type: GPU 14:16:23 INFO - Bus: Built-In 14:16:23 INFO - VRAM (Total): 512 MB 14:16:23 INFO - VRAM (Dynamic, Max): 10 14:16:23 INFO - Vendor: Intel (0x8086) 14:16:23 INFO - Device ID: 0x0116 14:16:23 INFO - Revision ID: 0x0009 14:16:23 INFO - Displays: 14:16:23 INFO - Display: 14:16:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:23 INFO - Display Serial Number: 1600x1200 60 14:16:23 INFO - Main Display: Yes 14:16:23 INFO - Mirror: Off 14:16:23 INFO - Online: Yes 14:16:23 INFO - Rotation: Supported 14:16:23 INFO - Return code: 0 14:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:23 INFO - Python 2.7.3 14:16:23 INFO - Return code: 0 14:16:23 INFO - grabbing minidump binary from tooltool 14:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:23 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 0x10442f9f0>, '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 0x10418ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043f9990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:23 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 14:16:23 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 14:16:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:23 INFO - Return code: 0 14:16:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:16:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:16:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:23 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/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0003', '--webServer', 'localhost'] in /builds/slave/test/build 14:16:23 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/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0003 --webServer localhost 14:16:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf6qlpkvUU/Render', 14:16:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:23 INFO - 'HOME': '/Users/cltbld', 14:16:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:23 INFO - 'LOGNAME': 'cltbld', 14:16:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:23 INFO - 'MOZ_NO_REMOTE': '1', 14:16:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:23 INFO - 'NO_EM_RESTART': '1', 14:16:23 INFO - 'PAGER': '/bin/cat', 14:16:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:23 INFO - 'PWD': '/builds/slave/test', 14:16:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:23 INFO - 'SHELL': '/bin/bash', 14:16:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pfCOzm1WCA/Listeners', 14:16:23 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 14:16:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:23 INFO - 'USER': 'cltbld', 14:16:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:23 INFO - 'XPC_FLAGS': '0x0', 14:16:23 INFO - 'XPC_SERVICE_NAME': '0', 14:16:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:16:23 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/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0003', '--webServer', 'localhost'] with output_timeout 3600 14:16:24 INFO - mozversion INFO | application_buildid: 20151125131130 14:16:24 INFO - mozversion INFO | application_changeset: 1f88b627ee6a78de1536beaab4b1a7c04a992806 14:16:24 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:16:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:24 INFO - mozversion INFO | application_name: Firefox 14:16:24 INFO - mozversion INFO | application_remotingname: firefox-dev 14:16:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:16:24 INFO - mozversion INFO | application_vendor: Mozilla 14:16:24 INFO - mozversion INFO | application_version: 44.0a2 14:16:24 INFO - mozversion INFO | platform_buildid: 20151125131130 14:16:24 INFO - mozversion INFO | platform_changeset: 1f88b627ee6a78de1536beaab4b1a7c04a992806 14:16:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:16:24 INFO - mozversion INFO | platform_version: 44.0a2 14:16:24 INFO - 2015-11-25 14:16:24,177 DEBUG : using testdate: 1448489784 14:16:24 INFO - 2015-11-25 14:16:24,177 DEBUG : actual date: 1448489784 14:16:24 INFO - 2015-11-25 14:16:24,264 INFO : starting webserver on 'localhost:49264' 14:16:24 INFO - 2015-11-25 14:16:24,266 INFO : Starting test suite t-yosemite-r5-0003 14:16:24 INFO - 2015-11-25 14:16:24,266 INFO : Starting test dromaeo_css 14:16:24 INFO - 2015-11-25 14:16:24,266 DEBUG : operating with platform_type : mac_ 14:16:24 INFO - 2015-11-25 14:16:24,267 INFO : Initialising browser for dromaeo_css test... 14:16:24 INFO - 2015-11-25 14:16:24,295 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpzkmqiS/profile http://localhost:49264/getInfo.html 14:16:27 INFO - 2015-11-25 14:16:27,331 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:16:27 INFO - 2015-11-25 14:16:27,331 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:16:27 INFO - 2015-11-25 14:16:27,331 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:16:27 INFO - 2015-11-25 14:16:27,332 DEBUG : BROWSER_OUTPUT: __metrics 14:16:27 INFO - 2015-11-25 14:16:27,339 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:28 INFO - 2015-11-25 14:16:28,078 INFO : Browser initialized. 14:16:28 INFO - 2015-11-25 14:16:28,079 INFO : Running cycle 1/1 for dromaeo_css test... 14:16:28 INFO - 2015-11-25 14:16:28,079 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpzkmqiS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:16:40 INFO - 2015-11-25 14:16:40,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 199200768 14:16:40 INFO - 2015-11-25 14:16:40,143 DEBUG : BROWSER_OUTPUT: 14:17:31 INFO - 2015-11-25 14:17:31,936 DEBUG : BROWSER_OUTPUT: 1448489851934 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] 14:19:42 INFO - 2015-11-25 14:19:42,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 14:19:43 INFO - 2015-11-25 14:19:43,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 324030464 14:19:43 INFO - 2015-11-25 14:19:43,531 DEBUG : BROWSER_OUTPUT: 14:22:46 INFO - 2015-11-25 14:22:46,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 14:22:46 INFO - 2015-11-25 14:22:46,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 343687168 14:22:46 INFO - 2015-11-25 14:22:46,865 DEBUG : BROWSER_OUTPUT: 14:25:49 INFO - 2015-11-25 14:25:49,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 14:25:49 INFO - 2015-11-25 14:25:49,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 309567488 14:25:49 INFO - 2015-11-25 14:25:49,697 DEBUG : BROWSER_OUTPUT: 14:28:51 INFO - 2015-11-25 14:28:51,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 14:28:52 INFO - 2015-11-25 14:28:52,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 302526464 14:28:52 INFO - 2015-11-25 14:28:52,373 DEBUG : BROWSER_OUTPUT: 14:31:55 INFO - 2015-11-25 14:31:55,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 14:31:56 INFO - 2015-11-25 14:31:56,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 303939584 14:31:56 INFO - 2015-11-25 14:31:56,078 DEBUG : BROWSER_OUTPUT: 14:34:58 INFO - 2015-11-25 14:34:58,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 14:34:59 INFO - 2015-11-25 14:34:59,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 347770880 14:34:59 INFO - 2015-11-25 14:34:59,118 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,118 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:34:59 INFO - 2015-11-25 14:34:59,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:34:59 INFO - 2015-11-25 14:34:59,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:34:59 INFO - 2015-11-25 14:34:59,119 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:34:59 INFO - 2015-11-25 14:34:59,119 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2701.459708058388;2754.311422144464;2759.5170845102116;2770.7921905857065;2790.958135627966;4676.696014759038;4681.250999840026;4686.109639168556;4703.576678098971;4775.044991001801;4517.435320584927;4641.9071618567605;4679.485256621778;4690.530946905308;4747.62019038477;4347.260965635834;4357.651387888977;4368.584984426474;4428.712133711307;4552.567506086916;4358.585934336233;4443.111377724452;4488.573585509388;4534;4570.040291538781;4234.343676730112;4410.31640095784;4429;4448.466184057917;4535.7958891849785;4460.286354183315;4571.862844114682;4578.427696537933;4597.517260687613;4629.884252893671;4184.895377615553;4329.805158767863;4348.326009468537;4424.513303536608;4477.507474177838;4475.351074094271;4770.022145460172;4773.498782627844;4804.327394164819;4907.779149938261;5080.339555857715;5146.588272938156;5158.277841102249;5186.273921650972;5199.974000130013;4840.419149702058;5076;5187.870303242411;5210.478952104797;5233;4554.635629149726;4572.542745725401;4689.906201875943;4716.1510928033285;4774.880627984258;5219.921701174486;5242.9737851311265;5243.344581927259;5273.1299335609965;5276.472352764693;4709.576138147583;4973.751312434364;4977.626677999092;5061.417936937226;5065;4849.2968519564465;4971.975140124277;5000.74996250186;5078.847634570969;5109.284700141983;5039.966806804597;5043.067032598981;5054.7472626368535;5066.392032956069;5126.384833819965;4852.51474852519;5101.0818052750865;5110.029094472038;5114.15616423286;5136.743162841918;3801.0877389426337;3833.884983450501;3886.8639597613947;3915.8629447969183;3924.529056513237;3473.6873681368293;3510.982445087809;3519.1554027033326;3534.6465353464964;3570.232400034005;4371.519132895379;4817.686850354786;4825.372701548847;4830.6135509159185;4854.2233242681;4844.079624871263;4898.265260210926;5004.749762511859;5115;5179.171332586768;4661.277501987197;4682.157211701859;4694.600958918462;4696.718196908197;4734.455537613218;4179.958200418017;4368.978155109204;4390.1878152541885;4453.376527286183;4460.754658493749;4820.25286080658;4887.584555312767;4985.775640096132;5002.874928126753;5052.46949070357;4992.550670439678;5076.060928728197;5103.693778373309;5143.6399452037995;5184.144616138295;4993.400791904995;5087.974560127176;5144.125498665311;5155.046316431472;5167.870803229949;4900.411950565955;4932.457429682804;5000.349954505891;5002.649814512949;5058.797648094035;5123.205903085028;5130.923036154535;5150.639455238097;5161.458046905021;5171.689698618095;4738.715677059387;5067.391912970467;5076.593872490118;5145;5150.665206761549;4546.954530454653;4789.425268967746;4902.558769710743;4934.01319736047;4963.057019166346;4888.926666100083;4928.67963582366;4934.950650493593;4997.875053123701;5005.599552035756;4671.719696818202;5012.172991456368;5022.196448568212;5049.924251136309;5088.135017047185;4759.881002974953;4868.805247790048;4890.021995600823;4908.4355299139625;4965.304857319906 14:34:59 INFO - 2015-11-25 14:34:59,119 DEBUG : BROWSER_OUTPUT: |1;ext.html;489.7820469890899;492.83490030839664;493.5360760884768;507.64458894751;527.1223413017326;28341.291467713316;29680.406391872177;35577.64422355779;36231.81884090583;36788.44817327742;36844.44733329002;38687.80656096723;39045.60954390455;39811.60188398115;39903;7327.4504412169035;7956.562389068614;8155;8165.3059489943425;8169.550674712888;7464.9626751866435;9650;9895.703128906109;9929.801403971916;9984.850227246561;9285.442873427583;9621.374610650286;9707.660231891885;9774.16919561838;9787.510624468783;7625.542467451971;7817.140114587391;9466.526673666323;9609.663661771874;9742.22062235023;9490.715278541655;9499.477528735917;9590.08894155054;9635.277354198462;9712.562934667956;36013;36884.81557592221;36949.44575831365;36957.630423695686;36969;2702.8513431761244;2781.137847267333;2888.1046875468674;3005.0984704588536;3049.5273232648974;24088.15691450791;24145.758542414704;24296.757032429625;24404.145854894992;24463.877680611484;2040.9183632654676;2041.1223174035158;2042.428120126367;2144.710464087344;2157.0508976050646;255924;256059;258362.9999999981;260445;260574;51777.22334164991;53022;53674.7316263424;54246.728766356704;54641;61267.38732612706;63289.36710632835;63940.36059639344;64009;64022.6798866012;14640.633984150269;14769.630759231106;14853.554393368217;14853.737432318374;14858.182799946107;11355.432228388547;11392.772144557228;11404.885951140548;11481.483333250024;11576.652700419001;17475;17643.470695879143;17819;17837.554061148316;18284.451466456027;7579;7741.742041876945;7759.650815713194;7824;7839.176886426957;796.9521828690297;878.4553576782436;901.4591245252927;903.5708038681573;1010.4998025977188;25880.611790823154;26522.602160967603;26754.866225668746;26921.86539067292;26976;848.6478111583747;873.9825203495894;951.2342564235856;971.3783178765595;1040.8542804007445;11196.776064478665;12443.066769992287;12490.375481226085;12492.81260781089;12594.748105037848;300441;311754;312621;314034;314553;45782.31326530105;46507;46691.76654116776;46904.061918761436;47246.76376618095;1235.7899157143306;1246.4391024039037;1248.9696000799195;1249.5439164704817;1257.1765493601706;23220.187293444647;23542.52914941726;23917.521649566563;24482.265532034067;25345.619815702412;42581.14837703166;42609.36085958651;42714.78642606767;43295.56704432915;43322.35016474818;232738;238822;242704;244110;244974;25291.367715807253;25429.364265893502;27844.886204551593;28272.85863570669;28982.27544311409;33196.1700957478;33604.80754328335;34150.65849341475;34165.31669366549;34517.482237766955;29385.85307073451;30293.394132117675;30720.692793071783;31284.687153128176;31664.366712666077;24912.750872491768;28014;31337.37325253528;31355.686443135277;31823.363532728752;30962.33476668216;31706.207344816565;31764.682353176173;31848.840755796075;32123.67876321207;24799.725166666893;24883.751162488144;27866.30334241579;27902.72097279001;28026.2993425166;19673.704894426883;20789;20947.8952605236;21432.249871254433;21433.892830535748 14:34:59 INFO - 2015-11-25 14:34:59,121 DEBUG : BROWSER_OUTPUT: |2;jquery.html;299.52824301724763;300.3467458278244;301.0321815363606;309.3642564529891;309.85746556583985;12984.350782460886;13431.664208394795;15276.159811210378;15687.764683529742;15781.053136811799;10466.842997355026;10531.21015923805;10745;13306.401211945462;15603.375864965416;3742.0644838790236;3845.403962385835;3845.788481633509;3848.2303539292116;3850.3646898261895;3043.3913217356508;3161.731252843511;3716.0709822544363;3815.9809200953955;4151.73013754105;4088.407180958759;4127.422160897462;4142.2543942090415;4189.7695626740515;4201.936970945439;4120.443740095079;4137;4180.038591124028;4195.8741237762615;4198.6221240088535;3436.226848958989;3529.8235088245483;3532.540769699948;3562.412201986695;3564.536610240652;11507.827382589185;11530.942345288304;11560.6531804046;11613.419329033515;11759.706007349885;1550.0854495847504;1601.6396310830087;1622.22944101552;1630.2663801289468;1721.397510871185;8326.125756795509;8440.11378805229;8441.366897482714;8464;8792.780180495474;1346.3402932563072;1351.3918736568583;1375.4979432507064;1387.1538361599416;1448.7826825976083;51141.23288150681;52539;53561;53697.73151134259;54384.59770803987;5779.364269930388;5905.616134951214;5908.084246941731;5952.613080149777;5956.076808094752;6573.704183311763;6663.633955039205;6684.465242780566;6706.295838936939;6776;4687.507811679793;4737.502562230985;4744.620430365562;4799.832005879777;4967.428745694219;4624.237000894815;4842.394700662418;4864.075825593126;4867.902641947141;4962.751862406865;2567.8587677677906;2646.563317052703;2652.867356632161;2658.2291135570467;2668.4529671417313;929.3633860805235;939.5349302095507;943.0852073488705;948.5020364308793;998.7553049502918;336.15792439938286;348.27475008062015;374.92314075614433;382.97510661806893;418.4079527468598;10045.949770251102;10116.747081323027;10429.58878934066;10568.947155264175;10851.945740271249;362.5631114507013;389.56563431773367;402.49047190765555;409.38796499233837;413.6339339684401;5442.2108794225405;5657.717114144276;5872.941270587239;5875.177475153482;5900.203472531153;478076;490011;490736;507496;510818;66183.33816661868;67530;67701;68548;70683.29316706768;453.3313362789859;456.8857785553612;459.16432093590015;461.2389557230529;463.726401423162;9960.153386962189;9970.50147492637;10002.349847259904;10029.949850250994;10237.488125593542;30943.69056309498;31829;31857.203569910936;31868;32137.517937230492;39297.80351098341;39331.803340984254;41073;42028.78985605175;43804.34293485664;5422.267993820941;5542.695151766691;5640.492355688008;5643.322801263875;5649.322081350264;10384.221183411426;10488.475576221006;10783.568657253621;10814.621488247874;10924.071453926505;8936.597853096757;9137.5888085035;9327.533623318672;9341.57962891658;9343.71968840936;8890.866637000321;9045.502497362708;9055.954720226357;9061.909380906107;9202.217811486098;9067.954660226656;9329.766755831159;9403.576839042396;9417;9522.714318570454;5068.82259120929;5302.8144014960835;5443.836684899459;5502.944970550243;5588.944110558842;8923.598438070172;8988.955055224682;9112.544372781467;9214.308926830381;9365.765855853386 14:34:59 INFO - 2015-11-25 14:34:59,124 DEBUG : BROWSER_OUTPUT: |3;mootools.html;705.59428328711;1225.3015781004829;1230.4340003598345;1239;1587.5554844643498;6263.592866463682;6317.494600431966;6430.807075787722;6700.631465269408;6933.791986240408;6697.832554186136;6728.764493242737;6801.523893327469;6826.283240259776;6840.076589660394;1876.0900963032918;1882.1812511557482;1906.6377388296248;1910.245453046053;1918.8486907855315;1946.2506934830121;2007.317512045904;2009.588034452941;2014.315132854829;2018.959620807583;1941.834944029752;1978.0406502846108;1989.1247850945538;1991.8148701522643;1994.1624517702528;1876.6997280435132;1888.490107670928;1902.838258748008;1907.4468404162776;1907.6184763047445;1926.7206255092933;1941.1652989214633;1951.8926459044746;1971.6451038813009;1977.7824439311664;6730.394264516217;6817.216020157695;6819.863602727967;6839.726410943556;6878.105846239957;3612.8193590320643;3755.0987762936697;4110.095778928631;4205.621494065518;4224.45082139323;2580.2259322203263;2594.610808378758;2601.414681696622;2641.1152263991585;2676.852773097479;802.9558374289412;816.873384625384;818.3330585572799;823.0781524692324;836.2975100915261;9186.586603602855;9247.352685312031;9251.444913305224;9258.6296548138;9370.57832397537;3810.9519882032664;3865.16898866745;3877.108265099043;3881.029742564359;3930.6462418382484;7723.034620672416;8110.067342255598;8119.269265766109;8119.959400203079;8133.59332033396;4261.190373829025;4276.31578947367;4282;4302.44068271129;4320.567943205717;3818.770873747584;3863.74885632433;3868.207017561393;3874.6319099685484;3928.548216955087;3157.3527426877436;3172.7620428467494;3194.3291908699434;3199.232184275757;3221.3074189049;961.3270710502676;1001.1840350114634;1004.5479534209635;1009.4700282351678;1011.6155860772859;840.0717207485641;860.0883063952231;864.0409145848104;871.5990644303691;1026.897310268982;6043;6102.908456373158;6169.938300616936;6170.938290617126;6275.717592708339;411.2084237842142;420.08631227080974;425.5085376390274;429.6906227516183;431.2883741826012;4362.345648152803;4396.07682386696;4443.733375997451;4503.347014682852;4846.878828029327;7320.1581818090535;7961;8080.474769139987;8081.353491720648;8084.919150808417;7821.530708157528;7912.564808935564;8037.276645101969;8038.397120216007;8074.152214017444;6286.842828929313;6322.241331040213;6368.64972426521;6494.188226471785;6517.576357536745;6279.937200627935;6298.307186209605;6375.075614035846;6381.425671689571;6425.967870160619;7259.963700181465;7283.8179045522165;7408.814779630552;7427.294407031323;7442.813929651802;7426.777196684108;7534.849303014019;7664.770056898302;7671.769846904602;7681.231876812274;5904.704764761831;6050.788222412194;6096.207493026056;6109;6160.260768707783;6594.571352862049;6663.833404164935;6712.4294434971625;6720.227173874871;6722.495812813961;5843.7370318336625;6228.781992630236;6230.7507699691505;6300.810975670737;6321.8735625288155;6038.215032045806;6056.091586262096;6088.543359247986;6106.969465152646;6212.192414986023;5885.176075349369;6144.723487442986;6242.344553821965;6281.874362512633;6290.24517057956;5335.626506144533;5437.8368648940595;5442.863928401822;5448.237246785374;5449.509544141047;5376.274202982548;5401.432849550741;5430;5512.173174023928;5545.417731138173 14:34:59 INFO - 2015-11-25 14:34:59,125 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.761827210327;280.7922137618162;285.8127926208334;289.3735063587335;289.3850567543969;5176.301199338088;5178.818741344054;5198.272241886134;5232.319798426204;5339.626226164165;5054.570361519266;5128.43587205408;5180.1970694542315;5229.633925625208;5252.107141785896;4111.157212771374;4127.690423218256;4159.064210552617;4164.97917510412;4177.456930599018;3969.3847453644585;4050.412690159925;4059.573744756802;4137.13120244749;4170.52039015514;4067.9389809152885;4111.48606424197;4127.215828992482;4142;4183.288840897055;4070.267351876661;4084.14233011068;4097.344424892033;4103.4460347852955;4122.175564887019;3443.7933723976644;3564.465330200465;3576.535050443452;3577.0520811984843;3580.6240344763687;5008.84973450797;5016.046951079284;5040.269160971675;5042.697438153686;5051.267566202917;4554.795034223468;4572.954270457286;4593.770311484446;4594.1271158479785;4606.378138951266;5307.708076055816;5387.595930305203;5486.561075114021;5493.148561972901;5508.091164957777;3777.0934975605933;3839.78881161536;3840.2703486337787;3846.307664620367;3851.614838516154;5538.113901775737;5724.284464441945;5732.0542110551705;5746.333563266648;5769.1346298055205;3747.9437808432895;3760.9435858462143;3793.867214647474;3802.8288727006798;3825.464434979105;3824.388097904322;3882.3594106972596;3888.2806680763583;3890.6692931101175;3892.2993861105274;4503.392042074343;4506.278995360726;4508.954910450919;4515.571020753023;4516.322551617283;5420.674759514442;5499.945000549943;5514.80698175562;5527.585431092684;5535.806246781343;1282.9550965716155;1368.0286996232587;1386.4869998100767;1402.6002589262216;1407.268220525321;874.7987962768599;895.0557162193818;901.6663834381189;906.1029580715044;915.8305713442901;5084.847454576368;5085.389753229636;5152.793888244503;5169.974150129226;5180.559652429511;5476.397596264408;5487.341519017744;5518.503334699816;5579.218909352694;5605.1872478491205;5078.4413714491375;5164.845054648366;5206.167013277857;5239.8166064188335;5245.868853278698;3060.586820779211;3075.031365120025;3129.0769223079246;3137.51368537877;3199.600049993751;5660.2075709400715;5666.320041595035;5667.546596272288;5676.205331253628;5679.091345384802;5699.287589051369;5753.367129615739;5770.711464426846;5787.913181302284;5820.126980952891;5672.432756724294;5691.772329106955;5703.686297253608;5725.112607545837;5726.3700992890745;5589.217509548585;5696.886062278814;5705.4579814917515;5716.8570785729025;5727.36998930109;5412.972935135299;5555.555555555627;5557.083081291542;5603.971980140073;5691.117876729114;5615.5507559395965;5634.352049514358;5635.380108188178;5643.830685079454;5645.40723224072;3584.211473475831;3585.2650206708086;3646.0155757945736;3679.7792132472136;3682.6869716074434;5554.50009499147;5631.2960879890015;5639.802606908738;5640.435956404327;5655.377908430151;5058.54473097423;5369.328833895763;5387.542058925035;5424.050791111618;5439.537639300545;5436.483534064258;5444.292242008513;5465.9726701366235;5502.752376143163;5568.415316391721;5318.202269659582;5344.866378340573;5346.010987967238;5358.812441564526;5470.507654311131;5323.1216849219445;5475.479829416199;5497.367802702581;5516;5529.972350138223;5284.365876094893;5348.7593058311695;5390.4879036491475;5453.672779633234;5535.197396377423 14:34:59 INFO - 2015-11-25 14:34:59,129 DEBUG : BROWSER_OUTPUT: |5;yui.html;573.4867293772074;609.6281268426261;615.3262177915184;619.4332186049764;631.5263552335748;11708.180427370087;12075.758484830309;12318.199317044397;12325.876741232585;12329;12381.195222310544;12578;12618;12629.684257893558;12904.354782260896;633.2875515045574;746.6789280609336;766.0615745711486;777.7161336112307;778.2295527427834;621.502797761791;742.0687037767622;762.1387831750114;764.7782143178472;774.1871035412822;780.7696729464822;801.6272433318505;807.9717209897655;816.6610856494548;820.1388542030874;648.6043513456788;649.6524359467709;788.9763307100797;813.4631143445328;814.1858141858141;597.641415150906;600.3606159440183;601.2304250559291;601.9819405417844;607.9331273559949;11706.122040846885;12332.876671233262;12336.568220112253;12454;12504.749905001849;10208.897911020944;10232.948835255776;10406.843897341547;10694.73263168427;10955.4522273886;7721.575313357763;7997.320227780646;8167.469114507538;8179.672813087469;8180.9590952045455;2839.1908306132655;2913.0823790505924;2926.590277361171;2938.8824447022093;2953.1878733348285;40185.79907100446;44032.77983610093;45377.77311113424;45763.542364576264;46229.53770462286;7349.853002939912;7833.804154896059;7836.451448398671;7901.367890568741;7940.367837540115;16926.91536542334;17105.401310954057;17131.914340428466;17218.139093045298;17222.483325500005;6141.109539116893;6256.718447669866;6341.841453963595;6367.808965731036;6396.328385519547;3329.8002119872885;3337.4493208620793;3372.0558243691808;3398.4732366483236;3410.9937568417376;2560.9871950640127;2640.577507598775;2642.643243162187;2643.524165650163;2643.867806609662;364.5716283367033;371.55970175342304;376.3357673705911;376.7306375941215;376.76452217364147;436.9235383807821;442.71444918028334;453.6529554890511;466.33314360464186;507.24167369781674;6276.246850377984;6564.343565643398;6577.539572229898;6612.8346791330605;7609.391248700202;426.3093788063357;446.0432372560839;446.6404544341771;448.87655894628585;516.3442428116347;2980.344324248662;3132.1543183340373;3188.7449004079617;3202.5676533667656;3264.6245681746905;49495;50330.24504632434;54521.1821822673;55022.17466738002;55276.72361638166;44398;44735.77632111819;45040;45196;45447.54552454499;42272.57727422748;42559.78720106441;42839.357409638884;43560.34659480047;43571.346429803576;6877.759278425231;6911.516193866582;7137.571745695275;7151.356377926011;7234.493585448968;29198.124056278346;29573.26066848346;31469.8426507866;31500.527492087178;32199.839000804845;38701.6129838698;39113;39229.60770392259;40295.79852100838;40439.595604043585;6622.801315960529;6925.272846351262;6930.965345173242;6954.652267386711;7102.147742270754;9893.208543316661;10024.398536087858;10060.94969525177;10121.392716437038;10139.898601013896;8929.285657147282;9195.724128276162;9459.38513996588;9525.237980961645;9532.428054316762;9448.811023779623;9471.810563788824;9533.380330278787;9572.760680982752;9680.75798105053;9033.096690330914;9070.18368346852;9125;9150.679726209552;9156.267498599962;8085.8787118192095;8257.57727118348;8262.462939908886;8337.708180213664;8342.791430214293;7734.729284475016;7933.127355990721;8000.639971201426;8129.593520324079;8338.79153021155 14:34:59 INFO - 2015-11-25 14:34:59,129 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:34:59 INFO - 2015-11-25 14:34:59,129 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:34:59 INFO - 2015-11-25 14:34:59,129 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 14:34:59 INFO - 2015-11-25 14:34:59,129 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:34:59 INFO - 2015-11-25 14:34:59,130 DEBUG : BROWSER_OUTPUT: __startTimestamp1448490899113__endTimestamp 14:34:59 INFO - 2015-11-25 14:34:59,130 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,130 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:34:59 INFO - 2015-11-25 14:34:59,130 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:34:59 INFO - 2015-11-25 14:34:59,130 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,130 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4712.21 Median:4849.30 stddev:517.06 (10.7%) stddev-sans-first:494.00 14:34:59 INFO - 2015-11-25 14:34:59,131 DEBUG : BROWSER_OUTPUT: Values: 2701.5 2754.3 2759.5 2770.8 2791.0 4676.7 4681.3 4686.1 4703.6 4775.0 4517.4 4641.9 4679.5 4690.5 4747.6 4347.3 4357.7 4368.6 4428.7 4552.6 4358.6 4443.1 4488.6 4534.0 4570.0 4234.3 4410.3 4429.0 4448.5 4535.8 4460.3 4571.9 4578.4 4597.5 4629.9 4184.9 4329.8 4348.3 4424.5 4477.5 4475.4 4770.0 4773.5 4804.3 4907.8 5080.3 5146.6 5158.3 5186.3 5200.0 4840.4 5076.0 5187.9 5210.5 5233.0 4554.6 4572.5 4689.9 4716.2 4774.9 5219.9 5243.0 5243.3 5273.1 5276.5 4709.6 4973.8 4977.6 5061.4 5065.0 4849.3 4972.0 5000.7 5078.8 5109.3 5040.0 5043.1 5054.7 5066.4 5126.4 4852.5 5101.1 5110.0 5114.2 5136.7 3801.1 3833.9 3886.9 3915.9 3924.5 3473.7 3511.0 3519.2 3534.6 3570.2 4371.5 4817.7 4825.4 4830.6 4854.2 4844.1 4898.3 5004.7 5115.0 5179.2 4661.3 4682.2 4694.6 4696.7 4734.5 4180.0 4369.0 4390.2 4453.4 4460.8 4820.3 4887.6 4985.8 5002.9 5052.5 4992.6 5076.1 5103.7 5143.6 5184.1 4993.4 5088.0 5144.1 5155.0 5167.9 4900.4 4932.5 5000.3 5002.6 5058.8 5123.2 5130.9 5150.6 5161.5 5171.7 4738.7 5067.4 5076.6 5145.0 5150.7 4547.0 4789.4 4902.6 4934.0 4963.1 4888.9 4928.7 4935.0 4997.9 5005.6 4671.7 5012.2 5022.2 5049.9 5088.1 4759.9 4868.8 4890.0 4908.4 4965.3 14:34:59 INFO - 2015-11-25 14:34:59,131 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,131 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42176.50 Median:172694.84 stddev:71121.18 (41.2%) stddev-sans-first:71251.82 14:34:59 INFO - 2015-11-25 14:34:59,131 DEBUG : BROWSER_OUTPUT: Values: 489.8 492.8 493.5 507.6 527.1 28341.3 29680.4 35577.6 36231.8 36788.4 36844.4 38687.8 39045.6 39811.6 39903.0 7327.5 7956.6 8155.0 8165.3 8169.6 7465.0 9650.0 9895.7 9929.8 9984.9 9285.4 9621.4 9707.7 9774.2 9787.5 7625.5 7817.1 9466.5 9609.7 9742.2 9490.7 9499.5 9590.1 9635.3 9712.6 36013.0 36884.8 36949.4 36957.6 36969.0 2702.9 2781.1 2888.1 3005.1 3049.5 24088.2 24145.8 24296.8 24404.1 24463.9 2040.9 2041.1 2042.4 2144.7 2157.1 255924.0 256059.0 258363.0 260445.0 260574.0 51777.2 53022.0 53674.7 54246.7 54641.0 61267.4 63289.4 63940.4 64009.0 64022.7 14640.6 14769.6 14853.6 14853.7 14858.2 11355.4 11392.8 11404.9 11481.5 11576.7 17475.0 17643.5 17819.0 17837.6 18284.5 7579.0 7741.7 7759.7 7824.0 7839.2 797.0 878.5 901.5 903.6 1010.5 25880.6 26522.6 26754.9 26921.9 26976.0 848.6 874.0 951.2 971.4 1040.9 11196.8 12443.1 12490.4 12492.8 12594.7 300441.0 311754.0 312621.0 314034.0 314553.0 45782.3 46507.0 46691.8 46904.1 47246.8 1235.8 1246.4 1249.0 1249.5 1257.2 23220.2 23542.5 23917.5 24482.3 25345.6 42581.1 42609.4 42714.8 43295.6 43322.4 232738.0 238822.0 242704.0 244110.0 244974.0 25291.4 25429.4 27844.9 28272.9 28982.3 33196.2 33604.8 34150.7 34165.3 34517.5 29385.9 30293.4 30720.7 31284.7 31664.4 24912.8 28014.0 31337.4 31355.7 31823.4 30962.3 31706.2 31764.7 31848.8 32123.7 24799.7 24883.8 27866.3 27902.7 28026.3 19673.7 20789.0 20947.9 21432.2 21433.9 14:34:59 INFO - 2015-11-25 14:34:59,131 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,132 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24179.18 Median:23115.36 stddev:81235.17 (351.4%) stddev-sans-first:81443.26 14:34:59 INFO - 2015-11-25 14:34:59,133 DEBUG : BROWSER_OUTPUT: Values: 299.5 300.3 301.0 309.4 309.9 12984.4 13431.7 15276.2 15687.8 15781.1 10466.8 10531.2 10745.0 13306.4 15603.4 3742.1 3845.4 3845.8 3848.2 3850.4 3043.4 3161.7 3716.1 3816.0 4151.7 4088.4 4127.4 4142.3 4189.8 4201.9 4120.4 4137.0 4180.0 4195.9 4198.6 3436.2 3529.8 3532.5 3562.4 3564.5 11507.8 11530.9 11560.7 11613.4 11759.7 1550.1 1601.6 1622.2 1630.3 1721.4 8326.1 8440.1 8441.4 8464.0 8792.8 1346.3 1351.4 1375.5 1387.2 1448.8 51141.2 52539.0 53561.0 53697.7 54384.6 5779.4 5905.6 5908.1 5952.6 5956.1 6573.7 6663.6 6684.5 6706.3 6776.0 4687.5 4737.5 4744.6 4799.8 4967.4 4624.2 4842.4 4864.1 4867.9 4962.8 2567.9 2646.6 2652.9 2658.2 2668.5 929.4 939.5 943.1 948.5 998.8 336.2 348.3 374.9 383.0 418.4 10045.9 10116.7 10429.6 10568.9 10851.9 362.6 389.6 402.5 409.4 413.6 5442.2 5657.7 5872.9 5875.2 5900.2 478076.0 490011.0 490736.0 507496.0 510818.0 66183.3 67530.0 67701.0 68548.0 70683.3 453.3 456.9 459.2 461.2 463.7 9960.2 9970.5 10002.3 10029.9 10237.5 30943.7 31829.0 31857.2 31868.0 32137.5 39297.8 39331.8 41073.0 42028.8 43804.3 5422.3 5542.7 5640.5 5643.3 5649.3 10384.2 10488.5 10783.6 10814.6 10924.1 8936.6 9137.6 9327.5 9341.6 9343.7 8890.9 9045.5 9056.0 9061.9 9202.2 9068.0 9329.8 9403.6 9417.0 9522.7 5068.8 5302.8 5443.8 5502.9 5588.9 8923.6 8989.0 9112.5 9214.3 9365.8 14:34:59 INFO - 2015-11-25 14:34:59,134 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,134 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4712.29 Median:6072.32 stddev:2493.07 (41.1%) stddev-sans-first:2481.86 14:34:59 INFO - 2015-11-25 14:34:59,135 DEBUG : BROWSER_OUTPUT: Values: 705.6 1225.3 1230.4 1239.0 1587.6 6263.6 6317.5 6430.8 6700.6 6933.8 6697.8 6728.8 6801.5 6826.3 6840.1 1876.1 1882.2 1906.6 1910.2 1918.8 1946.3 2007.3 2009.6 2014.3 2019.0 1941.8 1978.0 1989.1 1991.8 1994.2 1876.7 1888.5 1902.8 1907.4 1907.6 1926.7 1941.2 1951.9 1971.6 1977.8 6730.4 6817.2 6819.9 6839.7 6878.1 3612.8 3755.1 4110.1 4205.6 4224.5 2580.2 2594.6 2601.4 2641.1 2676.9 803.0 816.9 818.3 823.1 836.3 9186.6 9247.4 9251.4 9258.6 9370.6 3811.0 3865.2 3877.1 3881.0 3930.6 7723.0 8110.1 8119.3 8120.0 8133.6 4261.2 4276.3 4282.0 4302.4 4320.6 3818.8 3863.7 3868.2 3874.6 3928.5 3157.4 3172.8 3194.3 3199.2 3221.3 961.3 1001.2 1004.5 1009.5 1011.6 840.1 860.1 864.0 871.6 1026.9 6043.0 6102.9 6169.9 6170.9 6275.7 411.2 420.1 425.5 429.7 431.3 4362.3 4396.1 4443.7 4503.3 4846.9 7320.2 7961.0 8080.5 8081.4 8084.9 7821.5 7912.6 8037.3 8038.4 8074.2 6286.8 6322.2 6368.6 6494.2 6517.6 6279.9 6298.3 6375.1 6381.4 6426.0 7260.0 7283.8 7408.8 7427.3 7442.8 7426.8 7534.8 7664.8 7671.8 7681.2 5904.7 6050.8 6096.2 6109.0 6160.3 6594.6 6663.8 6712.4 6720.2 6722.5 5843.7 6228.8 6230.8 6300.8 6321.9 6038.2 6056.1 6088.5 6107.0 6212.2 5885.2 6144.7 6242.3 6281.9 6290.2 5335.6 5437.8 5442.9 5448.2 5449.5 5376.3 5401.4 5430.0 5512.2 5545.4 14:34:59 INFO - 2015-11-25 14:34:59,136 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,136 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4569.97 Median:5230.98 stddev:1359.79 (26.0%) stddev-sans-first:1324.82 14:34:59 INFO - 2015-11-25 14:34:59,136 DEBUG : BROWSER_OUTPUT: Values: 273.8 280.8 285.8 289.4 289.4 5176.3 5178.8 5198.3 5232.3 5339.6 5054.6 5128.4 5180.2 5229.6 5252.1 4111.2 4127.7 4159.1 4165.0 4177.5 3969.4 4050.4 4059.6 4137.1 4170.5 4067.9 4111.5 4127.2 4142.0 4183.3 4070.3 4084.1 4097.3 4103.4 4122.2 3443.8 3564.5 3576.5 3577.1 3580.6 5008.8 5016.0 5040.3 5042.7 5051.3 4554.8 4573.0 4593.8 4594.1 4606.4 5307.7 5387.6 5486.6 5493.1 5508.1 3777.1 3839.8 3840.3 3846.3 3851.6 5538.1 5724.3 5732.1 5746.3 5769.1 3747.9 3760.9 3793.9 3802.8 3825.5 3824.4 3882.4 3888.3 3890.7 3892.3 4503.4 4506.3 4509.0 4515.6 4516.3 5420.7 5499.9 5514.8 5527.6 5535.8 1283.0 1368.0 1386.5 1402.6 1407.3 874.8 895.1 901.7 906.1 915.8 5084.8 5085.4 5152.8 5170.0 5180.6 5476.4 5487.3 5518.5 5579.2 5605.2 5078.4 5164.8 5206.2 5239.8 5245.9 3060.6 3075.0 3129.1 3137.5 3199.6 5660.2 5666.3 5667.5 5676.2 5679.1 5699.3 5753.4 5770.7 5787.9 5820.1 5672.4 5691.8 5703.7 5725.1 5726.4 5589.2 5696.9 5705.5 5716.9 5727.4 5413.0 5555.6 5557.1 5604.0 5691.1 5615.6 5634.4 5635.4 5643.8 5645.4 3584.2 3585.3 3646.0 3679.8 3682.7 5554.5 5631.3 5639.8 5640.4 5655.4 5058.5 5369.3 5387.5 5424.1 5439.5 5436.5 5444.3 5466.0 5502.8 5568.4 5318.2 5344.9 5346.0 5358.8 5470.5 5323.1 5475.5 5497.4 5516.0 5530.0 5284.4 5348.8 5390.5 5453.7 5535.2 14:34:59 INFO - 2015-11-25 14:34:59,136 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,136 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12080.43 Median:27518.76 stddev:14579.04 (53.0%) stddev-sans-first:14594.33 14:34:59 INFO - 2015-11-25 14:34:59,138 DEBUG : BROWSER_OUTPUT: Values: 573.5 609.6 615.3 619.4 631.5 11708.2 12075.8 12318.2 12325.9 12329.0 12381.2 12578.0 12618.0 12629.7 12904.4 633.3 746.7 766.1 777.7 778.2 621.5 742.1 762.1 764.8 774.2 780.8 801.6 808.0 816.7 820.1 648.6 649.7 789.0 813.5 814.2 597.6 600.4 601.2 602.0 607.9 11706.1 12332.9 12336.6 12454.0 12504.7 10208.9 10232.9 10406.8 10694.7 10955.5 7721.6 7997.3 8167.5 8179.7 8181.0 2839.2 2913.1 2926.6 2938.9 2953.2 40185.8 44032.8 45377.8 45763.5 46229.5 7349.9 7833.8 7836.5 7901.4 7940.4 16926.9 17105.4 17131.9 17218.1 17222.5 6141.1 6256.7 6341.8 6367.8 6396.3 3329.8 3337.4 3372.1 3398.5 3411.0 2561.0 2640.6 2642.6 2643.5 2643.9 364.6 371.6 376.3 376.7 376.8 436.9 442.7 453.7 466.3 507.2 6276.2 6564.3 6577.5 6612.8 7609.4 426.3 446.0 446.6 448.9 516.3 2980.3 3132.2 3188.7 3202.6 3264.6 49495.0 50330.2 54521.2 55022.2 55276.7 44398.0 44735.8 45040.0 45196.0 45447.5 42272.6 42559.8 42839.4 43560.3 43571.3 6877.8 6911.5 7137.6 7151.4 7234.5 29198.1 29573.3 31469.8 31500.5 32199.8 38701.6 39113.0 39229.6 40295.8 40439.6 6622.8 6925.3 6931.0 6954.7 7102.1 9893.2 10024.4 10060.9 10121.4 10139.9 8929.3 9195.7 9459.4 9525.2 9532.4 9448.8 9471.8 9533.4 9572.8 9680.8 9033.1 9070.2 9125.0 9150.7 9156.3 8085.9 8257.6 8262.5 8337.7 8342.8 7734.7 7933.1 8000.6 8129.6 8338.8 14:34:59 INFO - 2015-11-25 14:34:59,138 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:34:59 INFO - 2015-11-25 14:34:59,138 DEBUG : BROWSER_OUTPUT: 14:34:59 INFO - 2015-11-25 14:34:59,811 INFO : Browser exited with error code: 0 14:34:59 INFO - 2015-11-25 14:34:59,844 INFO : Completed test dromaeo_css (00:18:35) 14:34:59 INFO - 2015-11-25 14:34:59,844 INFO : Starting test kraken 14:34:59 INFO - 2015-11-25 14:34:59,844 DEBUG : operating with platform_type : mac_ 14:34:59 INFO - 2015-11-25 14:34:59,844 INFO : Initialising browser for kraken test... 14:34:59 INFO - 2015-11-25 14:34:59,859 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmp0SB7oT/profile http://localhost:49264/getInfo.html 14:35:02 INFO - 2015-11-25 14:35:02,316 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:35:02 INFO - 2015-11-25 14:35:02,317 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:35:02 INFO - 2015-11-25 14:35:02,317 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:35:02 INFO - 2015-11-25 14:35:02,317 DEBUG : BROWSER_OUTPUT: __metrics 14:35:02 INFO - 2015-11-25 14:35:02,333 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:03 INFO - 2015-11-25 14:35:03,045 INFO : Browser initialized. 14:35:03 INFO - 2015-11-25 14:35:03,046 INFO : Running cycle 1/1 for kraken test... 14:35:03 INFO - 2015-11-25 14:35:03,046 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmp0SB7oT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:35:15 INFO - 2015-11-25 14:35:15,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 199008256 14:35:15 INFO - 2015-11-25 14:35:15,084 DEBUG : BROWSER_OUTPUT: 14:35:17 INFO - 2015-11-25 14:35:17,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:18 INFO - 2015-11-25 14:35:18,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 265461760 14:35:18 INFO - 2015-11-25 14:35:18,568 DEBUG : BROWSER_OUTPUT: 14:35:21 INFO - 2015-11-25 14:35:21,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 14:35:22 INFO - 2015-11-25 14:35:22,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 279375872 14:35:22 INFO - 2015-11-25 14:35:22,206 DEBUG : BROWSER_OUTPUT: 14:35:25 INFO - 2015-11-25 14:35:25,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 14:35:25 INFO - 2015-11-25 14:35:25,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 267816960 14:35:25 INFO - 2015-11-25 14:35:25,991 DEBUG : BROWSER_OUTPUT: 14:35:28 INFO - 2015-11-25 14:35:28,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 14:35:28 INFO - 2015-11-25 14:35:28,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 269168640 14:35:28 INFO - 2015-11-25 14:35:28,858 DEBUG : BROWSER_OUTPUT: 14:35:31 INFO - 2015-11-25 14:35:31,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:31 INFO - 2015-11-25 14:35:31,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 269254656 14:35:31 INFO - 2015-11-25 14:35:31,856 DEBUG : BROWSER_OUTPUT: 14:35:35 INFO - 2015-11-25 14:35:35,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:35 INFO - 2015-11-25 14:35:35,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 269193216 14:35:35 INFO - 2015-11-25 14:35:35,898 DEBUG : BROWSER_OUTPUT: 14:35:39 INFO - 2015-11-25 14:35:39,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:40 INFO - 2015-11-25 14:35:40,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 265482240 14:35:40 INFO - 2015-11-25 14:35:40,050 DEBUG : BROWSER_OUTPUT: 14:35:43 INFO - 2015-11-25 14:35:43,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 14:35:43 INFO - 2015-11-25 14:35:43,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 267948032 14:35:43 INFO - 2015-11-25 14:35:43,922 DEBUG : BROWSER_OUTPUT: 14:35:45 INFO - 2015-11-25 14:35:45,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:46 INFO - 2015-11-25 14:35:46,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 298610688 14:35:46 INFO - 2015-11-25 14:35:46,242 DEBUG : BROWSER_OUTPUT: 14:35:48 INFO - 2015-11-25 14:35:48,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:48 INFO - 2015-11-25 14:35:48,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 300371968 14:35:48 INFO - 2015-11-25 14:35:48,886 DEBUG : BROWSER_OUTPUT: 14:35:51 INFO - 2015-11-25 14:35:51,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:51 INFO - 2015-11-25 14:35:51,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 308133888 14:35:51 INFO - 2015-11-25 14:35:51,767 DEBUG : BROWSER_OUTPUT: 14:35:54 INFO - 2015-11-25 14:35:54,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:55 INFO - 2015-11-25 14:35:55,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 308645888 14:35:55 INFO - 2015-11-25 14:35:55,250 DEBUG : BROWSER_OUTPUT: 14:35:58 INFO - 2015-11-25 14:35:58,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:58 INFO - 2015-11-25 14:35:58,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 308768768 14:35:58 INFO - 2015-11-25 14:35:58,696 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 14:36:00 INFO - 2015-11-25 14:36:00,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 367915008 14:36:00 INFO - 2015-11-25 14:36:00,885 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: |0;ai-astar;125;123;127;131;134;129;132;129;127;128 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;168;200;202;155;177;149;187;180;150 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;188;189;197;192;187;189;189;189;196 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: |3;audio-fft;87;92;94;143;81;85;85;85;138;80 14:36:00 INFO - 2015-11-25 14:36:00,886 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;115;158;108;108;103;139;103;103;148 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;141;136;148;140;135;135;148;141;136;137 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;154;152;147;147;153;150;148;146;154 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;124;123;125;120;119;120;124;124;124 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;71;73;74;72;72;73;83;68;66 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;76;77;79;78;78;78;82;82;83 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;94;100;100;99;99;100;100;100;99 14:36:00 INFO - 2015-11-25 14:36:00,887 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;140;148;149;145;144;149;145;150;147;153 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;155;172;175;166;166;172;165;175;176 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;76;80;83;85;85;84;84;85;82 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,940 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:36:00 INFO - 2015-11-25 14:36:00,888 DEBUG : BROWSER_OUTPUT: __startTimestamp1448490960879__endTimestamp 14:36:00 INFO - 2015-11-25 14:36:00,889 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,889 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:36:00 INFO - 2015-11-25 14:36:00,889 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:36:00 INFO - 2015-11-25 14:36:00,889 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,889 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:128.50 Median:129.00 stddev:3.27 (2.5%) stddev-sans-first:3.22 14:36:00 INFO - 2015-11-25 14:36:00,889 DEBUG : BROWSER_OUTPUT: Values: 125.0 123.0 127.0 131.0 134.0 129.0 132.0 129.0 127.0 128.0 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:173.40 Median:178.50 stddev:19.24 (10.8%) stddev-sans-first:20.22 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: Values: 166.0 168.0 200.0 202.0 155.0 177.0 149.0 187.0 180.0 150.0 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:190.00 Median:189.00 stddev:3.97 (2.1%) stddev-sans-first:3.57 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: Values: 184.0 188.0 189.0 197.0 192.0 187.0 189.0 189.0 189.0 196.0 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,890 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.00 Median:85.00 stddev:23.35 (27.5%) stddev-sans-first:24.49 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: Values: 87.0 92.0 94.0 143.0 81.0 85.0 85.0 85.0 138.0 80.0 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.30 Median:111.50 stddev:20.84 (18.7%) stddev-sans-first:21.70 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: Values: 108.0 115.0 158.0 108.0 108.0 103.0 139.0 103.0 103.0 148.0 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.70 Median:140.50 stddev:4.95 (3.5%) stddev-sans-first:5.22 14:36:00 INFO - 2015-11-25 14:36:00,891 DEBUG : BROWSER_OUTPUT: Values: 141.0 136.0 148.0 140.0 135.0 135.0 148.0 141.0 136.0 137.0 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.90 Median:151.00 stddev:3.11 (2.1%) stddev-sans-first:3.22 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: Values: 148.0 154.0 152.0 147.0 147.0 153.0 150.0 148.0 146.0 154.0 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.20 Median:124.00 stddev:2.39 (1.9%) stddev-sans-first:2.24 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: Values: 119.0 124.0 123.0 125.0 120.0 119.0 120.0 124.0 124.0 124.0 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,892 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:72.50 stddev:5.94 (8.2%) stddev-sans-first:4.72 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: Values: 60.0 71.0 73.0 74.0 72.0 72.0 73.0 83.0 68.0 66.0 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.70 Median:78.50 stddev:2.87 (3.7%) stddev-sans-first:2.49 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 77.0 79.0 78.0 78.0 78.0 82.0 82.0 83.0 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:94.00 stddev:2.42 (2.6%) stddev-sans-first:1.94 14:36:00 INFO - 2015-11-25 14:36:00,893 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 100.0 100.0 99.0 99.0 100.0 100.0 100.0 99.0 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:148.50 stddev:3.65 (2.5%) stddev-sans-first:2.86 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: Values: 140.0 148.0 149.0 145.0 144.0 149.0 145.0 150.0 147.0 153.0 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:172.00 stddev:7.30 (4.2%) stddev-sans-first:6.79 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: Values: 158.0 155.0 172.0 175.0 166.0 166.0 172.0 165.0 175.0 176.0 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.10 Median:84.00 stddev:3.35 (4.0%) stddev-sans-first:3.00 14:36:00 INFO - 2015-11-25 14:36:00,894 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 80.0 83.0 85.0 85.0 84.0 84.0 85.0 82.0 14:36:00 INFO - 2015-11-25 14:36:00,895 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:36:00 INFO - 2015-11-25 14:36:00,895 DEBUG : BROWSER_OUTPUT: 14:36:01 INFO - 2015-11-25 14:36:01,602 INFO : Browser exited with error code: 0 14:36:01 INFO - 2015-11-25 14:36:01,658 INFO : Completed test kraken (00:01:01) 14:36:01 INFO - 2015-11-25 14:36:01,658 INFO : Starting test v8_7 14:36:01 INFO - 2015-11-25 14:36:01,659 DEBUG : operating with platform_type : mac_ 14:36:01 INFO - 2015-11-25 14:36:01,659 INFO : Initialising browser for v8_7 test... 14:36:01 INFO - 2015-11-25 14:36:01,674 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpi47_cG/profile http://localhost:49264/getInfo.html 14:36:04 INFO - 2015-11-25 14:36:04,145 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:36:04 INFO - 2015-11-25 14:36:04,145 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:36:04 INFO - 2015-11-25 14:36:04,145 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:36:04 INFO - 2015-11-25 14:36:04,145 DEBUG : BROWSER_OUTPUT: __metrics 14:36:04 INFO - 2015-11-25 14:36:04,161 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:36:04 INFO - 2015-11-25 14:36:04,867 INFO : Browser initialized. 14:36:04 INFO - 2015-11-25 14:36:04,868 INFO : Running cycle 1/1 for v8_7 test... 14:36:04 INFO - 2015-11-25 14:36:04,868 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpi47_cG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:36:16 INFO - 2015-11-25 14:36:16,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 198709248 14:36:16 INFO - 2015-11-25 14:36:16,914 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 14:36:39 INFO - 2015-11-25 14:36:39,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 519712768 14:36:39 INFO - 2015-11-25 14:36:39,758 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,758 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:36:39 INFO - 2015-11-25 14:36:39,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: |0;Richards;192.7153594141453 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;216.26297577854672 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: |2;Encrypt;375.9398496240602 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7583.333333333333 14:36:39 INFO - 2015-11-25 14:36:39,759 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1211.864406779661 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: |5;Earley;805.8017727639001 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: |6;Boyer;14720.588235294117 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: |7;RegExp;34706.89655172414 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: |8;Splay;695.8942240779402 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6836.734693877551 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: __startTimestamp1448490999750__endTimestamp 14:36:39 INFO - 2015-11-25 14:36:39,760 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:192.72 Median:192.72 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: Values: 192.7 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:216.26 Median:216.26 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: Values: 216.3 14:36:39 INFO - 2015-11-25 14:36:39,761 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:375.94 Median:375.94 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: Values: 375.9 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7583.33 Median:7583.33 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: Values: 7583.3 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1211.86 Median:1211.86 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,762 DEBUG : BROWSER_OUTPUT: Values: 1211.9 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:805.80 Median:805.80 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: Values: 805.8 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14720.59 Median:14720.59 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: Values: 14720.6 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34706.90 Median:34706.90 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: Values: 34706.9 14:36:39 INFO - 2015-11-25 14:36:39,763 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: Values: 695.9 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6836.73 Median:6836.73 stddev:0.00 (0.0%) 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: Values: 6836.7 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:36:39 INFO - 2015-11-25 14:36:39,764 DEBUG : BROWSER_OUTPUT: 14:36:40 INFO - 2015-11-25 14:36:40,456 INFO : Browser exited with error code: 0 14:36:40 INFO - 2015-11-25 14:36:40,479 INFO : Completed test v8_7 (00:00:38) 14:36:40 INFO - 2015-11-25 14:36:40,785 INFO : Completed test suite (00:20:16) 14:36:40 INFO - 2015-11-25 14:36:40,785 DEBUG : Working with test: dromaeo_css 14:36:40 INFO - 2015-11-25 14:36:40,785 DEBUG : Generating results file: dromaeo_css 14:36:40 INFO - 2015-11-25 14:36:40,785 DEBUG : Working with test: kraken 14:36:40 INFO - 2015-11-25 14:36:40,786 DEBUG : Generating results file: kraken 14:36:40 INFO - 2015-11-25 14:36:40,786 INFO : javascript benchmark 14:36:40 INFO - 2015-11-25 14:36:40,786 DEBUG : Working with test: v8_7 14:36:40 INFO - 2015-11-25 14:36:40,786 DEBUG : Generating results file: v8_7 14:36:40 INFO - 2015-11-25 14:36:40,786 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:36:40 INFO - 2015-11-25 14:36:40,917 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 14:36:40 INFO - 2015-11-25 14:36:40,918 DEBUG : process_Request line: dromaeo_css 5782.18 graph.html#tests=[[72,52,55]] 14:36:40 INFO - 2015-11-25 14:36:40,918 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:36:40 INFO - 2015-11-25 14:36:40,960 DEBUG : process_Request line: kraken 1765.50 graph.html#tests=[[232,52,55]] 14:36:40 INFO - 2015-11-25 14:36:40,960 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:36:40 INFO - 2015-11-25 14:36:40,996 DEBUG : process_Request line: v8_7 17183.27 graph.html#tests=[[230,52,55]] 14:36:40 INFO - 2015-11-25 14:36:40,997 INFO : javascript benchmark 14:36:41 INFO - 2015-11-25 14:36:40,999 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [299.52824301724763, 300.3467458278244, 301.0321815363606, 309.3642564529891, 309.85746556583985, 12984.350782460886, 13431.664208394795, 15276.159811210378, 15687.764683529742, 15781.053136811799, 10466.842997355026, 10531.21015923805, 10745.0, 13306.401211945462, 15603.375864965416, 3742.0644838790236, 3845.403962385835, 3845.788481633509, 3848.2303539292116, 3850.3646898261895, 3043.3913217356508, 3161.731252843511, 3716.0709822544363, 3815.9809200953955, 4151.73013754105, 4088.407180958759, 4127.422160897462, 4142.2543942090415, 4189.7695626740515, 4201.936970945439, 4120.443740095079, 4137.0, 4180.038591124028, 4195.8741237762615, 4198.6221240088535, 3436.226848958989, 3529.8235088245483, 3532.540769699948, 3562.412201986695, 3564.536610240652, 11507.827382589185, 11530.942345288304, 11560.6531804046, 11613.419329033515, 11759.706007349885, 1550.0854495847504, 1601.6396310830087, 1622.22944101552, 1630.2663801289468, 1721.397510871185, 8326.125756795509, 8440.11378805229, 8441.366897482714, 8464.0, 8792.780180495474, 1346.3402932563072, 1351.3918736568583, 1375.4979432507064, 1387.1538361599416, 1448.7826825976083, 51141.23288150681, 52539.0, 53561.0, 53697.73151134259, 54384.59770803987, 5779.364269930388, 5905.616134951214, 5908.084246941731, 5952.613080149777, 5956.076808094752, 6573.704183311763, 6663.633955039205, 6684.465242780566, 6706.295838936939, 6776.0, 4687.507811679793, 4737.502562230985, 4744.620430365562, 4799.832005879777, 4967.428745694219, 4624.237000894815, 4842.394700662418, 4864.075825593126, 4867.902641947141, 4962.751862406865, 2567.8587677677906, 2646.563317052703, 2652.867356632161, 2658.2291135570467, 2668.4529671417313, 929.3633860805235, 939.5349302095507, 943.0852073488705, 948.5020364308793, 998.7553049502918, 336.15792439938286, 348.27475008062015, 374.92314075614433, 382.97510661806893, 418.4079527468598, 10045.949770251102, 10116.747081323027, 10429.58878934066, 10568.947155264175, 10851.945740271249, 362.5631114507013, 389.56563431773367, 402.49047190765555, 409.38796499233837, 413.6339339684401, 5442.2108794225405, 5657.717114144276, 5872.941270587239, 5875.177475153482, 5900.203472531153, 478076.0, 490011.0, 490736.0, 507496.0, 510818.0, 66183.33816661868, 67530.0, 67701.0, 68548.0, 70683.29316706768, 453.3313362789859, 456.8857785553612, 459.16432093590015, 461.2389557230529, 463.726401423162, 9960.153386962189, 9970.50147492637, 10002.349847259904, 10029.949850250994, 10237.488125593542, 30943.69056309498, 31829.0, 31857.203569910936, 31868.0, 32137.517937230492, 39297.80351098341, 39331.803340984254, 41073.0, 42028.78985605175, 43804.34293485664, 5422.267993820941, 5542.695151766691, 5640.492355688008, 5643.322801263875, 5649.322081350264, 10384.221183411426, 10488.475576221006, 10783.568657253621, 10814.621488247874, 10924.071453926505, 8936.597853096757, 9137.5888085035, 9327.533623318672, 9341.57962891658, 9343.71968840936, 8890.866637000321, 9045.502497362708, 9055.954720226357, 9061.909380906107, 9202.217811486098, 9067.954660226656, 9329.766755831159, 9403.576839042396, 9417.0, 9522.714318570454, 5068.82259120929, 5302.8144014960835, 5443.836684899459, 5502.944970550243, 5588.944110558842, 8923.598438070172, 8988.955055224682, 9112.544372781467, 9214.308926830381, 9365.765855853386], "dojo.html": [2701.459708058388, 2754.311422144464, 2759.5170845102116, 2770.7921905857065, 2790.958135627966, 4676.696014759038, 4681.250999840026, 4686.109639168556, 4703.576678098971, 4775.044991001801, 4517.435320584927, 4641.9071618567605, 4679.485256621778, 4690.530946905308, 4747.62019038477, 4347.260965635834, 4357.651387888977, 4368.584984426474, 4428.712133711307, 4552.567506086916, 4358.585934336233, 4443.111377724452, 4488.573585509388, 4534.0, 4570.040291538781, 4234.343676730112, 4410.31640095784, 4429.0, 4448.466184057917, 4535.7958891849785, 4460.286354183315, 4571.862844114682, 4578.427696537933, 4597.517260687613, 4629.884252893671, 4184.895377615553, 4329.805158767863, 4348.326009468537, 4424.513303536608, 4477.507474177838, 4475.351074094271, 4770.022145460172, 4773.498782627844, 4804.327394164819, 4907.779149938261, 5080.339555857715, 5146.588272938156, 5158.277841102249, 5186.273921650972, 5199.974000130013, 4840.419149702058, 5076.0, 5187.870303242411, 5210.478952104797, 5233.0, 4554.635629149726, 4572.542745725401, 4689.906201875943, 4716.1510928033285, 4774.880627984258, 5219.921701174486, 5242.9737851311265, 5243.344581927259, 5273.1299335609965, 5276.472352764693, 4709.576138147583, 4973.751312434364, 4977.626677999092, 5061.417936937226, 5065.0, 4849.2968519564465, 4971.975140124277, 5000.74996250186, 5078.847634570969, 5109.284700141983, 5039.966806804597, 5043.067032598981, 5054.7472626368535, 5066.392032956069, 5126.384833819965, 4852.51474852519, 5101.0818052750865, 5110.029094472038, 5114.15616423286, 5136.743162841918, 3801.0877389426337, 3833.884983450501, 3886.8639597613947, 3915.8629447969183, 3924.529056513237, 3473.6873681368293, 3510.982445087809, 3519.1554027033326, 3534.6465353464964, 3570.232400034005, 4371.519132895379, 4817.686850354786, 4825.372701548847, 4830.6135509159185, 4854.2233242681, 4844.079624871263, 4898.265260210926, 5004.749762511859, 5115.0, 5179.171332586768, 4661.277501987197, 4682.157211701859, 4694.600958918462, 4696.718196908197, 4734.455537613218, 4179.958200418017, 4368.978155109204, 4390.1878152541885, 4453.376527286183, 4460.754658493749, 4820.25286080658, 4887.584555312767, 4985.775640096132, 5002.874928126753, 5052.46949070357, 4992.550670439678, 5076.060928728197, 5103.693778373309, 5143.6399452037995, 5184.144616138295, 4993.400791904995, 5087.974560127176, 5144.125498665311, 5155.046316431472, 5167.870803229949, 4900.411950565955, 4932.457429682804, 5000.349954505891, 5002.649814512949, 5058.797648094035, 5123.205903085028, 5130.923036154535, 5150.639455238097, 5161.458046905021, 5171.689698618095, 4738.715677059387, 5067.391912970467, 5076.593872490118, 5145.0, 5150.665206761549, 4546.954530454653, 4789.425268967746, 4902.558769710743, 4934.01319736047, 4963.057019166346, 4888.926666100083, 4928.67963582366, 4934.950650493593, 4997.875053123701, 5005.599552035756, 4671.719696818202, 5012.172991456368, 5022.196448568212, 5049.924251136309, 5088.135017047185, 4759.881002974953, 4868.805247790048, 4890.021995600823, 4908.4355299139625, 4965.304857319906], "mootools.html": [705.59428328711, 1225.3015781004829, 1230.4340003598345, 1239.0, 1587.5554844643498, 6263.592866463682, 6317.494600431966, 6430.807075787722, 6700.631465269408, 6933.791986240408, 6697.832554186136, 6728.764493242737, 6801.523893327469, 6826.283240259776, 6840.076589660394, 1876.0900963032918, 1882.1812511557482, 1906.6377388296248, 1910.245453046053, 1918.8486907855315, 1946.2506934830121, 2007.317512045904, 2009.588034452941, 2014.315132854829, 2018.959620807583, 1941.834944029752, 1978.0406502846108, 1989.1247850945538, 1991.8148701522643, 1994.1624517702528, 1876.6997280435132, 1888.490107670928, 1902.838258748008, 1907.4468404162776, 1907.6184763047445, 1926.7206255092933, 1941.1652989214633, 1951.8926459044746, 1971.6451038813009, 1977.7824439311664, 6730.394264516217, 6817.216020157695, 6819.863602727967, 6839.726410943556, 6878.105846239957, 3612.8193590320643, 3755.0987762936697, 4110.095778928631, 4205.621494065518, 4224.45082139323, 2580.2259322203263, 2594.610808378758, 2601.414681696622, 2641.1152263991585, 2676.852773097479, 802.9558374289412, 816.873384625384, 818.3330585572799, 823.0781524692324, 836.2975100915261, 9186.586603602855, 9247.352685312031, 9251.444913305224, 9258.6296548138, 9370.57832397537, 3810.9519882032664, 3865.16898866745, 3877.108265099043, 3881.029742564359, 3930.6462418382484, 7723.034620672416, 8110.067342255598, 8119.269265766109, 8119.959400203079, 8133.59332033396, 4261.190373829025, 4276.31578947367, 4282.0, 4302.44068271129, 4320.567943205717, 3818.770873747584, 3863.74885632433, 3868.207017561393, 3874.6319099685484, 3928.548216955087, 3157.3527426877436, 3172.7620428467494, 3194.3291908699434, 3199.232184275757, 3221.3074189049, 961.3270710502676, 1001.1840350114634, 1004.5479534209635, 1009.4700282351678, 1011.6155860772859, 840.0717207485641, 860.0883063952231, 864.0409145848104, 871.5990644303691, 1026.897310268982, 6043.0, 6102.908456373158, 6169.938300616936, 6170.938290617126, 6275.717592708339, 411.2084237842142, 420.08631227080974, 425.5085376390274, 429.6906227516183, 431.2883741826012, 4362.345648152803, 4396.07682386696, 4443.733375997451, 4503.347014682852, 4846.878828029327, 7320.1581818090535, 7961.0, 8080.474769139987, 8081.353491720648, 8084.919150808417, 7821.530708157528, 7912.564808935564, 8037.276645101969, 8038.397120216007, 8074.152214017444, 6286.842828929313, 6322.241331040213, 6368.64972426521, 6494.188226471785, 6517.576357536745, 6279.937200627935, 6298.307186209605, 6375.075614035846, 6381.425671689571, 6425.967870160619, 7259.963700181465, 7283.8179045522165, 7408.814779630552, 7427.294407031323, 7442.813929651802, 7426.777196684108, 7534.849303014019, 7664.770056898302, 7671.769846904602, 7681.231876812274, 5904.704764761831, 6050.788222412194, 6096.207493026056, 6109.0, 6160.260768707783, 6594.571352862049, 6663.833404164935, 6712.4294434971625, 6720.227173874871, 6722.495812813961, 5843.7370318336625, 6228.781992630236, 6230.7507699691505, 6300.810975670737, 6321.8735625288155, 6038.215032045806, 6056.091586262096, 6088.543359247986, 6106.969465152646, 6212.192414986023, 5885.176075349369, 6144.723487442986, 6242.344553821965, 6281.874362512633, 6290.24517057956, 5335.626506144533, 5437.8368648940595, 5442.863928401822, 5448.237246785374, 5449.509544141047, 5376.274202982548, 5401.432849550741, 5430.0, 5512.173174023928, 5545.417731138173], "ext.html": [489.7820469890899, 492.83490030839664, 493.5360760884768, 507.64458894751, 527.1223413017326, 28341.291467713316, 29680.406391872177, 35577.64422355779, 36231.81884090583, 36788.44817327742, 36844.44733329002, 38687.80656096723, 39045.60954390455, 39811.60188398115, 39903.0, 7327.4504412169035, 7956.562389068614, 8155.0, 8165.3059489943425, 8169.550674712888, 7464.9626751866435, 9650.0, 9895.703128906109, 9929.801403971916, 9984.850227246561, 9285.442873427583, 9621.374610650286, 9707.660231891885, 9774.16919561838, 9787.510624468783, 7625.542467451971, 7817.140114587391, 9466.526673666323, 9609.663661771874, 9742.22062235023, 9490.715278541655, 9499.477528735917, 9590.08894155054, 9635.277354198462, 9712.562934667956, 36013.0, 36884.81557592221, 36949.44575831365, 36957.630423695686, 36969.0, 2702.8513431761244, 2781.137847267333, 2888.1046875468674, 3005.0984704588536, 3049.5273232648974, 24088.15691450791, 24145.758542414704, 24296.757032429625, 24404.145854894992, 24463.877680611484, 2040.9183632654676, 2041.1223174035158, 2042.428120126367, 2144.710464087344, 2157.0508976050646, 255924.0, 256059.0, 258362.9999999981, 260445.0, 260574.0, 51777.22334164991, 53022.0, 53674.7316263424, 54246.728766356704, 54641.0, 61267.38732612706, 63289.36710632835, 63940.36059639344, 64009.0, 64022.6798866012, 14640.633984150269, 14769.630759231106, 14853.554393368217, 14853.737432318374, 14858.182799946107, 11355.432228388547, 11392.772144557228, 11404.885951140548, 11481.483333250024, 11576.652700419001, 17475.0, 17643.470695879143, 17819.0, 17837.554061148316, 18284.451466456027, 7579.0, 7741.742041876945, 7759.650815713194, 7824.0, 7839.176886426957, 796.9521828690297, 878.4553576782436, 901.4591245252927, 903.5708038681573, 1010.4998025977188, 25880.611790823154, 26522.602160967603, 26754.866225668746, 26921.86539067292, 26976.0, 848.6478111583747, 873.9825203495894, 951.2342564235856, 971.3783178765595, 1040.8542804007445, 11196.776064478665, 12443.066769992287, 12490.375481226085, 12492.81260781089, 12594.748105037848, 300441.0, 311754.0, 312621.0, 314034.0, 314553.0, 45782.31326530105, 46507.0, 46691.76654116776, 46904.061918761436, 47246.76376618095, 1235.7899157143306, 1246.4391024039037, 1248.9696000799195, 1249.5439164704817, 1257.1765493601706, 23220.187293444647, 23542.52914941726, 23917.521649566563, 24482.265532034067, 25345.619815702412, 42581.14837703166, 42609.36085958651, 42714.78642606767, 43295.56704432915, 43322.35016474818, 232738.0, 238822.0, 242704.0, 244110.0, 244974.0, 25291.367715807253, 25429.364265893502, 27844.886204551593, 28272.85863570669, 28982.27544311409, 33196.1700957478, 33604.80754328335, 34150.65849341475, 34165.31669366549, 34517.482237766955, 29385.85307073451, 30293.394132117675, 30720.692793071783, 31284.687153128176, 31664.366712666077, 24912.750872491768, 28014.0, 31337.37325253528, 31355.686443135277, 31823.363532728752, 30962.33476668216, 31706.207344816565, 31764.682353176173, 31848.840755796075, 32123.67876321207, 24799.725166666893, 24883.751162488144, 27866.30334241579, 27902.72097279001, 28026.2993425166, 19673.704894426883, 20789.0, 20947.8952605236, 21432.249871254433, 21433.892830535748], "prototype.html": [273.761827210327, 280.7922137618162, 285.8127926208334, 289.3735063587335, 289.3850567543969, 5176.301199338088, 5178.818741344054, 5198.272241886134, 5232.319798426204, 5339.626226164165, 5054.570361519266, 5128.43587205408, 5180.1970694542315, 5229.633925625208, 5252.107141785896, 4111.157212771374, 4127.690423218256, 4159.064210552617, 4164.97917510412, 4177.456930599018, 3969.3847453644585, 4050.412690159925, 4059.573744756802, 4137.13120244749, 4170.52039015514, 4067.9389809152885, 4111.48606424197, 4127.215828992482, 4142.0, 4183.288840897055, 4070.267351876661, 4084.14233011068, 4097.344424892033, 4103.4460347852955, 4122.175564887019, 3443.7933723976644, 3564.465330200465, 3576.535050443452, 3577.0520811984843, 3580.6240344763687, 5008.84973450797, 5016.046951079284, 5040.269160971675, 5042.697438153686, 5051.267566202917, 4554.795034223468, 4572.954270457286, 4593.770311484446, 4594.1271158479785, 4606.378138951266, 5307.708076055816, 5387.595930305203, 5486.561075114021, 5493.148561972901, 5508.091164957777, 3777.0934975605933, 3839.78881161536, 3840.2703486337787, 3846.307664620367, 3851.614838516154, 5538.113901775737, 5724.284464441945, 5732.0542110551705, 5746.333563266648, 5769.1346298055205, 3747.9437808432895, 3760.9435858462143, 3793.867214647474, 3802.8288727006798, 3825.464434979105, 3824.388097904322, 3882.3594106972596, 3888.2806680763583, 3890.6692931101175, 3892.2993861105274, 4503.392042074343, 4506.278995360726, 4508.954910450919, 4515.571020753023, 4516.322551617283, 5420.674759514442, 5499.945000549943, 5514.80698175562, 5527.585431092684, 5535.806246781343, 1282.9550965716155, 1368.0286996232587, 1386.4869998100767, 1402.6002589262216, 1407.268220525321, 874.7987962768599, 895.0557162193818, 901.6663834381189, 906.1029580715044, 915.8305713442901, 5084.847454576368, 5085.389753229636, 5152.793888244503, 5169.974150129226, 5180.559652429511, 5476.397596264408, 5487.341519017744, 5518.503334699816, 5579.218909352694, 5605.1872478491205, 5078.4413714491375, 5164.845054648366, 5206.167013277857, 5239.8166064188335, 5245.868853278698, 3060.586820779211, 3075.031365120025, 3129.0769223079246, 3137.51368537877, 3199.600049993751, 5660.2075709400715, 5666.320041595035, 5667.546596272288, 5676.205331253628, 5679.091345384802, 5699.287589051369, 5753.367129615739, 5770.711464426846, 5787.913181302284, 5820.126980952891, 5672.432756724294, 5691.772329106955, 5703.686297253608, 5725.112607545837, 5726.3700992890745, 5589.217509548585, 5696.886062278814, 5705.4579814917515, 5716.8570785729025, 5727.36998930109, 5412.972935135299, 5555.555555555627, 5557.083081291542, 5603.971980140073, 5691.117876729114, 5615.5507559395965, 5634.352049514358, 5635.380108188178, 5643.830685079454, 5645.40723224072, 3584.211473475831, 3585.2650206708086, 3646.0155757945736, 3679.7792132472136, 3682.6869716074434, 5554.50009499147, 5631.2960879890015, 5639.802606908738, 5640.435956404327, 5655.377908430151, 5058.54473097423, 5369.328833895763, 5387.542058925035, 5424.050791111618, 5439.537639300545, 5436.483534064258, 5444.292242008513, 5465.9726701366235, 5502.752376143163, 5568.415316391721, 5318.202269659582, 5344.866378340573, 5346.010987967238, 5358.812441564526, 5470.507654311131, 5323.1216849219445, 5475.479829416199, 5497.367802702581, 5516.0, 5529.972350138223, 5284.365876094893, 5348.7593058311695, 5390.4879036491475, 5453.672779633234, 5535.197396377423], "yui.html": [573.4867293772074, 609.6281268426261, 615.3262177915184, 619.4332186049764, 631.5263552335748, 11708.180427370087, 12075.758484830309, 12318.199317044397, 12325.876741232585, 12329.0, 12381.195222310544, 12578.0, 12618.0, 12629.684257893558, 12904.354782260896, 633.2875515045574, 746.6789280609336, 766.0615745711486, 777.7161336112307, 778.2295527427834, 621.502797761791, 742.0687037767622, 762.1387831750114, 764.7782143178472, 774.1871035412822, 780.7696729464822, 801.6272433318505, 807.9717209897655, 816.6610856494548, 820.1388542030874, 648.6043513456788, 649.6524359467709, 788.9763307100797, 813.4631143445328, 814.1858141858141, 597.641415150906, 600.3606159440183, 601.2304250559291, 601.9819405417844, 607.9331273559949, 11706.122040846885, 12332.876671233262, 12336.568220112253, 12454.0, 12504.749905001849, 10208.897911020944, 10232.948835255776, 10406.843897341547, 10694.73263168427, 10955.4522273886, 7721.575313357763, 7997.320227780646, 8167.469114507538, 8179.672813087469, 8180.9590952045455, 2839.1908306132655, 2913.0823790505924, 2926.590277361171, 2938.8824447022093, 2953.1878733348285, 40185.79907100446, 44032.77983610093, 45377.77311113424, 45763.542364576264, 46229.53770462286, 7349.853002939912, 7833.804154896059, 7836.451448398671, 7901.367890568741, 7940.367837540115, 16926.91536542334, 17105.401310954057, 17131.914340428466, 17218.139093045298, 17222.483325500005, 6141.109539116893, 6256.718447669866, 6341.841453963595, 6367.808965731036, 6396.328385519547, 3329.8002119872885, 3337.4493208620793, 3372.0558243691808, 3398.4732366483236, 3410.9937568417376, 2560.9871950640127, 2640.577507598775, 2642.643243162187, 2643.524165650163, 2643.867806609662, 364.5716283367033, 371.55970175342304, 376.3357673705911, 376.7306375941215, 376.76452217364147, 436.9235383807821, 442.71444918028334, 453.6529554890511, 466.33314360464186, 507.24167369781674, 6276.246850377984, 6564.343565643398, 6577.539572229898, 6612.8346791330605, 7609.391248700202, 426.3093788063357, 446.0432372560839, 446.6404544341771, 448.87655894628585, 516.3442428116347, 2980.344324248662, 3132.1543183340373, 3188.7449004079617, 3202.5676533667656, 3264.6245681746905, 49495.0, 50330.24504632434, 54521.1821822673, 55022.17466738002, 55276.72361638166, 44398.0, 44735.77632111819, 45040.0, 45196.0, 45447.54552454499, 42272.57727422748, 42559.78720106441, 42839.357409638884, 43560.34659480047, 43571.346429803576, 6877.759278425231, 6911.516193866582, 7137.571745695275, 7151.356377926011, 7234.493585448968, 29198.124056278346, 29573.26066848346, 31469.8426507866, 31500.527492087178, 32199.839000804845, 38701.6129838698, 39113.0, 39229.60770392259, 40295.79852100838, 40439.595604043585, 6622.801315960529, 6925.272846351262, 6930.965345173242, 6954.652267386711, 7102.147742270754, 9893.208543316661, 10024.398536087858, 10060.94969525177, 10121.392716437038, 10139.898601013896, 8929.285657147282, 9195.724128276162, 9459.38513996588, 9525.237980961645, 9532.428054316762, 9448.811023779623, 9471.810563788824, 9533.380330278787, 9572.760680982752, 9680.75798105053, 9033.096690330914, 9070.18368346852, 9125.0, 9150.679726209552, 9156.267498599962, 8085.8787118192095, 8257.57727118348, 8262.462939908886, 8337.708180213664, 8342.791430214293, 7734.729284475016, 7933.127355990721, 8000.639971201426, 8129.593520324079, 8338.79153021155]}, "summary": {"suite": 5782.1771758255, "subtests": {"jquery.html": {"filtered": 5879.99145690476, "value": 5879.99145690476}, "dojo.html": {"filtered": 4679.048038818696, "value": 4679.048038818696}, "mootools.html": {"filtered": 3768.434100061543, "value": 3768.434100061543}, "ext.html": {"filtered": 16574.23563322978, "value": 16574.23563322978}, "prototype.html": {"filtered": 4121.698671060551, "value": 4121.698671060551}, "yui.html": {"filtered": 5275.921912109224, "value": 5275.921912109224}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0003"}, "testrun": {"date": 1448489784, "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": "20151125131130", "branch": "Mozilla-Aurora", "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806"}}, {"talos_counters": {}, "results": {"audio-dft": [184.0, 188.0, 189.0, 197.0, 192.0, 187.0, 189.0, 189.0, 189.0, 196.0], "ai-astar": [125.0, 123.0, 127.0, 131.0, 134.0, 129.0, 132.0, 129.0, 127.0, 128.0], "imaging-gaussian-blur": [141.0, 136.0, 148.0, 140.0, 135.0, 135.0, 148.0, 141.0, 136.0, 137.0], "audio-beat-detection": [166.0, 168.0, 200.0, 202.0, 155.0, 177.0, 149.0, 187.0, 180.0, 150.0], "json-stringify-tinderbox": [74.0, 76.0, 77.0, 79.0, 78.0, 78.0, 78.0, 82.0, 82.0, 83.0], "stanford-crypto-pbkdf2": [158.0, 155.0, 172.0, 175.0, 166.0, 166.0, 172.0, 165.0, 175.0, 176.0], "json-parse-financial": [60.0, 71.0, 73.0, 74.0, 72.0, 72.0, 73.0, 83.0, 68.0, 66.0], "stanford-crypto-sha256-iterative": [77.0, 76.0, 80.0, 83.0, 85.0, 85.0, 84.0, 84.0, 85.0, 82.0], "audio-fft": [87.0, 92.0, 94.0, 143.0, 81.0, 85.0, 85.0, 85.0, 138.0, 80.0], "imaging-darkroom": [148.0, 154.0, 152.0, 147.0, 147.0, 153.0, 150.0, 148.0, 146.0, 154.0], "stanford-crypto-ccm": [140.0, 148.0, 149.0, 145.0, 144.0, 149.0, 145.0, 150.0, 147.0, 153.0], "audio-oscillator": [108.0, 115.0, 158.0, 108.0, 108.0, 103.0, 139.0, 103.0, 103.0, 148.0], "stanford-crypto-aes": [94.0, 94.0, 100.0, 100.0, 99.0, 99.0, 100.0, 100.0, 100.0, 99.0], "imaging-desaturate": [119.0, 124.0, 123.0, 125.0, 120.0, 119.0, 120.0, 124.0, 124.0, 124.0]}, "summary": {"suite": 1765.4999999999998, "subtests": {"audio-fft": {"filtered": 97.0, "value": 97.0}, "stanford-crypto-pbkdf2": {"filtered": 168.0, "value": 168.0}, "audio-beat-detection": {"filtered": 173.4, "value": 173.4}, "stanford-crypto-ccm": {"filtered": 147.0, "value": 147.0}, "imaging-darkroom": {"filtered": 149.9, "value": 149.9}, "json-parse-financial": {"filtered": 71.2, "value": 71.2}, "audio-oscillator": {"filtered": 119.3, "value": 119.3}, "ai-astar": {"filtered": 128.5, "value": 128.5}, "audio-dft": {"filtered": 190.0, "value": 190.0}, "stanford-crypto-sha256-iterative": {"filtered": 82.1, "value": 82.1}, "json-stringify-tinderbox": {"filtered": 78.7, "value": 78.7}, "imaging-gaussian-blur": {"filtered": 139.7, "value": 139.7}, "stanford-crypto-aes": {"filtered": 98.5, "value": 98.5}, "imaging-desaturate": {"filtered": 122.2, "value": 122.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0003"}, "testrun": {"date": 1448489784, "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": "20151125131130", "branch": "Mozilla-Aurora", "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806"}}, {"talos_counters": {}, "results": {"DeltaBlue": [216.26297577854672], "Encrypt": [375.9398496240602], "NavierStokes": [6836.734693877551], "Decrypt": [7583.333333333333], "Splay": [695.8942240779402], "Richards": [192.7153594141453], "RegExp": [34706.89655172414], "Earley": [805.8017727639001], "Boyer": [14720.588235294117], "RayTrace": [1211.864406779661]}, "summary": {"suite": 17183.271546955806, "subtests": {"DeltaBlue": {"filtered": 305.7296320000001, "value": 305.7296320000001}, "Encrypt": {"filtered": 708.0414599999997, "value": 708.0414599999997}, "NavierStokes": {"filtered": 217.0626865671642, "value": 217.0626865671642}, "Decrypt": {"filtered": 35.100791208791236, "value": 35.100791208791236}, "Splay": {"filtered": 117.10256700000005, "value": 117.10256700000005}, "RegExp": {"filtered": 26.247953303527062, "value": 26.247953303527062}, "Richards": {"filtered": 183.182078, "value": 183.182078}, "Earley": {"filtered": 827.0805830000004, "value": 827.0805830000004}, "Boyer": {"filtered": 45.27420979020977, "value": 45.27420979020977}, "RayTrace": {"filtered": 610.6202937062936, "value": 610.6202937062936}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0003"}, "testrun": {"date": 1448489784, "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": "20151125131130", "branch": "Mozilla-Aurora", "revision": "1f88b627ee6a78de1536beaab4b1a7c04a992806"}}] 14:36:41 INFO - RETURN: dromaeo_css: 5782.18 14:36:41 INFO - RETURN: kraken: 1765.50 14:36:41 INFO - RETURN: v8_7: 17183.27 14:36:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17183.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1765.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5782.18"}}} 14:36:41 INFO - Return code: 0 14:36:41 INFO - # TBPL SUCCESS # 14:36:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:36:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:36:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:36:41 INFO - 2015-11-25 14:36:41.121 screenresolution[1688:15129] starting screenresolution argv=screenresolution get 14:36:41 INFO - 2015-11-25 14:36:41.125 screenresolution[1688:15129] Display 0: 1600x1200x32@60 14:36:41 INFO - 2015-11-25 14:36:41.131 screenresolution[1689:15132] starting screenresolution argv=screenresolution list 14:36:41 INFO - Available Modes on Display 0 14:36:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:36:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:36:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:36:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:36:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:36:41 INFO - Intel HD Graphics 3000: 14:36:41 INFO - Chipset Model: Intel HD Graphics 3000 14:36:41 INFO - Type: GPU 14:36:41 INFO - Bus: Built-In 14:36:41 INFO - VRAM (Total): 512 MB 14:36:41 INFO - VRAM (Dynamic, Max): 10 14:36:41 INFO - Vendor: Intel (0x8086) 14:36:41 INFO - Device ID: 0x0116 14:36:41 INFO - Revision ID: 0x0009 14:36:41 INFO - Displays: 14:36:41 INFO - Display: 14:36:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:36:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:36:41 INFO - Display Serial Number: 1600x1200 60 14:36:41 INFO - Main Display: Yes 14:36:41 INFO - Mirror: Off 14:36:41 INFO - Online: Yes 14:36:41 INFO - Rotation: Supported 14:36:41 INFO - Return code: 0 14:36:41 INFO - Running post-action listener: _resource_record_post_action 14:36:41 INFO - Running post-run listener: _resource_record_post_run 14:36:42 INFO - Total resource usage - Wall time: 1259s; CPU: 30.0%; Read bytes: 37422080; Write bytes: 685389824; Read time: 5500; Write time: 49345 14:36:42 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 333820416; Write bytes: 333322240; Read time: 36226; Write time: 4441 14:36:42 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 36344832; Write bytes: 341798912; Read time: 5010; Write time: 44489 14:36:42 INFO - Running post-run listener: _upload_blobber_files 14:36:42 INFO - Blob upload gear active. 14:36:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:36:42 INFO - Copying logs to upload dir... 14:36:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1323.129387 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-25 14:36:43.394067) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:36:43.402070) ========= 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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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/XE076HUcSHKebawwHdnxWQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009981 build_url: 'https://queue.taskcluster.net/v1/task/XE076HUcSHKebawwHdnxWQ/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-25 14:36:43.429669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:36:43.430039) ========= 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.mf6qlpkvUU/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.pfCOzm1WCA/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.005190 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:36:43.482549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 14:36:43.482928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 14:36:43.910979) ========= ========= Total master_lag: 4.09 =========