builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0054 starttime: 1447330053.17 results: success (0) buildid: 20151112024444 builduid: 0be3a557c84b40ea9fa034971627b078 revision: 0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:33.173232) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:33.176854) ========= ========= Started set props: basedir (results: 0, elapsed: 7 secs) (at 2015-11-12 04:07:33.177271) ========= 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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.006076 basedir: '/builds/slave/test' ========= master_lag: 7.00 ========= ========= Finished set props: basedir (results: 0, elapsed: 7 secs) (at 2015-11-12 04:07:40.180681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:40.181044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:40.274169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 04:07:40.274512) ========= 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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.058699 ========= master_lag: 1.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 04:07:41.528160) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:41.528465) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:41.528873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:41.529145) ========= 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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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-12 04:07:41-- 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 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-12 04:07:41 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:41.767088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:41.767403) ========= 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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.133143 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.006106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.006448) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd --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 0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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-12 04:07:42,090 truncating revision to first 12 chars 2015-11-12 04:07:42,091 Setting DEBUG logging. 2015-11-12 04:07:42,091 attempt 1/10 2015-11-12 04:07:42,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0e9c6096f7e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 04:07:42,457 unpacking tar archive at: mozilla-aurora-0e9c6096f7e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.647044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.647405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.659881) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.660208) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 04:07:42.660636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-12 04:07:42.660929) ========= /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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:07:42 INFO - MultiFileLogger online at 20151112 04:07:42 in /builds/slave/test 04:07:42 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 04:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:42 INFO - {'append_to_log': False, 04:07:42 INFO - 'base_work_dir': '/builds/slave/test', 04:07:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:42 INFO - 'branch': 'Mozilla-Aurora', 04:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:42 INFO - 'config_files': ('talos/mac_config.py',), 04:07:42 INFO - 'default_actions': ('clobber', 04:07:42 INFO - 'read-buildbot-config', 04:07:42 INFO - 'download-and-extract', 04:07:42 INFO - 'populate-webroot', 04:07:42 INFO - 'create-virtualenv', 04:07:42 INFO - 'install', 04:07:42 INFO - 'run-tests'), 04:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:42 INFO - 'download_minidump_stackwalk': True, 04:07:42 INFO - 'download_symbols': 'ondemand', 04:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:42 INFO - 'installer_path': 'installer.exe', 04:07:42 INFO - 'log_level': 'info', 04:07:42 INFO - 'log_name': 'talos', 04:07:42 INFO - 'log_to_console': True, 04:07:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:07:42 INFO - 'opt_config_files': (), 04:07:42 INFO - 'pip_index': False, 04:07:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:07:42 INFO - 'cmd': ('bash', 04:07:42 INFO - '-c', 04:07:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:07:42 INFO - 'enabled': True, 04:07:42 INFO - 'halt_on_failure': False, 04:07:42 INFO - 'name': 'check_screen_resolution'},), 04:07:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:07:42 INFO - 'cmd': ('bash', 04:07:42 INFO - '-c', 04:07:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:07:42 INFO - 'enabled': True, 04:07:42 INFO - 'halt_on_failure': False, 04:07:42 INFO - 'name': 'check_screen_resolution'},), 04:07:42 INFO - 'run_cmd_checks_enabled': True, 04:07:42 INFO - 'sps_profile': False, 04:07:42 INFO - 'sps_profile_interval': 0, 04:07:42 INFO - 'suite': 'dromaeojs', 04:07:42 INFO - 'system_bits': '64', 04:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:42 INFO - 'title': 't-yosemite-r5-0054', 04:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:42 INFO - 'use_talos_json': True, 04:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:42 INFO - 'work_dir': 'build'} 04:07:42 INFO - ##### 04:07:42 INFO - ##### Running clobber step. 04:07:42 INFO - ##### 04:07:42 INFO - Running pre-action listener: _resource_record_pre_action 04:07:42 INFO - Running main action method: clobber 04:07:42 INFO - rmtree: /builds/slave/test/build 04:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:47 INFO - Running post-action listener: _resource_record_post_action 04:07:47 INFO - ##### 04:07:47 INFO - ##### Running read-buildbot-config step. 04:07:47 INFO - ##### 04:07:47 INFO - Running pre-action listener: _resource_record_pre_action 04:07:47 INFO - Running main action method: read_buildbot_config 04:07:47 INFO - Using buildbot properties: 04:07:47 INFO - { 04:07:47 INFO - "properties": { 04:07:47 INFO - "buildnumber": 415, 04:07:47 INFO - "product": "firefox", 04:07:47 INFO - "script_repo_revision": "production", 04:07:47 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 04:07:47 INFO - "repository": "", 04:07:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 04:07:47 INFO - "buildid": "20151112024444", 04:07:47 INFO - "slavename": "t-yosemite-r5-0054", 04:07:47 INFO - "pgo_build": "False", 04:07:47 INFO - "basedir": "/builds/slave/test", 04:07:47 INFO - "project": "", 04:07:47 INFO - "platform": "yosemite", 04:07:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:07:47 INFO - "slavebuilddir": "test", 04:07:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:07:47 INFO - "branch": "mozilla-aurora", 04:07:47 INFO - "repo_path": "releases/mozilla-aurora", 04:07:47 INFO - "stage_platform": "macosx64", 04:07:47 INFO - "builduid": "0be3a557c84b40ea9fa034971627b078", 04:07:47 INFO - "revision": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd" 04:07:47 INFO - }, 04:07:47 INFO - "sourcestamp": { 04:07:47 INFO - "repository": "", 04:07:47 INFO - "hasPatch": false, 04:07:47 INFO - "project": "", 04:07:47 INFO - "branch": "mozilla-aurora-macosx64-talos", 04:07:47 INFO - "changes": [ 04:07:47 INFO - { 04:07:47 INFO - "category": null, 04:07:47 INFO - "files": [ 04:07:47 INFO - { 04:07:47 INFO - "url": null, 04:07:47 INFO - "name": "https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 04:07:47 INFO - } 04:07:47 INFO - ], 04:07:47 INFO - "repository": "", 04:07:47 INFO - "rev": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd", 04:07:47 INFO - "who": "cbook@mozilla.com", 04:07:47 INFO - "when": 1447329975, 04:07:47 INFO - "number": 6653124, 04:07:47 INFO - "comments": "Bug 1221330 - Show the app icon in the XUL upgraded notifications alert. r=MattN, a=ritu", 04:07:47 INFO - "project": "", 04:07:47 INFO - "at": "Thu 12 Nov 2015 04:06:15", 04:07:47 INFO - "branch": "mozilla-aurora-macosx64-talos", 04:07:47 INFO - "revlink": "", 04:07:47 INFO - "properties": [ 04:07:47 INFO - [ 04:07:47 INFO - "buildid", 04:07:47 INFO - "20151112024444", 04:07:47 INFO - "Change" 04:07:47 INFO - ], 04:07:47 INFO - [ 04:07:47 INFO - "builduid", 04:07:47 INFO - "0be3a557c84b40ea9fa034971627b078", 04:07:47 INFO - "Change" 04:07:47 INFO - ], 04:07:47 INFO - [ 04:07:47 INFO - "pgo_build", 04:07:47 INFO - "False", 04:07:47 INFO - "Change" 04:07:47 INFO - ] 04:07:47 INFO - ], 04:07:47 INFO - "revision": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd" 04:07:47 INFO - } 04:07:47 INFO - ], 04:07:47 INFO - "revision": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd" 04:07:47 INFO - } 04:07:47 INFO - } 04:07:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 04:07:47 INFO - Running post-action listener: _resource_record_post_action 04:07:47 INFO - ##### 04:07:47 INFO - ##### Running download-and-extract step. 04:07:47 INFO - ##### 04:07:47 INFO - Running pre-action listener: _resource_record_pre_action 04:07:47 INFO - Running main action method: download_and_extract 04:07:47 INFO - mkdir: /builds/slave/test/build/tests 04:07:47 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')]} 04:07:47 INFO - https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/test_packages.json 04:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/test_packages.json 04:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:07:48 INFO - Downloaded 1149 bytes. 04:07:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:07:48 INFO - Using the following test package requirements: 04:07:48 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:07:48 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 04:07:48 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'jsshell-mac.zip'], 04:07:48 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 04:07:48 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:07:48 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 04:07:48 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 04:07:48 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 04:07:48 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:07:48 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:07:48 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 04:07:48 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:07:48 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')]} 04:07:48 INFO - https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:07:49 INFO - Downloaded 17447689 bytes. 04:07:49 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 04:07:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:07:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 04:07:55 INFO - Return code: 0 04:07:55 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 04:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:55 INFO - https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:07:58 INFO - Downloaded 17447689 bytes. 04:07:58 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 04:07:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:07:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 04:08:04 INFO - Return code: 0 04:08:04 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')]} 04:08:04 INFO - https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:08:05 INFO - Downloaded 11131307 bytes. 04:08:05 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 04:08:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:08:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:08:05 INFO - Return code: 0 04:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:05 INFO - https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 04:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 04:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:08:09 INFO - Downloaded 107716732 bytes. 04:08:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:08:09 INFO - mkdir: /builds/slave/test/properties 04:08:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:09 INFO - Contents: 04:08:09 INFO - build_url:https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:08:09 INFO - Running post-action listener: _resource_record_post_action 04:08:09 INFO - Running post-action listener: set_extra_try_arguments 04:08:09 INFO - ##### 04:08:09 INFO - ##### Running populate-webroot step. 04:08:09 INFO - ##### 04:08:09 INFO - Running pre-action listener: _resource_record_pre_action 04:08:09 INFO - Running main action method: populate_webroot 04:08:09 INFO - Guessing talos json url... 04:08:09 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')]} 04:08:09 INFO - https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 04:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 04:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 04:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 04:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e5oVOJoDSguYNAAgG6kqUw/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 04:08:10 INFO - Downloaded 107 bytes. 04:08:10 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 04:08:10 INFO - Contents: 04:08:10 INFO - 20151112024444 04:08:10 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd 04:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:10 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/0e9c6096f7/testing/talos/talos.json 04:08:10 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/0e9c6096f7/testing/talos/talos.json to /builds/slave/test/build/talos.json 04:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/0e9c6096f7/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 04:08:10 INFO - Downloaded 4264 bytes. 04:08:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:08:10 INFO - '../fennec_ids.txt'], 04:08:10 INFO - 'tests': ['tcheck2']}, 04:08:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:10 INFO - '--tppagecycles', 04:08:10 INFO - '7'], 04:08:10 INFO - 'tests': ['tsvgm']}}, 04:08:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:10 INFO - 'talos_options': ['--e10s'], 04:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:10 INFO - 'tests': ['damp', 'tps']}, 04:08:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:10 INFO - 'talos_options': ['--e10s'], 04:08:10 INFO - 'tests': ['damp', 'tps']}, 04:08:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:11 INFO - 'other': {'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore']}, 04:08:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:11 INFO - 'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore']}, 04:08:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:11 INFO - 'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore']}, 04:08:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:11 INFO - 'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore']}, 04:08:11 INFO - 'other_l64': {'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore']}, 04:08:11 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore']}, 04:08:11 INFO - 'svgr': {'tests': ['tsvgx', 04:08:11 INFO - 'tsvgr_opacity', 04:08:11 INFO - 'tart', 04:08:11 INFO - 'tscrollx', 04:08:11 INFO - 'cart']}, 04:08:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:11 INFO - 'tests': ['tsvgx', 04:08:11 INFO - 'tsvgr_opacity', 04:08:11 INFO - 'tart', 04:08:11 INFO - 'tscrollx', 04:08:11 INFO - 'cart']}, 04:08:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'tests': ['tp5o']}, 04:08:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--e10s'], 04:08:11 INFO - 'tests': ['tp5o']}, 04:08:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--xperf_path', 04:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:11 INFO - 'tests': ['tp5n']}, 04:08:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--e10s', 04:08:11 INFO - '--xperf_path', 04:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 04:08:11 INFO - 'C:/slave/talos-data/talos/xperf.config'], 04:08:11 INFO - 'tests': ['tp5n']}}, 04:08:11 INFO - 'talos.zip': {'path': '', 04:08:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:11 INFO - Running post-action listener: _resource_record_post_action 04:08:11 INFO - ##### 04:08:11 INFO - ##### Running create-virtualenv step. 04:08:11 INFO - ##### 04:08:11 INFO - Running pre-action listener: _resource_record_pre_action 04:08:11 INFO - Running main action method: create_virtualenv 04:08:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:11 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 04:08:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:11 INFO - Using real prefix '/tools/python27' 04:08:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:15 INFO - Installing pip.................done. 04:08:15 INFO - Return code: 0 04:08:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:15 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')]} 04:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:15 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')]} 04:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:15 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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:15 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 04:08:15 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 04:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:15 INFO - 'HOME': '/Users/cltbld', 04:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:15 INFO - 'LOGNAME': 'cltbld', 04:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:15 INFO - 'MOZ_NO_REMOTE': '1', 04:08:15 INFO - 'NO_EM_RESTART': '1', 04:08:15 INFO - 'PAGER': '/bin/cat', 04:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:15 INFO - 'PWD': '/builds/slave/test', 04:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:15 INFO - 'SHELL': '/bin/bash', 04:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:15 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:15 INFO - 'USER': 'cltbld', 04:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:15 INFO - 'XPC_FLAGS': '0x0', 04:08:15 INFO - 'XPC_SERVICE_NAME': '0', 04:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:16 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 04:08:16 INFO - Cleaning up... 04:08:16 INFO - Return code: 0 04:08:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:16 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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:16 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 04:08:16 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 04:08:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:16 INFO - 'HOME': '/Users/cltbld', 04:08:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:16 INFO - 'LOGNAME': 'cltbld', 04:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:16 INFO - 'MOZ_NO_REMOTE': '1', 04:08:16 INFO - 'NO_EM_RESTART': '1', 04:08:16 INFO - 'PAGER': '/bin/cat', 04:08:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:16 INFO - 'PWD': '/builds/slave/test', 04:08:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:16 INFO - 'SHELL': '/bin/bash', 04:08:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:16 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:16 INFO - 'USER': 'cltbld', 04:08:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:16 INFO - 'XPC_FLAGS': '0x0', 04:08:16 INFO - 'XPC_SERVICE_NAME': '0', 04:08:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:16 INFO - Downloading/unpacking psutil>=0.7.1 04:08:16 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 04:08:16 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 04:08:16 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 04:08:16 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 04:08:16 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 04:08:16 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 04:08:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:08:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:19 INFO - Installing collected packages: psutil 04:08:19 INFO - Running setup.py install for psutil 04:08:19 INFO - building 'psutil._psutil_osx' extension 04:08: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:08:21 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 04:08:21 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 04:08:21 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 04:08:22 INFO - building 'psutil._psutil_posix' extension 04:08:22 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 04:08:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:08:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:08:22 INFO - ^ 04:08:22 INFO - 1 warning generated. 04:08:22 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 04:08:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:22 INFO - Successfully installed psutil 04:08:22 INFO - Cleaning up... 04:08:22 INFO - Return code: 0 04:08:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:22 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')]} 04:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:22 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')]} 04:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:22 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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:22 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 04:08:22 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 04:08:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:22 INFO - 'HOME': '/Users/cltbld', 04:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:22 INFO - 'LOGNAME': 'cltbld', 04:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:22 INFO - 'MOZ_NO_REMOTE': '1', 04:08:22 INFO - 'NO_EM_RESTART': '1', 04:08:22 INFO - 'PAGER': '/bin/cat', 04:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:22 INFO - 'PWD': '/builds/slave/test', 04:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:22 INFO - 'SHELL': '/bin/bash', 04:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:22 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:22 INFO - 'USER': 'cltbld', 04:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:22 INFO - 'XPC_FLAGS': '0x0', 04:08:22 INFO - 'XPC_SERVICE_NAME': '0', 04:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:22 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 04:08:22 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 04:08:22 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 04:08:22 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 04:08:22 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 04:08:22 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 04:08:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:25 INFO - Installing collected packages: mozsystemmonitor 04:08:25 INFO - Running setup.py install for mozsystemmonitor 04:08:25 INFO - Successfully installed mozsystemmonitor 04:08:25 INFO - Cleaning up... 04:08:25 INFO - Return code: 0 04:08:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:25 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 04:08:25 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 04:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:25 INFO - 'HOME': '/Users/cltbld', 04:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:25 INFO - 'LOGNAME': 'cltbld', 04:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:25 INFO - 'MOZ_NO_REMOTE': '1', 04:08:25 INFO - 'NO_EM_RESTART': '1', 04:08:25 INFO - 'PAGER': '/bin/cat', 04:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:25 INFO - 'PWD': '/builds/slave/test', 04:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:25 INFO - 'SHELL': '/bin/bash', 04:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:25 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:25 INFO - 'USER': 'cltbld', 04:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:25 INFO - 'XPC_FLAGS': '0x0', 04:08:25 INFO - 'XPC_SERVICE_NAME': '0', 04:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 INFO - Downloading docopt-0.6.1.tar.gz 04:08:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:29 INFO - Running setup.py install for blobuploader 04:08:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:30 INFO - Running setup.py install for requests 04:08:30 INFO - Running setup.py install for docopt 04:08:30 INFO - Successfully installed blobuploader requests docopt 04:08:30 INFO - Cleaning up... 04:08:30 INFO - Return code: 0 04:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:30 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')]} 04:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:30 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')]} 04:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:30 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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:30 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 04:08:30 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 04:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:30 INFO - 'HOME': '/Users/cltbld', 04:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:30 INFO - 'LOGNAME': 'cltbld', 04:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:30 INFO - 'MOZ_NO_REMOTE': '1', 04:08:30 INFO - 'NO_EM_RESTART': '1', 04:08:30 INFO - 'PAGER': '/bin/cat', 04:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:30 INFO - 'PWD': '/builds/slave/test', 04:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:30 INFO - 'SHELL': '/bin/bash', 04:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:30 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:30 INFO - 'USER': 'cltbld', 04:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:30 INFO - 'XPC_FLAGS': '0x0', 04:08:30 INFO - 'XPC_SERVICE_NAME': '0', 04:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-zAzOUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-r69Qfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-zno7gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-xjcYP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-DpX0xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-8mGAbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-b_20ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-7X7R8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-JWfvD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-5o2EMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-5H3vx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-jCL6lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-kTAsSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-eJ7ORT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-yXHMyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-z90Xgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-VvJRka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:33 INFO - Running setup.py install for manifestparser 04:08:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:33 INFO - Running setup.py install for mozcrash 04:08:33 INFO - Running setup.py install for mozdebug 04:08:33 INFO - Running setup.py install for mozdevice 04:08:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozfile 04:08:34 INFO - Running setup.py install for mozhttpd 04:08:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozinfo 04:08:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozInstall 04:08:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozleak 04:08:34 INFO - Running setup.py install for mozlog 04:08:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Running setup.py install for moznetwork 04:08:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Running setup.py install for mozprocess 04:08:35 INFO - Running setup.py install for mozprofile 04:08:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Running setup.py install for mozrunner 04:08:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Running setup.py install for mozscreenshot 04:08:36 INFO - Running setup.py install for moztest 04:08:36 INFO - Running setup.py install for mozversion 04:08:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:36 INFO - Cleaning up... 04:08:36 INFO - Return code: 0 04:08:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:36 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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:36 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 04:08:36 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 04:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:36 INFO - 'HOME': '/Users/cltbld', 04:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:36 INFO - 'LOGNAME': 'cltbld', 04:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:36 INFO - 'MOZ_NO_REMOTE': '1', 04:08:36 INFO - 'NO_EM_RESTART': '1', 04:08:36 INFO - 'PAGER': '/bin/cat', 04:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:36 INFO - 'PWD': '/builds/slave/test', 04:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:36 INFO - 'SHELL': '/bin/bash', 04:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:36 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:36 INFO - 'USER': 'cltbld', 04:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:36 INFO - 'XPC_FLAGS': '0x0', 04:08:36 INFO - 'XPC_SERVICE_NAME': '0', 04:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:36 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-Z30h9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:36 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)) 04:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:36 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-8fLnUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-a8CrfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-zXmBwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-XC9lkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-0EHJ5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-L0iOxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-hDo8Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-SMJ8D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:37 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)) 04:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-qjjt0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-5nk4aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-4M55yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-gOzPpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-etQeLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-Aj0p_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-Y6ZWEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:38 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)) 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-rpQthZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:39 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)) 04:08:39 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)) 04:08:39 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)) 04:08:39 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)) 04:08:39 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)) 04:08:39 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)) 04:08:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Downloading blessings-1.5.1.tar.gz 04:08:41 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 04:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:41 INFO - Installing collected packages: blessings 04:08:41 INFO - Running setup.py install for blessings 04:08:41 INFO - Successfully installed blessings 04:08:41 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:42 INFO - Reading from file tmpfile_stdout 04:08:42 INFO - Current package versions: 04:08:42 INFO - blessings == 1.5.1 04:08:42 INFO - blobuploader == 1.2.4 04:08:42 INFO - docopt == 0.6.1 04:08:42 INFO - manifestparser == 1.1 04:08:42 INFO - mozInstall == 1.12 04:08:42 INFO - mozcrash == 0.16 04:08:42 INFO - mozdebug == 0.1 04:08:42 INFO - mozdevice == 0.46 04:08:42 INFO - mozfile == 1.2 04:08:42 INFO - mozhttpd == 0.7 04:08:42 INFO - mozinfo == 0.8 04:08:42 INFO - mozleak == 0.1 04:08:42 INFO - mozlog == 3.0 04:08:42 INFO - moznetwork == 0.27 04:08:42 INFO - mozprocess == 0.22 04:08:42 INFO - mozprofile == 0.27 04:08:42 INFO - mozrunner == 6.11 04:08:42 INFO - mozscreenshot == 0.1 04:08:42 INFO - mozsystemmonitor == 0.0 04:08:42 INFO - moztest == 0.7 04:08:42 INFO - mozversion == 1.4 04:08:42 INFO - psutil == 3.1.1 04:08:42 INFO - requests == 1.2.3 04:08:42 INFO - wsgiref == 0.1.2 04:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 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 0x106132a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10619f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24be02280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, '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.oKWptB18hd/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.u7lSd87MBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 04:08:42 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 04:08:42 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 04:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:42 INFO - 'HOME': '/Users/cltbld', 04:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:42 INFO - 'LOGNAME': 'cltbld', 04:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:42 INFO - 'MOZ_NO_REMOTE': '1', 04:08:42 INFO - 'NO_EM_RESTART': '1', 04:08:42 INFO - 'PAGER': '/bin/cat', 04:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:42 INFO - 'PWD': '/builds/slave/test', 04:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:42 INFO - 'SHELL': '/bin/bash', 04:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:08:42 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:42 INFO - 'USER': 'cltbld', 04:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:42 INFO - 'XPC_FLAGS': '0x0', 04:08:42 INFO - 'XPC_SERVICE_NAME': '0', 04:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 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)) 04:08:42 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Running post-action listener: _resource_record_post_action 04:08:42 INFO - Running post-action listener: _start_resource_monitoring 04:08:42 INFO - Starting resource monitoring. 04:08:42 INFO - ##### 04:08:42 INFO - ##### Running install step. 04:08:42 INFO - ##### 04:08:42 INFO - Running pre-action listener: _resource_record_pre_action 04:08:42 INFO - Running main action method: install 04:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:43 INFO - Reading from file tmpfile_stdout 04:08:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:43 INFO - Reading from file tmpfile_stdout 04:08:43 INFO - Output received: 04:08:43 INFO - Usage: mozinstall [options] installer 04:08:43 INFO - Options: 04:08:43 INFO - -h, --help show this help message and exit 04:08:43 INFO - -d DEST, --destination=DEST 04:08:43 INFO - Directory to install application into. [default: 04:08:43 INFO - "/builds/slave/test"] 04:08:43 INFO - --app=APP Application being installed. [default: firefox] 04:08:43 INFO - mkdir: /builds/slave/test/build/application 04:08:43 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'] 04:08:43 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 04:09:22 INFO - Reading from file tmpfile_stdout 04:09:22 INFO - Output received: 04:09:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:09:22 INFO - Running post-action listener: _resource_record_post_action 04:09:22 INFO - ##### 04:09:22 INFO - ##### Running run-tests step. 04:09:22 INFO - ##### 04:09:22 INFO - Running pre-action listener: _resource_record_pre_action 04:09:22 INFO - Running main action method: run_tests 04:09:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:09:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:09:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:09:22 INFO - 2015-11-12 04:09:22.928 screenresolution[1617:7789] starting screenresolution argv=screenresolution get 04:09:22 INFO - 2015-11-12 04:09:22.931 screenresolution[1617:7789] Display 0: 1600x1200x32@60 04:09:22 INFO - 2015-11-12 04:09:22.938 screenresolution[1618:7791] starting screenresolution argv=screenresolution list 04:09:22 INFO - Available Modes on Display 0 04:09:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:09:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:09:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:09:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:09:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:09:23 INFO - Intel HD Graphics 3000: 04:09:23 INFO - Chipset Model: Intel HD Graphics 3000 04:09:23 INFO - Type: GPU 04:09:23 INFO - Bus: Built-In 04:09:23 INFO - VRAM (Total): 512 MB 04:09:23 INFO - VRAM (Dynamic, Max): 10 04:09:23 INFO - Vendor: Intel (0x8086) 04:09:23 INFO - Device ID: 0x0116 04:09:23 INFO - Revision ID: 0x0009 04:09:23 INFO - Displays: 04:09:23 INFO - Display: 04:09:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:09:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:09:23 INFO - Display Serial Number: 1600x1200 60 04:09:23 INFO - Main Display: Yes 04:09:23 INFO - Mirror: Off 04:09:23 INFO - Online: Yes 04:09:23 INFO - Rotation: Supported 04:09:23 INFO - Return code: 0 04:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:23 INFO - Python 2.7.3 04:09:23 INFO - Return code: 0 04:09:23 INFO - grabbing minidump binary from tooltool 04:09: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')]} 04:09: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 0x1060e79f0>, '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 0x105e46cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060b1990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09: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 04:09: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 04:09:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:23 INFO - Return code: 0 04:09:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:09:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:09:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09: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/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0054', '--webServer', 'localhost'] in /builds/slave/test/build 04:09: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/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0054 --webServer localhost 04:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKWptB18hd/Render', 04:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:23 INFO - 'HOME': '/Users/cltbld', 04:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:23 INFO - 'LOGNAME': 'cltbld', 04:09:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:23 INFO - 'MOZ_NO_REMOTE': '1', 04:09:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:23 INFO - 'NO_EM_RESTART': '1', 04:09:23 INFO - 'PAGER': '/bin/cat', 04:09:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:23 INFO - 'PWD': '/builds/slave/test', 04:09:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:23 INFO - 'SHELL': '/bin/bash', 04:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7lSd87MBA/Listeners', 04:09:23 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 04:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:23 INFO - 'USER': 'cltbld', 04:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:23 INFO - 'XPC_FLAGS': '0x0', 04:09:23 INFO - 'XPC_SERVICE_NAME': '0', 04:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:09: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/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0054', '--webServer', 'localhost'] with output_timeout 3600 04:09:23 INFO - mozversion INFO | application_buildid: 20151112024444 04:09:23 INFO - mozversion INFO | application_changeset: 0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd 04:09:23 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 04:09:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:23 INFO - mozversion INFO | application_name: Firefox 04:09:23 INFO - mozversion INFO | application_remotingname: firefox-dev 04:09:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:09:23 INFO - mozversion INFO | application_vendor: Mozilla 04:09:23 INFO - mozversion INFO | application_version: 44.0a2 04:09:23 INFO - mozversion INFO | platform_buildid: 20151112024444 04:09:23 INFO - mozversion INFO | platform_changeset: 0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd 04:09:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:09:23 INFO - mozversion INFO | platform_version: 44.0a2 04:09:23 INFO - 2015-11-12 04:09:23,712 DEBUG : using testdate: 1447330163 04:09:23 INFO - 2015-11-12 04:09:23,712 DEBUG : actual date: 1447330163 04:09:23 INFO - 2015-11-12 04:09:23,722 INFO : starting webserver on 'localhost:49260' 04:09:23 INFO - 2015-11-12 04:09:23,723 INFO : Starting test suite t-yosemite-r5-0054 04:09:23 INFO - 2015-11-12 04:09:23,723 INFO : Starting test dromaeo_css 04:09:23 INFO - 2015-11-12 04:09:23,723 DEBUG : operating with platform_type : mac_ 04:09:23 INFO - 2015-11-12 04:09:23,724 INFO : Initialising browser for dromaeo_css test... 04:09:23 INFO - 2015-11-12 04:09:23,751 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpBasI9w/profile http://localhost:49260/getInfo.html 04:09:26 INFO - 2015-11-12 04:09:26,780 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:26 INFO - 2015-11-12 04:09:26,781 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:26 INFO - 2015-11-12 04:09:26,781 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:09:26 INFO - 2015-11-12 04:09:26,781 DEBUG : BROWSER_OUTPUT: __metrics 04:09:26 INFO - 2015-11-12 04:09:26,797 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:27 INFO - 2015-11-12 04:09:27,540 INFO : Browser initialized. 04:09:27 INFO - 2015-11-12 04:09:27,541 INFO : Running cycle 1/1 for dromaeo_css test... 04:09:27 INFO - 2015-11-12 04:09:27,541 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpBasI9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:39 INFO - 2015-11-12 04:09:39,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 200257536 04:09:39 INFO - 2015-11-12 04:09:39,563 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2015-11-12 04:10:31,263 DEBUG : BROWSER_OUTPUT: 1447330231256 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] 04:12:41 INFO - 2015-11-12 04:12:41,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49260/tests/dromaeo/cssquery-ext.html) 04:12:42 INFO - 2015-11-12 04:12:42,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 295833600 04:12:42 INFO - 2015-11-12 04:12:42,642 DEBUG : BROWSER_OUTPUT: 04:15:45 INFO - 2015-11-12 04:15:45,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/dromaeo/cssquery-ext.html (next: http://localhost:49260/tests/dromaeo/cssquery-jquery.html) 04:15:45 INFO - 2015-11-12 04:15:45,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 342499328 04:15:45 INFO - 2015-11-12 04:15:45,879 DEBUG : BROWSER_OUTPUT: 04:18:48 INFO - 2015-11-12 04:18:48,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49260/tests/dromaeo/cssquery-mootools.html) 04:18:48 INFO - 2015-11-12 04:18:48,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 305729536 04:18:48 INFO - 2015-11-12 04:18:48,608 DEBUG : BROWSER_OUTPUT: 04:21:50 INFO - 2015-11-12 04:21:50,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49260/tests/dromaeo/cssquery-prototype.html) 04:21:51 INFO - 2015-11-12 04:21:51,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 299458560 04:21:51 INFO - 2015-11-12 04:21:51,367 DEBUG : BROWSER_OUTPUT: 04:24:54 INFO - 2015-11-12 04:24:54,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49260/tests/dromaeo/cssquery-yui.html) 04:24:55 INFO - 2015-11-12 04:24:55,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 300777472 04:24:55 INFO - 2015-11-12 04:24:55,093 DEBUG : BROWSER_OUTPUT: 04:27:57 INFO - 2015-11-12 04:27:57,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/dromaeo/cssquery-yui.html (next: http://localhost:49260/tests/dromaeo/cssquery-dojo.html) 04:27:58 INFO - 2015-11-12 04:27:58,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 345161728 04:27:58 INFO - 2015-11-12 04:27:58,059 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,059 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:58 INFO - 2015-11-12 04:27:58,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:58 INFO - 2015-11-12 04:27:58,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:58 INFO - 2015-11-12 04:27:58,060 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:58 INFO - 2015-11-12 04:27:58,060 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2831.235566397073;2908;2926.034408645146;2926.7219614136648;2961.318896653769;4838.612910967123;4846.7091974481555;4877.731724755137;4902.828401005965;5007.49925007499;4885.19394299941;4901;4926.975365123179;4946.258061290808;4948.7278199699;4400.691951563392;4495.1459222747735;4556.407667003285;4576.954230457703;4635.188841952661;4411.911761764763;4451.265541185717;4459.687821852472;4478.171538265431;4569.200389931765;4589.128065667529;4597.747123908183;4610.193216187171;4649.093426781779;4714.4106986626675;4578.336141259532;4604.470485894098;4625.167469855424;4630.259158534635;4652.604528615072;4243.872683819491;4341.717788343748;4343;4375.2999520076955;4485.461744590637;4815.6388270879825;4818.590419814285;4839.201531747258;4841.394825646794;4857.514248575149;5208.947910520884;5214.634975551713;5243.213517972296;5247.1866860636665;5271.103912334912;5031.798728050873;5134.691918484903;5144.74276286188;5148.4851514848215;5381.784728610851;4937.086638971802;4968.354113965233;4980.327655766498;4980.726060066731;5021.548060674557;5372.435894231127;5422.349318081855;5422.810201642924;5432.375276843213;5485.61600687948;4915.90168196634;4939.777710003059;4940.456549779521;5140.485951404904;5182.818601348935;5216.713080780593;5281.630285880028;5294.047071527162;5298.364196296469;5348.625596208228;5193.195054766517;5199.090159222121;5207.453217412117;5220.1647736362;5243.737813109329;4874.147024270809;4969.27945447908;4996.825111121093;5081.110805609003;5139.408967968657;4054.4729185206324;4073;4073.7759423231414;4096.139810639739;4128.318827393507;3560.893173204808;3689.3174762668455;3703.9074023149637;3718.758280711745;3739.0652336915773;4731.219348807408;4774.928376074362;4813.15769740294;4813.831515896927;4862.781174847069;5236.6334356595435;5303.390110137384;5315.4950279724135;5317.41508434072;5340.145576707786;4651.465081515601;4922.384701912261;4944.3572335596145;4975.726335051534;4978;4501.639868810487;4550.067236216568;4565.794539245742;4580.7938642761155;4636.095961287517;5375.462453754593;5387.703676297841;5389.272448219519;5444.754986025718;5450.727463626724;5051.267566202953;5263.447338029452;5290.418054014132;5301.496357845998;5319.521243088141;5364.839054828361;5366.2487251784005;5384.596155288291;5413.566914646897;5417.756200971045;5274.208868669577;5276.103062479311;5277.340332458442;5325.733713314241;5331.573474121983;4999.375078115236;5362;5404.216388623706;5448.700321482356;5471.179323101407;5033.697978121324;5092.668976516515;5101.234814777813;5123.28274041627;5147;4941.160002799605;5169.198774190007;5181.430042695225;5185.325907631984;5227.869303267449;4762.095201911764;5009.699418034929;5089.312942752681;5092.134337162765;5092.618053646065;5029.9245511318095;5045.293658887832;5071.797128114834;5077.289179514944;5169.896602067863;5058.721770302522;5081.237814327733;5085.56772674312;5086.262491938574;5087.3386459759995 04:27:58 INFO - 2015-11-12 04:27:58,060 DEBUG : BROWSER_OUTPUT: |1;ext.html;509.4421608338869;515.160288729371;515.7730598536643;526.95399631731;538.7656369479274;29385.853070734644;30604.84697576512;35825.104372390706;36059.2788144237;36112.458313125324;38595.614043859554;39097.41353879687;39146.412803807965;39189;39200.60799392012;7640.235976402343;8246.505209687422;8314.542700151489;8406.453580517278;8424.410291279613;7645.61771911405;9953.850692239586;10022.448765317904;10126.29115961883;10134.594616215343;9693.369930954465;9806.166475849526;9953.601855925754;9959.302848800588;9986.251031172655;7799.298063174341;7924.683012679486;9829.066238707348;9886.950565247163;9957.253206009578;9493.335466517347;9678;9721.65974190907;9743.951280243553;9806.215502759762;35597.82201089004;35661.64338356635;35669.64330356689;36149.09627259313;36176.457353139725;2680.8123431359813;2685.5837345211526;2710.2004908552026;2760.986195069032;2761.9033333833218;24858.143485560307;24916.875415622988;25012.749872501223;25972.220833375028;26713.599296010576;2134.1463414634113;2186.9234576789895;2194.9122035118576;2224.944376390587;2245.8315626327926;240915;241738;242072;242770;243204;48659.5134048655;50299.74850125799;55091.17363239555;55094.173587396224;60232;56715.149272760944;56913;56925.71537142288;56983.43016569864;57035.429645703014;15677.451289204822;15706.214689265491;15770.211489425483;15789.763153552705;15894.284757185724;11945.343006134572;11961.10291728124;11979.401029948642;11997.100217483548;12105.939470302592;18041.909790450965;18053.638927221644;18064.18711158001;18107.637847243244;18161.7275740864;7646.311831935152;7803.123048094941;7848.411369147337;7937.841243175104;7967.561784101814;789.6012513680555;834.407570624851;877.3507604372718;946.7207173883721;1024.8616436781087;24977.00091996336;26303.210903672538;26648;26673.866630666722;27868.517660654325;874.0516539554527;929.5259417696888;977.2084611464594;998.7503124218945;1044.2011860926398;11718.88281117178;12645.051621128452;12684.619461416172;12746.80879786804;12806.487740490276;280760;286358;288504;289163;290906;47872.04255914862;47967;48048;48163.27755083676;48250.27624585634;1319.2612137203198;1333.3999700134978;1336.9732605347838;1353.9323033848268;1358.701085761131;23687.752355316643;24494.877525612257;24856.751432486166;24879.378015549755;25141.120060797784;41826.1634767309;42594.787026064674;43065.354019690356;43098.78450607727;43131;264201;266353;268826;270024;318910;25491.36271593225;27828.44343113167;28223.153305400872;28726.85636571804;28728.425431490836;33121;37187.25625487421;38345.42481862719;38490.23019539649;39200;29515.704842951294;29908.551371729878;29999;32832;33725.66274337225;26003.479930400907;29158.854205728836;30852.845735771178;32465;32590.348193035534;29568;30406.239844004078;30655.54016689707;30789.846050769604;30816.383672326876;27043.594346085218;28159.859200703864;28205.15384538467;28668.71331286744;28890.133296001153;21600.783992160505;21715.565688685823;21741.347759567238;21754.564908702054;21875.343739687836 04:27:58 INFO - 2015-11-12 04:27:58,065 DEBUG : BROWSER_OUTPUT: |2;jquery.html;288.4908137137952;313.76937950606316;315.9383920135573;320.1244596029859;330.11693719300865;13663.248521331323;14091.01362904597;15717;16394.26225819838;16533.17334133293;9700.320977531575;10074.748131296721;10113.14038306743;14410.135391876469;16463.588410289747;3807.3908174692124;3914.197589494147;3926.4699265599206;3969.3847453644585;3977.184677141194;3142.9371412571736;3221.5167724841226;3894.8636797712084;4054.1688953764406;4094.651954583864;4151.418801367811;4220.409142720022;4226.366045093245;4234.74591524508;4238.597333253336;4060.167665628539;4135.421041054255;4145.067359844041;4167.895802604944;4226.767527785971;3456.861725531001;3470.9305813883834;3474.7567670263093;3476.6349533299144;3518.1204698825295;10823.83764243537;10851.728706782314;11030.117590592734;11154.051905588034;11341.659750207507;1594.378192504924;1632.5184070699054;1646.3003223630028;1679.0261648243988;1741.7474466202457;8094.9595252023955;8124.106348301682;8279.089300176976;8292.83414331716;8325.95837020817;1359.8572149924314;1385.6605131742688;1392.997042129665;1395.323268214915;1422.5163444428945;52527.737361312946;54314.185287220724;54752.72623636896;54826.72586637081;56019.159712603934;5448.373437054789;5481.479259470344;5481.561475081984;5767.452092051249;5827.096799996008;6538.673066346759;6567.934320656732;6592.43964263043;6604.801855944329;6639.834004149935;4617.907641847144;4765.69023013503;4804.0872234275375;4808.831690890872;4853.757312134449;5084;5095.745212739348;5126.359205099363;5128.717920514333;5169.06956747789;2534.2017264561973;2534.4550921551586;2556.2459074573044;2556.85937273448;2567.1785028790982;896.8116695494019;912.1653686876566;922.8200500902394;929.6374413978554;956.4882787708542;336.7861408005934;348.7750400991346;356.1914454188977;378.50982977044794;379.88603418974196;9554.04459554039;9937.254705897087;10042.648507302209;10052.849207261897;10128;342.31024485661413;343.96904278615045;364.42057129164755;376.6515972725218;378.6894746308056;5166.4058633257655;5187.325647665779;5198.856251624637;5204.323437953042;5387.784488620411;315910;332979;339909;451757;477842;37619;37820.62179378226;38247.23505529874;57459;59131.52171195669;370.1818980054057;374.4551677309508;394.4438341937854;405.34132035442406;407.3685787030151;8616.956915215384;9128.767616371704;9281.72154835356;9418.95290523543;9486.667966621135;32336.67663323337;32649.34701306008;32974.50538241976;33052;33100.66899330976;44514.77742611266;45837.08325833398;46359.768201158775;46580.53419465762;47664;5461.235427040297;5489.780408783604;5496.862578435571;5514.531264842533;5576.1356989666665;9279.953600231956;9737.318387712792;9847.867495238139;9864.605415783288;9875.901240987498;6744.662766861736;7399.186089530255;7700.8844867325915;8485.066642669179;8728;8249.340052795882;8270.421070525246;8323.292520135856;8410;8487.533185674847;8576.528290944058;8770.210681038738;8784.692535761218;8813.294936404944;8887;2023.3828682251465;2698.90553830615;5214.582833373397;5546.889062218814;5573.247611572548;8667.483190441773;8744.300455963381;8765.298776098025;8766.254868336262;8912.242459391024 04:27:58 INFO - 2015-11-12 04:27:58,065 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1213.0235160695636;1607.7588361745738;1687.8059023212327;1689.11321556183;1700.736385860192;6408.45528130109;6651.135352404192;6911.48163887708;7084.468664850131;7102.254263302343;6785.18577770667;6890.689918953646;6977.65111744412;6978.0230767692565;7028.332308430691;1759.3930094117509;1759.445774581003;1953.2870502266676;1971.103148067633;2001.0895042755585;1952.5997170580067;1970.0642194957425;1970.3497845710954;1995.720599116125;1998.950026249341;1909.6944488881782;1927.9228830846748;1950.1809240119112;1950.8439324853978;1983.206717313072;1933.4296382567106;1965.5184479802397;1968.3307675390292;1989.641864464396;1992.3026940570685;1928.5467915039953;1958.0601311370622;1958.0601311370622;1977.5550501137272;1981.73246611707;6490.156279683658;6604.966975165142;6609.702563384659;6656.334366563354;6665.566738162052;4113.25961326961;4184.309588917825;4185.769782661952;4195.811188496525;4213.852515161985;2445.1808644104067;2505.498900219945;2513.1832154549843;2548.5157820014138;2549.821512494126;709.1348554763232;725.3399406540024;728.4427413029038;775.4920527054788;777.5762209595783;9068.31987600926;9204.539773011322;9215.44707317563;9302.16280534755;9318.20795232406;3684.9815750921075;3708.2027364116843;3712.1276500022473;3724.1992971511254;3764.830582623734;7873.763787086396;7927.643256053491;7930.603469826486;7984.121746607869;8008.519488830689;4191.224623444673;4196.349565817303;4238;4239.194553034913;4241.957580424156;3832.080300727805;3839;3881.573026967031;3885.8445662173763;3891.8248678809523;2819.675737290197;2901.7968742187845;3057.2356910772305;3244.2538216210405;3259.445894197992;1071.9387806071932;1083.3674171762534;1086.7717779266443;1088.2817340555196;1095.1293721491434;909.4270609515962;921.0973246218743;950.9952450237705;965.1362030982232;1207.8309036734863;6287.276963149205;6320.367963203735;6355.650439225795;6429.971204607334;6433.035044743326;993.2401712689798;997.755549890267;1006.5671761142632;1019.9439030853374;1041.9843702344472;5122.590192784643;5170.224466330081;5184.637075404686;5184.792608295701;5262.2632831403635;7938.444308898437;8250.504969701837;8254.793630159174;8331.208535189147;8334.916650833415;8214.342852571779;8223.136570660114;8247.381446391544;8319.750407487785;8322.583870806557;6483.805485835433;6557.3442655735;6579.967100164373;6584.604923704593;6591.340865913467;6048.4858787003595;6194.783182588588;6204.945159323016;6209.223847019122;6268.686565671789;7265.20082790882;7386.409087273113;7444.367228785397;7497.437692173218;7519.586422746802;7401.3708834747495;7474.364679002346;7485.401167906663;7581.203973582695;7585.544867307979;6069.969650151721;6121.296050954197;6130.63216207029;6150.969245153925;6212.006079027334;5997.580169388101;6072.514198864169;6321.557490975588;6544.411003009752;6558.573692709959;6027.4876635484725;6057.303410107894;6079.74733517566;6141.907871382022;6143.784967526115;5901.940980590311;5976.372480889618;5976.611520251344;6012.909806352821;6105.9084113737445;6056.0007598745715;6098.481629061579;6099.054646529795;6169.629822210682;6177.96911015442;5471.835844924659;5525.751341189576;5531.557475402039;5603.467670571289;5609.074502707008;5309.973450132725;5333.573314134782;5349.277847490539;5393.352797664305;5410.864728381822 04:27:58 INFO - 2015-11-12 04:27:58,066 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.9595456636071;300.7428648505528;301.74954787526354;303.47801780936794;306.0771773104093;5398.865028374283;5408.810691625789;5466.781328746851;5489.094299440588;5540.6398584092;5333.333333333333;5413.512783849453;5414;5440.510354068133;5446.101393270115;4184.28867092595;4226.72526285792;4227.281362168424;4235.851745188904;4239.978800106003;4104.09709863831;4165.208610364036;4170.520390155126;4192.24539582875;4199.55904630014;4029.8992525186814;4160.292750232467;4167.74993500391;4179.2686279901045;4179.582041795811;4133.0700592366775;4133.524644665857;4198.076423186894;4202.85290014848;4212.662986961036;3633.255182687543;3667.0282375170336;3679.466477360768;3683.465897444882;3694.0210844126327;5222.373315202162;5307.734613269321;5326.014687282865;5393.1101368274185;5411.648242864201;4769.833055843063;4779.163646361872;4787.784549695272;4813.422389313305;4819.662623616348;5734.967705812952;5752.137179423078;5772.422757724236;5781.8554536136935;5791.3339965903615;3823.6941044716355;3901.2782635212575;3905.1799122184375;3955.3275943089743;3999.420084087791;5903.439173278532;5903.557233207526;5909.586328956974;5965.13505541694;6009.939900601025;3933.901652458654;3967.603239676067;3973.7019723520852;3975.92048159041;3979.3633018716864;3979.6020397959974;4029.8589549365634;4030.314846476106;4036.1927614476635;4045.37296719009;4685.367475390779;4728.645351598575;4750.714957102585;4793.688410253322;4811.615070794328;5700.800471983461;5753.798617048383;5772.94227057724;5786.594938354359;5802.448767367094;1466.65533599604;1479.0460153201125;1494.6114010357169;1509.1925819686414;1523.9941638518746;977.731123940922;992.6277645882794;995.7411073121041;1002.9648962286285;1003.7791685829106;5379.1662292344745;5411.56707463402;5432.592555558349;5465.808696695676;5478.479544443271;5914.852128696817;5929.584929054925;5941.346451890288;5944.613600115978;5973.104034394789;5390.54180394663;5428.864278393072;5460.699661518575;5478.123500239943;5482.342118945752;3202.951955720666;3222.6132864055994;3237.935241295208;3260.2827377976805;3303.752218583616;5981.581289309706;6030.065339872327;6085.269767627913;6112.572119951561;6114.908276375858;5974.3428222895445;6012;6069.635821850615;6090.086487026892;6094.481969032593;5896.646201227854;6011.879762404727;6059.787907423219;6060.666663333559;6099.11562823397;5853.678047707417;5934.6142500737315;5944.405559444021;5950.910736339045;5959.821205363846;5664.122061080539;5715.885682286248;5748.597598168255;5768.307803063659;5810.854728631649;5990.520758339235;6020.789272375446;6034.155218269358;6068.51451883857;6077.270727512727;3888.5333759948985;3909.1986142840083;3919.118198405336;3944.309745794532;3953.0512676957896;5753.309602847685;5818.2436283282905;5863.882722345444;5927.762889484372;5966.075258334965;5790.94209057904;5795;5823.7670493181495;5844;5856.238688970407;5699.031164701928;5822.592418530831;5825.854353641193;5832.154337621106;5859.326177489473;5454.699991500505;5647.858803529944;5652.7173641318595;5681.346645135697;5726.685032323262;5763.97118014424;5821.592488525763;5821.94178058214;5832.066869300891;5833.270841144857;5668.744906479301;5675.148727690715;5717.971410142923;5727.997600419993;5746.051901436216 04:27:58 INFO - 2015-11-12 04:27:58,069 DEBUG : BROWSER_OUTPUT: |5;yui.html;591.3111225422383;614.7940439952615;656.8981807819783;688.1673175457696;693.1197379328253;12213.877861221385;12564.874351256485;12604.684882877933;12722.491100355976;12728.681782955431;12205.51177952883;12215.267083974968;12238.755224895496;12369.876301236985;12383.133180677356;671.4427025568766;689.1523426185795;837.7779888329612;842.9915700843005;857.0187135729586;805.3999770171231;829.4194064155085;843.6077224090797;846.2130218896424;857.4340934982913;873.4715497124243;885.9246964008067;886.5877367024333;887.1970866365949;887.6360692116234;702.0487239790062;703.2686006553179;843.8607629741147;869.6260607938584;880.6565439478544;646.760698541538;649.4349915573481;650.4016304999412;651.5048563092084;661.4245606322482;12423;12536.247825130431;12584.937075314656;12601.558945436956;12614.243145411212;10486.213533984905;10569.682909512727;10849.783004339948;11007.119430445546;11059.281146725438;8308.335333173392;8689.7827554311;8812;8830.381873268874;8888.955555222246;2987.850607469618;3049.5273232648974;3064.0807757672833;3126.8436578171;3143.9371212575847;44086.33870491945;44346.33480497795;44587.10825783466;45117.54882451199;45165.09669806618;8141.348692104736;8252.546109964009;8336.333093352518;8347.624356903832;8470.618822153017;17894.463166105037;17938.5515362117;18082.457526274233;18135.09324533768;18138.274469021355;5462.6995515247045;5664.801731939445;5727.76852976612;5810.1575271586225;5908.438698323653;3380.4760262159402;3423.640517745651;3458.8616455342008;3496.1609213789015;3574.7318951078773;2455.8894849731805;2462.236706620953;2463.211772232904;2491.165459571064;2497.5754121799337;355.9092431429969;356.7912771028977;357.4138413002678;357.8622230441299;360.01356283782246;511.6086194061546;517.9663321884066;525.6451894970955;533.2188344075947;537.9435159308216;6716.261211266757;6854.241379826376;6965.651717414109;7208.56748595086;7333.926660733431;418.89946412860695;474.6914505571337;542.4873494547694;557.5288880895637;575.2320651929637;3306.470964645645;3401.48977653354;3554.3871831754273;3606.4590311453494;3638.945415818712;56375.71812140913;56884;57389.13916291259;57764.13353799696;57767;44427.77786111049;44630.776846115565;44932.3260151098;49131.50868491341;49739.75130124326;40789;40983.79508102559;41312.793436032625;41546.79226603848;42119.789401052796;6988.196357418962;7012.474064445085;7178.784636460915;7226.4218862491925;7321.560706357635;32369.676303236665;32480.35039299248;32756;33259;33262.833685831414;40306;40783.388249175696;43457.78271108624;44118.11763764643;44174.779126104164;6439.871202576016;6639.136912201383;6651.73393064272;6746.831329216809;6823.283555226828;9740.902590974;9985.500724963578;10178.643747468803;10247.180225581786;10352.792944141225;9429.104235097655;9444.527773611155;9466.47934363589;9793.363431376938;9855.260855435728;9464.432134071978;9551.283653726137;9659.32384733062;9750.561224745046;9864.260180486635;9506.191973682315;9567.043295670377;9586.424814511152;9591.760205994906;9622.278329125484;8270.958645206976;8282.254597086292;8537.274331681876;8648.870266946127;8670.306375490072;8374.83250335002;8441.91558084436;8502.489850608983;8505.574721264036;8841.248493878093 04:27:58 INFO - 2015-11-12 04:27:58,070 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:58 INFO - 2015-11-12 04:27:58,070 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:27:58 INFO - 2015-11-12 04:27:58,070 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1023 04:27:58 INFO - 2015-11-12 04:27:58,070 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:27:58 INFO - 2015-11-12 04:27:58,070 DEBUG : BROWSER_OUTPUT: __startTimestamp1447331278055__endTimestamp 04:27:58 INFO - 2015-11-12 04:27:58,070 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,071 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:58 INFO - 2015-11-12 04:27:58,071 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:27:58 INFO - 2015-11-12 04:27:58,071 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,071 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4876.99 Median:5007.50 stddev:529.14 (10.6%) stddev-sans-first:505.84 04:27:58 INFO - 2015-11-12 04:27:58,071 DEBUG : BROWSER_OUTPUT: Values: 2831.2 2908.0 2926.0 2926.7 2961.3 4838.6 4846.7 4877.7 4902.8 5007.5 4885.2 4901.0 4927.0 4946.3 4948.7 4400.7 4495.1 4556.4 4577.0 4635.2 4411.9 4451.3 4459.7 4478.2 4569.2 4589.1 4597.7 4610.2 4649.1 4714.4 4578.3 4604.5 4625.2 4630.3 4652.6 4243.9 4341.7 4343.0 4375.3 4485.5 4815.6 4818.6 4839.2 4841.4 4857.5 5208.9 5214.6 5243.2 5247.2 5271.1 5031.8 5134.7 5144.7 5148.5 5381.8 4937.1 4968.4 4980.3 4980.7 5021.5 5372.4 5422.3 5422.8 5432.4 5485.6 4915.9 4939.8 4940.5 5140.5 5182.8 5216.7 5281.6 5294.0 5298.4 5348.6 5193.2 5199.1 5207.5 5220.2 5243.7 4874.1 4969.3 4996.8 5081.1 5139.4 4054.5 4073.0 4073.8 4096.1 4128.3 3560.9 3689.3 3703.9 3718.8 3739.1 4731.2 4774.9 4813.2 4813.8 4862.8 5236.6 5303.4 5315.5 5317.4 5340.1 4651.5 4922.4 4944.4 4975.7 4978.0 4501.6 4550.1 4565.8 4580.8 4636.1 5375.5 5387.7 5389.3 5444.8 5450.7 5051.3 5263.4 5290.4 5301.5 5319.5 5364.8 5366.2 5384.6 5413.6 5417.8 5274.2 5276.1 5277.3 5325.7 5331.6 4999.4 5362.0 5404.2 5448.7 5471.2 5033.7 5092.7 5101.2 5123.3 5147.0 4941.2 5169.2 5181.4 5185.3 5227.9 4762.1 5009.7 5089.3 5092.1 5092.6 5029.9 5045.3 5071.8 5077.3 5169.9 5058.7 5081.2 5085.6 5086.3 5087.3 04:27:58 INFO - 2015-11-12 04:27:58,071 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,072 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42271.31 Median:30202.62 stddev:70540.91 (233.6%) stddev-sans-first:70669.10 04:27:58 INFO - 2015-11-12 04:27:58,072 DEBUG : BROWSER_OUTPUT: Values: 509.4 515.2 515.8 527.0 538.8 29385.9 30604.8 35825.1 36059.3 36112.5 38595.6 39097.4 39146.4 39189.0 39200.6 7640.2 8246.5 8314.5 8406.5 8424.4 7645.6 9953.9 10022.4 10126.3 10134.6 9693.4 9806.2 9953.6 9959.3 9986.3 7799.3 7924.7 9829.1 9887.0 9957.3 9493.3 9678.0 9721.7 9744.0 9806.2 35597.8 35661.6 35669.6 36149.1 36176.5 2680.8 2685.6 2710.2 2761.0 2761.9 24858.1 24916.9 25012.7 25972.2 26713.6 2134.1 2186.9 2194.9 2224.9 2245.8 240915.0 241738.0 242072.0 242770.0 243204.0 48659.5 50299.7 55091.2 55094.2 60232.0 56715.1 56913.0 56925.7 56983.4 57035.4 15677.5 15706.2 15770.2 15789.8 15894.3 11945.3 11961.1 11979.4 11997.1 12105.9 18041.9 18053.6 18064.2 18107.6 18161.7 7646.3 7803.1 7848.4 7937.8 7967.6 789.6 834.4 877.4 946.7 1024.9 24977.0 26303.2 26648.0 26673.9 27868.5 874.1 929.5 977.2 998.8 1044.2 11718.9 12645.1 12684.6 12746.8 12806.5 280760.0 286358.0 288504.0 289163.0 290906.0 47872.0 47967.0 48048.0 48163.3 48250.3 1319.3 1333.4 1337.0 1353.9 1358.7 23687.8 24494.9 24856.8 24879.4 25141.1 41826.2 42594.8 43065.4 43098.8 43131.0 264201.0 266353.0 268826.0 270024.0 318910.0 25491.4 27828.4 28223.2 28726.9 28728.4 33121.0 37187.3 38345.4 38490.2 39200.0 29515.7 29908.6 29999.0 32832.0 33725.7 26003.5 29158.9 30852.8 32465.0 32590.3 29568.0 30406.2 30655.5 30789.8 30816.4 27043.6 28159.9 28205.2 28668.7 28890.1 21600.8 21715.6 21741.3 21754.6 21875.3 04:27:58 INFO - 2015-11-12 04:27:58,072 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,072 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20469.43 Median:248135.89 stddev:63965.48 (25.8%) stddev-sans-first:64126.97 04:27:58 INFO - 2015-11-12 04:27:58,074 DEBUG : BROWSER_OUTPUT: Values: 288.5 313.8 315.9 320.1 330.1 13663.2 14091.0 15717.0 16394.3 16533.2 9700.3 10074.7 10113.1 14410.1 16463.6 3807.4 3914.2 3926.5 3969.4 3977.2 3142.9 3221.5 3894.9 4054.2 4094.7 4151.4 4220.4 4226.4 4234.7 4238.6 4060.2 4135.4 4145.1 4167.9 4226.8 3456.9 3470.9 3474.8 3476.6 3518.1 10823.8 10851.7 11030.1 11154.1 11341.7 1594.4 1632.5 1646.3 1679.0 1741.7 8095.0 8124.1 8279.1 8292.8 8326.0 1359.9 1385.7 1393.0 1395.3 1422.5 52527.7 54314.2 54752.7 54826.7 56019.2 5448.4 5481.5 5481.6 5767.5 5827.1 6538.7 6567.9 6592.4 6604.8 6639.8 4617.9 4765.7 4804.1 4808.8 4853.8 5084.0 5095.7 5126.4 5128.7 5169.1 2534.2 2534.5 2556.2 2556.9 2567.2 896.8 912.2 922.8 929.6 956.5 336.8 348.8 356.2 378.5 379.9 9554.0 9937.3 10042.6 10052.8 10128.0 342.3 344.0 364.4 376.7 378.7 5166.4 5187.3 5198.9 5204.3 5387.8 315910.0 332979.0 339909.0 451757.0 477842.0 37619.0 37820.6 38247.2 57459.0 59131.5 370.2 374.5 394.4 405.3 407.4 8617.0 9128.8 9281.7 9419.0 9486.7 32336.7 32649.3 32974.5 33052.0 33100.7 44514.8 45837.1 46359.8 46580.5 47664.0 5461.2 5489.8 5496.9 5514.5 5576.1 9280.0 9737.3 9847.9 9864.6 9875.9 6744.7 7399.2 7700.9 8485.1 8728.0 8249.3 8270.4 8323.3 8410.0 8487.5 8576.5 8770.2 8784.7 8813.3 8887.0 2023.4 2698.9 5214.6 5546.9 5573.2 8667.5 8744.3 8765.3 8766.3 8912.2 04:27:58 INFO - 2015-11-12 04:27:58,074 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,074 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4763.91 Median:6052.24 stddev:2468.21 (40.8%) stddev-sans-first:2460.70 04:27:58 INFO - 2015-11-12 04:27:58,076 DEBUG : BROWSER_OUTPUT: Values: 1213.0 1607.8 1687.8 1689.1 1700.7 6408.5 6651.1 6911.5 7084.5 7102.3 6785.2 6890.7 6977.7 6978.0 7028.3 1759.4 1759.4 1953.3 1971.1 2001.1 1952.6 1970.1 1970.3 1995.7 1999.0 1909.7 1927.9 1950.2 1950.8 1983.2 1933.4 1965.5 1968.3 1989.6 1992.3 1928.5 1958.1 1958.1 1977.6 1981.7 6490.2 6605.0 6609.7 6656.3 6665.6 4113.3 4184.3 4185.8 4195.8 4213.9 2445.2 2505.5 2513.2 2548.5 2549.8 709.1 725.3 728.4 775.5 777.6 9068.3 9204.5 9215.4 9302.2 9318.2 3685.0 3708.2 3712.1 3724.2 3764.8 7873.8 7927.6 7930.6 7984.1 8008.5 4191.2 4196.3 4238.0 4239.2 4242.0 3832.1 3839.0 3881.6 3885.8 3891.8 2819.7 2901.8 3057.2 3244.3 3259.4 1071.9 1083.4 1086.8 1088.3 1095.1 909.4 921.1 951.0 965.1 1207.8 6287.3 6320.4 6355.7 6430.0 6433.0 993.2 997.8 1006.6 1019.9 1042.0 5122.6 5170.2 5184.6 5184.8 5262.3 7938.4 8250.5 8254.8 8331.2 8334.9 8214.3 8223.1 8247.4 8319.8 8322.6 6483.8 6557.3 6580.0 6584.6 6591.3 6048.5 6194.8 6204.9 6209.2 6268.7 7265.2 7386.4 7444.4 7497.4 7519.6 7401.4 7474.4 7485.4 7581.2 7585.5 6070.0 6121.3 6130.6 6151.0 6212.0 5997.6 6072.5 6321.6 6544.4 6558.6 6027.5 6057.3 6079.7 6141.9 6143.8 5901.9 5976.4 5976.6 6012.9 6105.9 6056.0 6098.5 6099.1 6169.6 6178.0 5471.8 5525.8 5531.6 5603.5 5609.1 5310.0 5333.6 5349.3 5393.4 5410.9 04:27:58 INFO - 2015-11-12 04:27:58,076 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,076 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4799.54 Median:5463.25 stddev:1440.45 (26.4%) stddev-sans-first:1404.14 04:27:58 INFO - 2015-11-12 04:27:58,077 DEBUG : BROWSER_OUTPUT: Values: 289.0 300.7 301.7 303.5 306.1 5398.9 5408.8 5466.8 5489.1 5540.6 5333.3 5413.5 5414.0 5440.5 5446.1 4184.3 4226.7 4227.3 4235.9 4240.0 4104.1 4165.2 4170.5 4192.2 4199.6 4029.9 4160.3 4167.7 4179.3 4179.6 4133.1 4133.5 4198.1 4202.9 4212.7 3633.3 3667.0 3679.5 3683.5 3694.0 5222.4 5307.7 5326.0 5393.1 5411.6 4769.8 4779.2 4787.8 4813.4 4819.7 5735.0 5752.1 5772.4 5781.9 5791.3 3823.7 3901.3 3905.2 3955.3 3999.4 5903.4 5903.6 5909.6 5965.1 6009.9 3933.9 3967.6 3973.7 3975.9 3979.4 3979.6 4029.9 4030.3 4036.2 4045.4 4685.4 4728.6 4750.7 4793.7 4811.6 5700.8 5753.8 5772.9 5786.6 5802.4 1466.7 1479.0 1494.6 1509.2 1524.0 977.7 992.6 995.7 1003.0 1003.8 5379.2 5411.6 5432.6 5465.8 5478.5 5914.9 5929.6 5941.3 5944.6 5973.1 5390.5 5428.9 5460.7 5478.1 5482.3 3203.0 3222.6 3237.9 3260.3 3303.8 5981.6 6030.1 6085.3 6112.6 6114.9 5974.3 6012.0 6069.6 6090.1 6094.5 5896.6 6011.9 6059.8 6060.7 6099.1 5853.7 5934.6 5944.4 5950.9 5959.8 5664.1 5715.9 5748.6 5768.3 5810.9 5990.5 6020.8 6034.2 6068.5 6077.3 3888.5 3909.2 3919.1 3944.3 3953.1 5753.3 5818.2 5863.9 5927.8 5966.1 5790.9 5795.0 5823.8 5844.0 5856.2 5699.0 5822.6 5825.9 5832.2 5859.3 5454.7 5647.9 5652.7 5681.3 5726.7 5764.0 5821.6 5821.9 5832.1 5833.3 5668.7 5675.1 5718.0 5728.0 5746.1 04:27:58 INFO - 2015-11-12 04:27:58,077 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,077 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12484.98 Median:31305.88 stddev:15167.03 (48.4%) stddev-sans-first:15183.28 04:27:58 INFO - 2015-11-12 04:27:58,079 DEBUG : BROWSER_OUTPUT: Values: 591.3 614.8 656.9 688.2 693.1 12213.9 12564.9 12604.7 12722.5 12728.7 12205.5 12215.3 12238.8 12369.9 12383.1 671.4 689.2 837.8 843.0 857.0 805.4 829.4 843.6 846.2 857.4 873.5 885.9 886.6 887.2 887.6 702.0 703.3 843.9 869.6 880.7 646.8 649.4 650.4 651.5 661.4 12423.0 12536.2 12584.9 12601.6 12614.2 10486.2 10569.7 10849.8 11007.1 11059.3 8308.3 8689.8 8812.0 8830.4 8889.0 2987.9 3049.5 3064.1 3126.8 3143.9 44086.3 44346.3 44587.1 45117.5 45165.1 8141.3 8252.5 8336.3 8347.6 8470.6 17894.5 17938.6 18082.5 18135.1 18138.3 5462.7 5664.8 5727.8 5810.2 5908.4 3380.5 3423.6 3458.9 3496.2 3574.7 2455.9 2462.2 2463.2 2491.2 2497.6 355.9 356.8 357.4 357.9 360.0 511.6 518.0 525.6 533.2 537.9 6716.3 6854.2 6965.7 7208.6 7333.9 418.9 474.7 542.5 557.5 575.2 3306.5 3401.5 3554.4 3606.5 3638.9 56375.7 56884.0 57389.1 57764.1 57767.0 44427.8 44630.8 44932.3 49131.5 49739.8 40789.0 40983.8 41312.8 41546.8 42119.8 6988.2 7012.5 7178.8 7226.4 7321.6 32369.7 32480.4 32756.0 33259.0 33262.8 40306.0 40783.4 43457.8 44118.1 44174.8 6439.9 6639.1 6651.7 6746.8 6823.3 9740.9 9985.5 10178.6 10247.2 10352.8 9429.1 9444.5 9466.5 9793.4 9855.3 9464.4 9551.3 9659.3 9750.6 9864.3 9506.2 9567.0 9586.4 9591.8 9622.3 8271.0 8282.3 8537.3 8648.9 8670.3 8374.8 8441.9 8502.5 8505.6 8841.2 04:27:58 INFO - 2015-11-12 04:27:58,079 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:58 INFO - 2015-11-12 04:27:58,079 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2015-11-12 04:27:58,746 INFO : Browser exited with error code: 0 04:27:58 INFO - 2015-11-12 04:27:58,777 INFO : Completed test dromaeo_css (00:18:35) 04:27:58 INFO - 2015-11-12 04:27:58,778 INFO : Starting test kraken 04:27:58 INFO - 2015-11-12 04:27:58,778 DEBUG : operating with platform_type : mac_ 04:27:58 INFO - 2015-11-12 04:27:58,778 INFO : Initialising browser for kraken test... 04:27:58 INFO - 2015-11-12 04:27:58,792 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpqcZQkM/profile http://localhost:49260/getInfo.html 04:28:01 INFO - 2015-11-12 04:28:01,217 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:01 INFO - 2015-11-12 04:28:01,217 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:01 INFO - 2015-11-12 04:28:01,217 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:28:01 INFO - 2015-11-12 04:28:01,217 DEBUG : BROWSER_OUTPUT: __metrics 04:28:01 INFO - 2015-11-12 04:28:01,233 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:01 INFO - 2015-11-12 04:28:01,994 INFO : Browser initialized. 04:28:01 INFO - 2015-11-12 04:28:01,995 INFO : Running cycle 1/1 for kraken test... 04:28:01 INFO - 2015-11-12 04:28:01,995 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpqcZQkM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:28:13 INFO - 2015-11-12 04:28:13,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 199921664 04:28:13 INFO - 2015-11-12 04:28:13,955 DEBUG : BROWSER_OUTPUT: 04:28:16 INFO - 2015-11-12 04:28:16,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49260/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:17 INFO - 2015-11-12 04:28:17,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 263954432 04:28:17 INFO - 2015-11-12 04:28:17,378 DEBUG : BROWSER_OUTPUT: 04:28:20 INFO - 2015-11-12 04:28:20,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49260/tests/kraken/driver.html?testName=audio-dft) 04:28:20 INFO - 2015-11-12 04:28:20,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 276541440 04:28:20 INFO - 2015-11-12 04:28:20,902 DEBUG : BROWSER_OUTPUT: 04:28:23 INFO - 2015-11-12 04:28:23,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49260/tests/kraken/driver.html?testName=audio-fft) 04:28:24 INFO - 2015-11-12 04:28:24,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 265953280 04:28:24 INFO - 2015-11-12 04:28:24,576 DEBUG : BROWSER_OUTPUT: 04:28:26 INFO - 2015-11-12 04:28:26,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49260/tests/kraken/driver.html?testName=audio-oscillator) 04:28:27 INFO - 2015-11-12 04:28:27,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 266203136 04:28:27 INFO - 2015-11-12 04:28:27,407 DEBUG : BROWSER_OUTPUT: 04:28:29 INFO - 2015-11-12 04:28:29,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:30 INFO - 2015-11-12 04:28:30,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 266977280 04:28:30 INFO - 2015-11-12 04:28:30,353 DEBUG : BROWSER_OUTPUT: 04:28:33 INFO - 2015-11-12 04:28:33,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49260/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:34 INFO - 2015-11-12 04:28:34,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 266944512 04:28:34 INFO - 2015-11-12 04:28:34,290 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2015-11-12 04:28:37,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49260/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:38 INFO - 2015-11-12 04:28:38,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 267853824 04:28:38 INFO - 2015-11-12 04:28:38,318 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2015-11-12 04:28:41,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49260/tests/kraken/driver.html?testName=json-parse-financial) 04:28:42 INFO - 2015-11-12 04:28:42,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 267735040 04:28:42 INFO - 2015-11-12 04:28:42,051 DEBUG : BROWSER_OUTPUT: 04:28:43 INFO - 2015-11-12 04:28:43,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:44 INFO - 2015-11-12 04:28:44,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 298778624 04:28:44 INFO - 2015-11-12 04:28:44,322 DEBUG : BROWSER_OUTPUT: 04:28:46 INFO - 2015-11-12 04:28:46,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:46 INFO - 2015-11-12 04:28:46,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 301555712 04:28:46 INFO - 2015-11-12 04:28:46,879 DEBUG : BROWSER_OUTPUT: 04:28:49 INFO - 2015-11-12 04:28:49,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:49 INFO - 2015-11-12 04:28:49,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 306401280 04:28:49 INFO - 2015-11-12 04:28:49,704 DEBUG : BROWSER_OUTPUT: 04:28:52 INFO - 2015-11-12 04:28:52,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:53 INFO - 2015-11-12 04:28:53,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 307941376 04:28:53 INFO - 2015-11-12 04:28:53,135 DEBUG : BROWSER_OUTPUT: 04:28:55 INFO - 2015-11-12 04:28:55,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:56 INFO - 2015-11-12 04:28:56,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 307126272 04:28:56 INFO - 2015-11-12 04:28:56,483 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49260/tests/kraken/driver.html?testName=ai-astar) 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 366698496 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;121;115;126;127;125;110;120;120;126 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;182;150;171;182;145;164;147;201;176;150 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: |2;audio-dft;178;180;187;184;181;181;181;181;180;188 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: |3;audio-fft;89;88;90;141;79;79;83;82;136;78 04:28:58 INFO - 2015-11-12 04:28:58,582 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;109;158;102;105;105;147;99;100;143 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;136;135;130;135;141;130;135;135;135 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;140;140;146;146;140;140;146;145 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;118;118;117;113;119;119;118;117;110 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;68;71;70;73;74;73;81;64;63 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;72;71;73;76;77;76;74;73;73 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;93;96;96;95;95;95;96;97;96 04:28:58 INFO - 2015-11-12 04:28:58,583 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;140;138;148;143;144;145;143;147;146;144 04:28:58 INFO - 2015-11-12 04:28:58,584 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;165;156;166;161;151;168;168;170;161 04:28:58 INFO - 2015-11-12 04:28:58,584 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;77;76;77;82;82;80;80;80;77 04:28:58 INFO - 2015-11-12 04:28:58,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:58 INFO - 2015-11-12 04:28:58,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:58 INFO - 2015-11-12 04:28:58,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 04:28:58 INFO - 2015-11-12 04:28:58,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:58 INFO - 2015-11-12 04:28:58,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1447331338579__endTimestamp 04:28:58 INFO - 2015-11-12 04:28:58,585 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:58 INFO - 2015-11-12 04:28:58,585 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:28:58 INFO - 2015-11-12 04:28:58,585 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,585 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.10 Median:123.00 stddev:6.26 (5.1%) stddev-sans-first:5.71 04:28:58 INFO - 2015-11-12 04:28:58,587 DEBUG : BROWSER_OUTPUT: Values: 111.0 121.0 115.0 126.0 127.0 125.0 110.0 120.0 120.0 126.0 04:28:58 INFO - 2015-11-12 04:28:58,587 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,587 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:166.80 Median:173.50 stddev:18.78 (10.8%) stddev-sans-first:19.09 04:28:58 INFO - 2015-11-12 04:28:58,587 DEBUG : BROWSER_OUTPUT: Values: 182.0 150.0 171.0 182.0 145.0 164.0 147.0 201.0 176.0 150.0 04:28:58 INFO - 2015-11-12 04:28:58,587 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,588 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.10 Median:181.00 stddev:3.21 (1.8%) stddev-sans-first:3.05 04:28:58 INFO - 2015-11-12 04:28:58,588 DEBUG : BROWSER_OUTPUT: Values: 178.0 180.0 187.0 184.0 181.0 181.0 181.0 181.0 180.0 188.0 04:28:58 INFO - 2015-11-12 04:28:58,588 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,588 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.50 Median:82.50 stddev:23.61 (28.6%) stddev-sans-first:24.96 04:28:58 INFO - 2015-11-12 04:28:58,588 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 90.0 141.0 79.0 79.0 83.0 82.0 136.0 78.0 04:28:58 INFO - 2015-11-12 04:28:58,588 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,589 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.90 Median:127.00 stddev:22.30 (17.6%) stddev-sans-first:23.51 04:28:58 INFO - 2015-11-12 04:28:58,589 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 158.0 102.0 105.0 105.0 147.0 99.0 100.0 143.0 04:28:58 INFO - 2015-11-12 04:28:58,589 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,589 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.80 Median:135.00 stddev:3.12 (2.3%) stddev-sans-first:3.28 04:28:58 INFO - 2015-11-12 04:28:58,589 DEBUG : BROWSER_OUTPUT: Values: 136.0 136.0 135.0 130.0 135.0 141.0 130.0 135.0 135.0 135.0 04:28:58 INFO - 2015-11-12 04:28:58,589 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,590 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:143.40 Median:145.50 stddev:2.95 (2.0%) stddev-sans-first:2.98 04:28:58 INFO - 2015-11-12 04:28:58,590 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 140.0 140.0 146.0 146.0 140.0 140.0 146.0 145.0 04:28:58 INFO - 2015-11-12 04:28:58,590 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,590 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.70 Median:118.00 stddev:2.91 (2.5%) stddev-sans-first:3.05 04:28:58 INFO - 2015-11-12 04:28:58,590 DEBUG : BROWSER_OUTPUT: Values: 118.0 118.0 118.0 117.0 113.0 119.0 119.0 118.0 117.0 110.0 04:28:58 INFO - 2015-11-12 04:28:58,591 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,591 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.70 Median:72.00 stddev:6.18 (8.6%) stddev-sans-first:5.47 04:28:58 INFO - 2015-11-12 04:28:58,591 DEBUG : BROWSER_OUTPUT: Values: 60.0 68.0 71.0 70.0 73.0 74.0 73.0 81.0 64.0 63.0 04:28:58 INFO - 2015-11-12 04:28:58,591 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,591 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:73.50 stddev:2.46 (3.3%) stddev-sans-first:2.03 04:28:58 INFO - 2015-11-12 04:28:58,591 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 71.0 73.0 76.0 77.0 76.0 74.0 73.0 73.0 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:96.00 stddev:2.02 (2.1%) stddev-sans-first:1.13 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: Values: 90.0 93.0 96.0 96.0 95.0 95.0 95.0 96.0 97.0 96.0 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:144.50 stddev:3.05 (2.1%) stddev-sans-first:2.91 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: Values: 140.0 138.0 148.0 143.0 144.0 145.0 143.0 147.0 146.0 144.0 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,592 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:165.50 stddev:5.90 (3.6%) stddev-sans-first:6.25 04:28:58 INFO - 2015-11-12 04:28:58,594 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 156.0 166.0 161.0 151.0 168.0 168.0 170.0 161.0 04:28:58 INFO - 2015-11-12 04:28:58,594 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-11-12 04:28:58,594 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:80.00 stddev:3.33 (4.2%) stddev-sans-first:2.29 04:28:58 INFO - 2015-11-12 04:28:58,594 DEBUG : BROWSER_OUTPUT: Values: 71.0 77.0 76.0 77.0 82.0 82.0 80.0 80.0 80.0 77.0 04:28:58 INFO - 2015-11-12 04:28:58,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:58 INFO - 2015-11-12 04:28:58,594 DEBUG : BROWSER_OUTPUT: 04:28:59 INFO - 2015-11-12 04:28:59,261 INFO : Browser exited with error code: 0 04:28:59 INFO - 2015-11-12 04:28:59,315 INFO : Completed test kraken (00:01:00) 04:28:59 INFO - 2015-11-12 04:28:59,315 INFO : Starting test v8_7 04:28:59 INFO - 2015-11-12 04:28:59,315 DEBUG : operating with platform_type : mac_ 04:28:59 INFO - 2015-11-12 04:28:59,315 INFO : Initialising browser for v8_7 test... 04:28:59 INFO - 2015-11-12 04:28:59,330 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpsRczAH/profile http://localhost:49260/getInfo.html 04:29:01 INFO - 2015-11-12 04:29:01,664 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:29:01 INFO - 2015-11-12 04:29:01,664 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:29:01 INFO - 2015-11-12 04:29:01,664 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:29:01 INFO - 2015-11-12 04:29:01,665 DEBUG : BROWSER_OUTPUT: __metrics 04:29:01 INFO - 2015-11-12 04:29:01,700 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:29:02 INFO - 2015-11-12 04:29:02,423 INFO : Browser initialized. 04:29:02 INFO - 2015-11-12 04:29:02,423 INFO : Running cycle 1/1 for v8_7 test... 04:29:02 INFO - 2015-11-12 04:29:02,423 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpsRczAH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:29:14 INFO - 2015-11-12 04:29:14,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 199720960 04:29:14 INFO - 2015-11-12 04:29:14,371 DEBUG : BROWSER_OUTPUT: 04:29:36 INFO - 2015-11-12 04:29:36,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49260/tests/v8_7/run.html (next: http://localhost:49260/tests/v8_7/run.html) 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 518266880 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |0;Richards;186.9508319312021 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;217.91239921551536 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |2;Encrypt;365.09675063891933 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6763.513513513513 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1180.637544273908 04:29:37 INFO - 2015-11-12 04:29:37,248 DEBUG : BROWSER_OUTPUT: |5;Earley;765.1109410864575 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: |6;Boyer;14323.94366197183 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: |7;RegExp;33177.41935483871 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: |8;Splay;677.8975741239892 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6555.555555555556 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: __startTimestamp1447331377245__endTimestamp 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.95 Median:186.95 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: Values: 187.0 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,249 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:217.91 Median:217.91 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: Values: 217.9 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:365.10 Median:365.10 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: Values: 365.1 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6763.51 Median:6763.51 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: Values: 6763.5 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1180.64 Median:1180.64 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: Values: 1180.6 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,250 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:765.11 Median:765.11 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: Values: 765.1 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14323.94 Median:14323.94 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: Values: 14323.9 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33177.42 Median:33177.42 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: Values: 33177.4 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:677.90 Median:677.90 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: Values: 677.9 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6555.56 Median:6555.56 stddev:0.00 (0.0%) 04:29:37 INFO - 2015-11-12 04:29:37,251 DEBUG : BROWSER_OUTPUT: Values: 6555.6 04:29:37 INFO - 2015-11-12 04:29:37,252 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:37 INFO - 2015-11-12 04:29:37,252 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-12 04:29:37,949 INFO : Browser exited with error code: 0 04:29:37 INFO - 2015-11-12 04:29:37,972 INFO : Completed test v8_7 (00:00:38) 04:29:38 INFO - 2015-11-12 04:29:38,244 INFO : Completed test suite (00:20:14) 04:29:38 INFO - 2015-11-12 04:29:38,244 DEBUG : Working with test: dromaeo_css 04:29:38 INFO - 2015-11-12 04:29:38,244 DEBUG : Generating results file: dromaeo_css 04:29:38 INFO - 2015-11-12 04:29:38,245 DEBUG : Working with test: kraken 04:29:38 INFO - 2015-11-12 04:29:38,245 DEBUG : Generating results file: kraken 04:29:38 INFO - 2015-11-12 04:29:38,245 INFO : javascript benchmark 04:29:38 INFO - 2015-11-12 04:29:38,245 DEBUG : Working with test: v8_7 04:29:38 INFO - 2015-11-12 04:29:38,245 DEBUG : Generating results file: v8_7 04:29:38 INFO - 2015-11-12 04:29:38,246 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:38 INFO - 2015-11-12 04:29:38,301 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 04:29:38 INFO - 2015-11-12 04:29:38,301 DEBUG : process_Request line: dromaeo_css 5908.72 graph.html#tests=[[72,52,55]] 04:29:38 INFO - 2015-11-12 04:29:38,301 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:38 INFO - 2015-11-12 04:29:38,331 DEBUG : process_Request line: kraken 1699.20 graph.html#tests=[[232,52,55]] 04:29:38 INFO - 2015-11-12 04:29:38,331 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:38 INFO - 2015-11-12 04:29:38,360 DEBUG : process_Request line: v8_7 17850.99 graph.html#tests=[[230,52,55]] 04:29:38 INFO - 2015-11-12 04:29:38,361 INFO : javascript benchmark 04:29:38 INFO - 2015-11-12 04:29:38,363 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [288.4908137137952, 313.76937950606316, 315.9383920135573, 320.1244596029859, 330.11693719300865, 13663.248521331323, 14091.01362904597, 15717.0, 16394.26225819838, 16533.17334133293, 9700.320977531575, 10074.748131296721, 10113.14038306743, 14410.135391876469, 16463.588410289747, 3807.3908174692124, 3914.197589494147, 3926.4699265599206, 3969.3847453644585, 3977.184677141194, 3142.9371412571736, 3221.5167724841226, 3894.8636797712084, 4054.1688953764406, 4094.651954583864, 4151.418801367811, 4220.409142720022, 4226.366045093245, 4234.74591524508, 4238.597333253336, 4060.167665628539, 4135.421041054255, 4145.067359844041, 4167.895802604944, 4226.767527785971, 3456.861725531001, 3470.9305813883834, 3474.7567670263093, 3476.6349533299144, 3518.1204698825295, 10823.83764243537, 10851.728706782314, 11030.117590592734, 11154.051905588034, 11341.659750207507, 1594.378192504924, 1632.5184070699054, 1646.3003223630028, 1679.0261648243988, 1741.7474466202457, 8094.9595252023955, 8124.106348301682, 8279.089300176976, 8292.83414331716, 8325.95837020817, 1359.8572149924314, 1385.6605131742688, 1392.997042129665, 1395.323268214915, 1422.5163444428945, 52527.737361312946, 54314.185287220724, 54752.72623636896, 54826.72586637081, 56019.159712603934, 5448.373437054789, 5481.479259470344, 5481.561475081984, 5767.452092051249, 5827.096799996008, 6538.673066346759, 6567.934320656732, 6592.43964263043, 6604.801855944329, 6639.834004149935, 4617.907641847144, 4765.69023013503, 4804.0872234275375, 4808.831690890872, 4853.757312134449, 5084.0, 5095.745212739348, 5126.359205099363, 5128.717920514333, 5169.06956747789, 2534.2017264561973, 2534.4550921551586, 2556.2459074573044, 2556.85937273448, 2567.1785028790982, 896.8116695494019, 912.1653686876566, 922.8200500902394, 929.6374413978554, 956.4882787708542, 336.7861408005934, 348.7750400991346, 356.1914454188977, 378.50982977044794, 379.88603418974196, 9554.04459554039, 9937.254705897087, 10042.648507302209, 10052.849207261897, 10128.0, 342.31024485661413, 343.96904278615045, 364.42057129164755, 376.6515972725218, 378.6894746308056, 5166.4058633257655, 5187.325647665779, 5198.856251624637, 5204.323437953042, 5387.784488620411, 315910.0, 332979.0, 339909.0, 451757.0, 477842.0, 37619.0, 37820.62179378226, 38247.23505529874, 57459.0, 59131.52171195669, 370.1818980054057, 374.4551677309508, 394.4438341937854, 405.34132035442406, 407.3685787030151, 8616.956915215384, 9128.767616371704, 9281.72154835356, 9418.95290523543, 9486.667966621135, 32336.67663323337, 32649.34701306008, 32974.50538241976, 33052.0, 33100.66899330976, 44514.77742611266, 45837.08325833398, 46359.768201158775, 46580.53419465762, 47664.0, 5461.235427040297, 5489.780408783604, 5496.862578435571, 5514.531264842533, 5576.1356989666665, 9279.953600231956, 9737.318387712792, 9847.867495238139, 9864.605415783288, 9875.901240987498, 6744.662766861736, 7399.186089530255, 7700.8844867325915, 8485.066642669179, 8728.0, 8249.340052795882, 8270.421070525246, 8323.292520135856, 8410.0, 8487.533185674847, 8576.528290944058, 8770.210681038738, 8784.692535761218, 8813.294936404944, 8887.0, 2023.3828682251465, 2698.90553830615, 5214.582833373397, 5546.889062218814, 5573.247611572548, 8667.483190441773, 8744.300455963381, 8765.298776098025, 8766.254868336262, 8912.242459391024], "dojo.html": [2831.235566397073, 2908.0, 2926.034408645146, 2926.7219614136648, 2961.318896653769, 4838.612910967123, 4846.7091974481555, 4877.731724755137, 4902.828401005965, 5007.49925007499, 4885.19394299941, 4901.0, 4926.975365123179, 4946.258061290808, 4948.7278199699, 4400.691951563392, 4495.1459222747735, 4556.407667003285, 4576.954230457703, 4635.188841952661, 4411.911761764763, 4451.265541185717, 4459.687821852472, 4478.171538265431, 4569.200389931765, 4589.128065667529, 4597.747123908183, 4610.193216187171, 4649.093426781779, 4714.4106986626675, 4578.336141259532, 4604.470485894098, 4625.167469855424, 4630.259158534635, 4652.604528615072, 4243.872683819491, 4341.717788343748, 4343.0, 4375.2999520076955, 4485.461744590637, 4815.6388270879825, 4818.590419814285, 4839.201531747258, 4841.394825646794, 4857.514248575149, 5208.947910520884, 5214.634975551713, 5243.213517972296, 5247.1866860636665, 5271.103912334912, 5031.798728050873, 5134.691918484903, 5144.74276286188, 5148.4851514848215, 5381.784728610851, 4937.086638971802, 4968.354113965233, 4980.327655766498, 4980.726060066731, 5021.548060674557, 5372.435894231127, 5422.349318081855, 5422.810201642924, 5432.375276843213, 5485.61600687948, 4915.90168196634, 4939.777710003059, 4940.456549779521, 5140.485951404904, 5182.818601348935, 5216.713080780593, 5281.630285880028, 5294.047071527162, 5298.364196296469, 5348.625596208228, 5193.195054766517, 5199.090159222121, 5207.453217412117, 5220.1647736362, 5243.737813109329, 4874.147024270809, 4969.27945447908, 4996.825111121093, 5081.110805609003, 5139.408967968657, 4054.4729185206324, 4073.0, 4073.7759423231414, 4096.139810639739, 4128.318827393507, 3560.893173204808, 3689.3174762668455, 3703.9074023149637, 3718.758280711745, 3739.0652336915773, 4731.219348807408, 4774.928376074362, 4813.15769740294, 4813.831515896927, 4862.781174847069, 5236.6334356595435, 5303.390110137384, 5315.4950279724135, 5317.41508434072, 5340.145576707786, 4651.465081515601, 4922.384701912261, 4944.3572335596145, 4975.726335051534, 4978.0, 4501.639868810487, 4550.067236216568, 4565.794539245742, 4580.7938642761155, 4636.095961287517, 5375.462453754593, 5387.703676297841, 5389.272448219519, 5444.754986025718, 5450.727463626724, 5051.267566202953, 5263.447338029452, 5290.418054014132, 5301.496357845998, 5319.521243088141, 5364.839054828361, 5366.2487251784005, 5384.596155288291, 5413.566914646897, 5417.756200971045, 5274.208868669577, 5276.103062479311, 5277.340332458442, 5325.733713314241, 5331.573474121983, 4999.375078115236, 5362.0, 5404.216388623706, 5448.700321482356, 5471.179323101407, 5033.697978121324, 5092.668976516515, 5101.234814777813, 5123.28274041627, 5147.0, 4941.160002799605, 5169.198774190007, 5181.430042695225, 5185.325907631984, 5227.869303267449, 4762.095201911764, 5009.699418034929, 5089.312942752681, 5092.134337162765, 5092.618053646065, 5029.9245511318095, 5045.293658887832, 5071.797128114834, 5077.289179514944, 5169.896602067863, 5058.721770302522, 5081.237814327733, 5085.56772674312, 5086.262491938574, 5087.3386459759995], "mootools.html": [1213.0235160695636, 1607.7588361745738, 1687.8059023212327, 1689.11321556183, 1700.736385860192, 6408.45528130109, 6651.135352404192, 6911.48163887708, 7084.468664850131, 7102.254263302343, 6785.18577770667, 6890.689918953646, 6977.65111744412, 6978.0230767692565, 7028.332308430691, 1759.3930094117509, 1759.445774581003, 1953.2870502266676, 1971.103148067633, 2001.0895042755585, 1952.5997170580067, 1970.0642194957425, 1970.3497845710954, 1995.720599116125, 1998.950026249341, 1909.6944488881782, 1927.9228830846748, 1950.1809240119112, 1950.8439324853978, 1983.206717313072, 1933.4296382567106, 1965.5184479802397, 1968.3307675390292, 1989.641864464396, 1992.3026940570685, 1928.5467915039953, 1958.0601311370622, 1958.0601311370622, 1977.5550501137272, 1981.73246611707, 6490.156279683658, 6604.966975165142, 6609.702563384659, 6656.334366563354, 6665.566738162052, 4113.25961326961, 4184.309588917825, 4185.769782661952, 4195.811188496525, 4213.852515161985, 2445.1808644104067, 2505.498900219945, 2513.1832154549843, 2548.5157820014138, 2549.821512494126, 709.1348554763232, 725.3399406540024, 728.4427413029038, 775.4920527054788, 777.5762209595783, 9068.31987600926, 9204.539773011322, 9215.44707317563, 9302.16280534755, 9318.20795232406, 3684.9815750921075, 3708.2027364116843, 3712.1276500022473, 3724.1992971511254, 3764.830582623734, 7873.763787086396, 7927.643256053491, 7930.603469826486, 7984.121746607869, 8008.519488830689, 4191.224623444673, 4196.349565817303, 4238.0, 4239.194553034913, 4241.957580424156, 3832.080300727805, 3839.0, 3881.573026967031, 3885.8445662173763, 3891.8248678809523, 2819.675737290197, 2901.7968742187845, 3057.2356910772305, 3244.2538216210405, 3259.445894197992, 1071.9387806071932, 1083.3674171762534, 1086.7717779266443, 1088.2817340555196, 1095.1293721491434, 909.4270609515962, 921.0973246218743, 950.9952450237705, 965.1362030982232, 1207.8309036734863, 6287.276963149205, 6320.367963203735, 6355.650439225795, 6429.971204607334, 6433.035044743326, 993.2401712689798, 997.755549890267, 1006.5671761142632, 1019.9439030853374, 1041.9843702344472, 5122.590192784643, 5170.224466330081, 5184.637075404686, 5184.792608295701, 5262.2632831403635, 7938.444308898437, 8250.504969701837, 8254.793630159174, 8331.208535189147, 8334.916650833415, 8214.342852571779, 8223.136570660114, 8247.381446391544, 8319.750407487785, 8322.583870806557, 6483.805485835433, 6557.3442655735, 6579.967100164373, 6584.604923704593, 6591.340865913467, 6048.4858787003595, 6194.783182588588, 6204.945159323016, 6209.223847019122, 6268.686565671789, 7265.20082790882, 7386.409087273113, 7444.367228785397, 7497.437692173218, 7519.586422746802, 7401.3708834747495, 7474.364679002346, 7485.401167906663, 7581.203973582695, 7585.544867307979, 6069.969650151721, 6121.296050954197, 6130.63216207029, 6150.969245153925, 6212.006079027334, 5997.580169388101, 6072.514198864169, 6321.557490975588, 6544.411003009752, 6558.573692709959, 6027.4876635484725, 6057.303410107894, 6079.74733517566, 6141.907871382022, 6143.784967526115, 5901.940980590311, 5976.372480889618, 5976.611520251344, 6012.909806352821, 6105.9084113737445, 6056.0007598745715, 6098.481629061579, 6099.054646529795, 6169.629822210682, 6177.96911015442, 5471.835844924659, 5525.751341189576, 5531.557475402039, 5603.467670571289, 5609.074502707008, 5309.973450132725, 5333.573314134782, 5349.277847490539, 5393.352797664305, 5410.864728381822], "ext.html": [509.4421608338869, 515.160288729371, 515.7730598536643, 526.95399631731, 538.7656369479274, 29385.853070734644, 30604.84697576512, 35825.104372390706, 36059.2788144237, 36112.458313125324, 38595.614043859554, 39097.41353879687, 39146.412803807965, 39189.0, 39200.60799392012, 7640.235976402343, 8246.505209687422, 8314.542700151489, 8406.453580517278, 8424.410291279613, 7645.61771911405, 9953.850692239586, 10022.448765317904, 10126.29115961883, 10134.594616215343, 9693.369930954465, 9806.166475849526, 9953.601855925754, 9959.302848800588, 9986.251031172655, 7799.298063174341, 7924.683012679486, 9829.066238707348, 9886.950565247163, 9957.253206009578, 9493.335466517347, 9678.0, 9721.65974190907, 9743.951280243553, 9806.215502759762, 35597.82201089004, 35661.64338356635, 35669.64330356689, 36149.09627259313, 36176.457353139725, 2680.8123431359813, 2685.5837345211526, 2710.2004908552026, 2760.986195069032, 2761.9033333833218, 24858.143485560307, 24916.875415622988, 25012.749872501223, 25972.220833375028, 26713.599296010576, 2134.1463414634113, 2186.9234576789895, 2194.9122035118576, 2224.944376390587, 2245.8315626327926, 240915.0, 241738.0, 242072.0, 242770.0, 243204.0, 48659.5134048655, 50299.74850125799, 55091.17363239555, 55094.173587396224, 60232.0, 56715.149272760944, 56913.0, 56925.71537142288, 56983.43016569864, 57035.429645703014, 15677.451289204822, 15706.214689265491, 15770.211489425483, 15789.763153552705, 15894.284757185724, 11945.343006134572, 11961.10291728124, 11979.401029948642, 11997.100217483548, 12105.939470302592, 18041.909790450965, 18053.638927221644, 18064.18711158001, 18107.637847243244, 18161.7275740864, 7646.311831935152, 7803.123048094941, 7848.411369147337, 7937.841243175104, 7967.561784101814, 789.6012513680555, 834.407570624851, 877.3507604372718, 946.7207173883721, 1024.8616436781087, 24977.00091996336, 26303.210903672538, 26648.0, 26673.866630666722, 27868.517660654325, 874.0516539554527, 929.5259417696888, 977.2084611464594, 998.7503124218945, 1044.2011860926398, 11718.88281117178, 12645.051621128452, 12684.619461416172, 12746.80879786804, 12806.487740490276, 280760.0, 286358.0, 288504.0, 289163.0, 290906.0, 47872.04255914862, 47967.0, 48048.0, 48163.27755083676, 48250.27624585634, 1319.2612137203198, 1333.3999700134978, 1336.9732605347838, 1353.9323033848268, 1358.701085761131, 23687.752355316643, 24494.877525612257, 24856.751432486166, 24879.378015549755, 25141.120060797784, 41826.1634767309, 42594.787026064674, 43065.354019690356, 43098.78450607727, 43131.0, 264201.0, 266353.0, 268826.0, 270024.0, 318910.0, 25491.36271593225, 27828.44343113167, 28223.153305400872, 28726.85636571804, 28728.425431490836, 33121.0, 37187.25625487421, 38345.42481862719, 38490.23019539649, 39200.0, 29515.704842951294, 29908.551371729878, 29999.0, 32832.0, 33725.66274337225, 26003.479930400907, 29158.854205728836, 30852.845735771178, 32465.0, 32590.348193035534, 29568.0, 30406.239844004078, 30655.54016689707, 30789.846050769604, 30816.383672326876, 27043.594346085218, 28159.859200703864, 28205.15384538467, 28668.71331286744, 28890.133296001153, 21600.783992160505, 21715.565688685823, 21741.347759567238, 21754.564908702054, 21875.343739687836], "prototype.html": [288.9595456636071, 300.7428648505528, 301.74954787526354, 303.47801780936794, 306.0771773104093, 5398.865028374283, 5408.810691625789, 5466.781328746851, 5489.094299440588, 5540.6398584092, 5333.333333333333, 5413.512783849453, 5414.0, 5440.510354068133, 5446.101393270115, 4184.28867092595, 4226.72526285792, 4227.281362168424, 4235.851745188904, 4239.978800106003, 4104.09709863831, 4165.208610364036, 4170.520390155126, 4192.24539582875, 4199.55904630014, 4029.8992525186814, 4160.292750232467, 4167.74993500391, 4179.2686279901045, 4179.582041795811, 4133.0700592366775, 4133.524644665857, 4198.076423186894, 4202.85290014848, 4212.662986961036, 3633.255182687543, 3667.0282375170336, 3679.466477360768, 3683.465897444882, 3694.0210844126327, 5222.373315202162, 5307.734613269321, 5326.014687282865, 5393.1101368274185, 5411.648242864201, 4769.833055843063, 4779.163646361872, 4787.784549695272, 4813.422389313305, 4819.662623616348, 5734.967705812952, 5752.137179423078, 5772.422757724236, 5781.8554536136935, 5791.3339965903615, 3823.6941044716355, 3901.2782635212575, 3905.1799122184375, 3955.3275943089743, 3999.420084087791, 5903.439173278532, 5903.557233207526, 5909.586328956974, 5965.13505541694, 6009.939900601025, 3933.901652458654, 3967.603239676067, 3973.7019723520852, 3975.92048159041, 3979.3633018716864, 3979.6020397959974, 4029.8589549365634, 4030.314846476106, 4036.1927614476635, 4045.37296719009, 4685.367475390779, 4728.645351598575, 4750.714957102585, 4793.688410253322, 4811.615070794328, 5700.800471983461, 5753.798617048383, 5772.94227057724, 5786.594938354359, 5802.448767367094, 1466.65533599604, 1479.0460153201125, 1494.6114010357169, 1509.1925819686414, 1523.9941638518746, 977.731123940922, 992.6277645882794, 995.7411073121041, 1002.9648962286285, 1003.7791685829106, 5379.1662292344745, 5411.56707463402, 5432.592555558349, 5465.808696695676, 5478.479544443271, 5914.852128696817, 5929.584929054925, 5941.346451890288, 5944.613600115978, 5973.104034394789, 5390.54180394663, 5428.864278393072, 5460.699661518575, 5478.123500239943, 5482.342118945752, 3202.951955720666, 3222.6132864055994, 3237.935241295208, 3260.2827377976805, 3303.752218583616, 5981.581289309706, 6030.065339872327, 6085.269767627913, 6112.572119951561, 6114.908276375858, 5974.3428222895445, 6012.0, 6069.635821850615, 6090.086487026892, 6094.481969032593, 5896.646201227854, 6011.879762404727, 6059.787907423219, 6060.666663333559, 6099.11562823397, 5853.678047707417, 5934.6142500737315, 5944.405559444021, 5950.910736339045, 5959.821205363846, 5664.122061080539, 5715.885682286248, 5748.597598168255, 5768.307803063659, 5810.854728631649, 5990.520758339235, 6020.789272375446, 6034.155218269358, 6068.51451883857, 6077.270727512727, 3888.5333759948985, 3909.1986142840083, 3919.118198405336, 3944.309745794532, 3953.0512676957896, 5753.309602847685, 5818.2436283282905, 5863.882722345444, 5927.762889484372, 5966.075258334965, 5790.94209057904, 5795.0, 5823.7670493181495, 5844.0, 5856.238688970407, 5699.031164701928, 5822.592418530831, 5825.854353641193, 5832.154337621106, 5859.326177489473, 5454.699991500505, 5647.858803529944, 5652.7173641318595, 5681.346645135697, 5726.685032323262, 5763.97118014424, 5821.592488525763, 5821.94178058214, 5832.066869300891, 5833.270841144857, 5668.744906479301, 5675.148727690715, 5717.971410142923, 5727.997600419993, 5746.051901436216], "yui.html": [591.3111225422383, 614.7940439952615, 656.8981807819783, 688.1673175457696, 693.1197379328253, 12213.877861221385, 12564.874351256485, 12604.684882877933, 12722.491100355976, 12728.681782955431, 12205.51177952883, 12215.267083974968, 12238.755224895496, 12369.876301236985, 12383.133180677356, 671.4427025568766, 689.1523426185795, 837.7779888329612, 842.9915700843005, 857.0187135729586, 805.3999770171231, 829.4194064155085, 843.6077224090797, 846.2130218896424, 857.4340934982913, 873.4715497124243, 885.9246964008067, 886.5877367024333, 887.1970866365949, 887.6360692116234, 702.0487239790062, 703.2686006553179, 843.8607629741147, 869.6260607938584, 880.6565439478544, 646.760698541538, 649.4349915573481, 650.4016304999412, 651.5048563092084, 661.4245606322482, 12423.0, 12536.247825130431, 12584.937075314656, 12601.558945436956, 12614.243145411212, 10486.213533984905, 10569.682909512727, 10849.783004339948, 11007.119430445546, 11059.281146725438, 8308.335333173392, 8689.7827554311, 8812.0, 8830.381873268874, 8888.955555222246, 2987.850607469618, 3049.5273232648974, 3064.0807757672833, 3126.8436578171, 3143.9371212575847, 44086.33870491945, 44346.33480497795, 44587.10825783466, 45117.54882451199, 45165.09669806618, 8141.348692104736, 8252.546109964009, 8336.333093352518, 8347.624356903832, 8470.618822153017, 17894.463166105037, 17938.5515362117, 18082.457526274233, 18135.09324533768, 18138.274469021355, 5462.6995515247045, 5664.801731939445, 5727.76852976612, 5810.1575271586225, 5908.438698323653, 3380.4760262159402, 3423.640517745651, 3458.8616455342008, 3496.1609213789015, 3574.7318951078773, 2455.8894849731805, 2462.236706620953, 2463.211772232904, 2491.165459571064, 2497.5754121799337, 355.9092431429969, 356.7912771028977, 357.4138413002678, 357.8622230441299, 360.01356283782246, 511.6086194061546, 517.9663321884066, 525.6451894970955, 533.2188344075947, 537.9435159308216, 6716.261211266757, 6854.241379826376, 6965.651717414109, 7208.56748595086, 7333.926660733431, 418.89946412860695, 474.6914505571337, 542.4873494547694, 557.5288880895637, 575.2320651929637, 3306.470964645645, 3401.48977653354, 3554.3871831754273, 3606.4590311453494, 3638.945415818712, 56375.71812140913, 56884.0, 57389.13916291259, 57764.13353799696, 57767.0, 44427.77786111049, 44630.776846115565, 44932.3260151098, 49131.50868491341, 49739.75130124326, 40789.0, 40983.79508102559, 41312.793436032625, 41546.79226603848, 42119.789401052796, 6988.196357418962, 7012.474064445085, 7178.784636460915, 7226.4218862491925, 7321.560706357635, 32369.676303236665, 32480.35039299248, 32756.0, 33259.0, 33262.833685831414, 40306.0, 40783.388249175696, 43457.78271108624, 44118.11763764643, 44174.779126104164, 6439.871202576016, 6639.136912201383, 6651.73393064272, 6746.831329216809, 6823.283555226828, 9740.902590974, 9985.500724963578, 10178.643747468803, 10247.180225581786, 10352.792944141225, 9429.104235097655, 9444.527773611155, 9466.47934363589, 9793.363431376938, 9855.260855435728, 9464.432134071978, 9551.283653726137, 9659.32384733062, 9750.561224745046, 9864.260180486635, 9506.191973682315, 9567.043295670377, 9586.424814511152, 9591.760205994906, 9622.278329125484, 8270.958645206976, 8282.254597086292, 8537.274331681876, 8648.870266946127, 8670.306375490072, 8374.83250335002, 8441.91558084436, 8502.489850608983, 8505.574721264036, 8841.248493878093]}, "summary": {"suite": 5908.727257615094, "subtests": {"jquery.html": {"filtered": 5610.434253222163, "value": 5610.434253222163}, "dojo.html": {"filtered": 4843.516113864782, "value": 4843.516113864782}, "mootools.html": {"filtered": 3910.374674970096, "value": 3910.374674970096}, "ext.html": {"filtered": 16850.6521020449, "value": 16850.6521020449}, "prototype.html": {"filtered": 4332.374818429963, "value": 4332.374818429963}, "yui.html": {"filtered": 5485.333265139132, "value": 5485.333265139132}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0054"}, "testrun": {"date": 1447330163, "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": "20151112024444", "branch": "Mozilla-Aurora", "revision": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd"}}, {"talos_counters": {}, "results": {"audio-dft": [178.0, 180.0, 187.0, 184.0, 181.0, 181.0, 181.0, 181.0, 180.0, 188.0], "ai-astar": [111.0, 121.0, 115.0, 126.0, 127.0, 125.0, 110.0, 120.0, 120.0, 126.0], "imaging-gaussian-blur": [136.0, 136.0, 135.0, 130.0, 135.0, 141.0, 130.0, 135.0, 135.0, 135.0], "audio-beat-detection": [182.0, 150.0, 171.0, 182.0, 145.0, 164.0, 147.0, 201.0, 176.0, 150.0], "json-stringify-tinderbox": [69.0, 72.0, 71.0, 73.0, 76.0, 77.0, 76.0, 74.0, 73.0, 73.0], "stanford-crypto-pbkdf2": [163.0, 165.0, 156.0, 166.0, 161.0, 151.0, 168.0, 168.0, 170.0, 161.0], "json-parse-financial": [60.0, 68.0, 71.0, 70.0, 73.0, 74.0, 73.0, 81.0, 64.0, 63.0], "stanford-crypto-sha256-iterative": [71.0, 77.0, 76.0, 77.0, 82.0, 82.0, 80.0, 80.0, 80.0, 77.0], "audio-fft": [89.0, 88.0, 90.0, 141.0, 79.0, 79.0, 83.0, 82.0, 136.0, 78.0], "imaging-darkroom": [146.0, 145.0, 140.0, 140.0, 146.0, 146.0, 140.0, 140.0, 146.0, 145.0], "stanford-crypto-ccm": [140.0, 138.0, 148.0, 143.0, 144.0, 145.0, 143.0, 147.0, 146.0, 144.0], "audio-oscillator": [111.0, 109.0, 158.0, 102.0, 105.0, 105.0, 147.0, 99.0, 100.0, 143.0], "stanford-crypto-aes": [90.0, 93.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0], "imaging-desaturate": [118.0, 118.0, 118.0, 117.0, 113.0, 119.0, 119.0, 118.0, 117.0, 110.0]}, "summary": {"suite": 1699.2000000000003, "subtests": {"audio-fft": {"filtered": 94.5, "value": 94.5}, "stanford-crypto-pbkdf2": {"filtered": 162.9, "value": 162.9}, "audio-beat-detection": {"filtered": 166.8, "value": 166.8}, "stanford-crypto-ccm": {"filtered": 143.8, "value": 143.8}, "imaging-darkroom": {"filtered": 143.4, "value": 143.4}, "json-parse-financial": {"filtered": 69.7, "value": 69.7}, "audio-oscillator": {"filtered": 117.9, "value": 117.9}, "ai-astar": {"filtered": 120.1, "value": 120.1}, "audio-dft": {"filtered": 182.1, "value": 182.1}, "stanford-crypto-sha256-iterative": {"filtered": 78.2, "value": 78.2}, "json-stringify-tinderbox": {"filtered": 73.4, "value": 73.4}, "imaging-gaussian-blur": {"filtered": 134.8, "value": 134.8}, "stanford-crypto-aes": {"filtered": 94.9, "value": 94.9}, "imaging-desaturate": {"filtered": 116.7, "value": 116.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0054"}, "testrun": {"date": 1447330163, "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": "20151112024444", "branch": "Mozilla-Aurora", "revision": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd"}}, {"talos_counters": {}, "results": {"DeltaBlue": [217.91239921551536], "Encrypt": [365.09675063891933], "NavierStokes": [6555.555555555556], "Decrypt": [6763.513513513513], "Splay": [677.8975741239892], "Richards": [186.9508319312021], "RegExp": [33177.41935483871], "Earley": [765.1109410864575], "Boyer": [14323.94366197183], "RayTrace": [1180.637544273908]}, "summary": {"suite": 17850.992314969033, "subtests": {"DeltaBlue": {"filtered": 303.4155019999999, "value": 303.4155019999999}, "Encrypt": {"filtered": 729.0697590000003, "value": 729.0697590000003}, "NavierStokes": {"filtered": 226.372881355932, "value": 226.372881355932}, "Decrypt": {"filtered": 39.35543256743254, "value": 39.35543256743254}, "Splay": {"filtered": 120.21137574552688, "value": 120.21137574552688}, "RegExp": {"filtered": 27.45798249878465, "value": 27.45798249878465}, "Richards": {"filtered": 188.83039799999997, "value": 188.83039799999997}, "Earley": {"filtered": 871.0671410000003, "value": 871.0671410000003}, "Boyer": {"filtered": 46.52789872173056, "value": 46.52789872173056}, "RayTrace": {"filtered": 626.770683, "value": 626.770683}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0054"}, "testrun": {"date": 1447330163, "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": "20151112024444", "branch": "Mozilla-Aurora", "revision": "0e9c6096f7e9d4deb0c7f98f88b5e032987bc2bd"}}] 04:29:38 INFO - RETURN: dromaeo_css: 5908.72 04:29:38 INFO - RETURN: kraken: 1699.20 04:29:38 INFO - RETURN: v8_7: 17850.99 04:29:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17850.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1699.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5908.72"}}} 04:29:38 INFO - Return code: 0 04:29:38 INFO - # TBPL SUCCESS # 04:29:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:29:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:29:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:29:38 INFO - 2015-11-12 04:29:38.487 screenresolution[1648:10089] starting screenresolution argv=screenresolution get 04:29:38 INFO - 2015-11-12 04:29:38.491 screenresolution[1648:10089] Display 0: 1600x1200x32@60 04:29:38 INFO - 2015-11-12 04:29:38.497 screenresolution[1649:10091] starting screenresolution argv=screenresolution list 04:29:38 INFO - Available Modes on Display 0 04:29:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:29:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:29:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:29:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:29:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:29:38 INFO - Intel HD Graphics 3000: 04:29:38 INFO - Chipset Model: Intel HD Graphics 3000 04:29:38 INFO - Type: GPU 04:29:38 INFO - Bus: Built-In 04:29:38 INFO - VRAM (Total): 512 MB 04:29:38 INFO - VRAM (Dynamic, Max): 10 04:29:38 INFO - Vendor: Intel (0x8086) 04:29:38 INFO - Device ID: 0x0116 04:29:38 INFO - Revision ID: 0x0009 04:29:38 INFO - Displays: 04:29:38 INFO - Display: 04:29:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:29:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:29:38 INFO - Display Serial Number: 1600x1200 60 04:29:38 INFO - Main Display: Yes 04:29:38 INFO - Mirror: Off 04:29:38 INFO - Online: Yes 04:29:38 INFO - Rotation: Supported 04:29:38 INFO - Return code: 0 04:29:38 INFO - Running post-action listener: _resource_record_post_action 04:29:38 INFO - Running post-run listener: _resource_record_post_run 04:29:39 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 37921792; Write bytes: 689183744; Read time: 4158; Write time: 62622 04:29:39 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 341094912; Write bytes: 346943488; Read time: 35872; Write time: 8842 04:29:39 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 35857408; Write bytes: 340167680; Read time: 3643; Write time: 52864 04:29:39 INFO - Running post-run listener: _upload_blobber_files 04:29:39 INFO - Blob upload gear active. 04:29:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:29:39 INFO - Copying logs to upload dir... 04:29:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.219297 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-12 04:29:39.910929) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:29:39.914039) ========= 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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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/e5oVOJoDSguYNAAgG6kqUw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010028 build_url: 'https://queue.taskcluster.net/v1/task/e5oVOJoDSguYNAAgG6kqUw/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-12 04:29:39.939756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:29:39.940064) ========= 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.oKWptB18hd/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.u7lSd87MBA/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:29:39.989275) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 04:29:39.989861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 04:29:39.990504) ========= ========= Total master_lag: 8.42 =========