builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0044 starttime: 1448361595.24 results: success (0) buildid: 20151124004047 builduid: 22d4b47d8ca5473b8e5b5b79590bf003 revision: f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.243077) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.243531) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.243869) ========= 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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.005843 basedir: '/builds/slave/test' ========= master_lag: 0.32 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.567278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.567618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.620686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.621016) ========= 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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.034820 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.677574) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.677906) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.678509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.678817) ========= 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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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-24 02:39:55-- 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% 9.02M=0.001s 2015-11-24 02:39:55 (9.02 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159406 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.876955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:55.877305) ========= 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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.138418 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:56.081670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 02:39:56.082068) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5 --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 f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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-24 02:39:56,205 truncating revision to first 12 chars 2015-11-24 02:39:56,205 Setting DEBUG logging. 2015-11-24 02:39:56,205 attempt 1/10 2015-11-24 02:39:56,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f8c58b5949a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 02:39:57,366 unpacking tar archive at: mozilla-aurora-f8c58b5949a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430271 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 02:39:57.548837) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:57.549200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:57.561707) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:57.561993) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 02:39:57.562462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 46 secs) (at 2015-11-24 02:39:57.562777) ========= /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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 02:39:57 INFO - MultiFileLogger online at 20151124 02:39:57 in /builds/slave/test 02:39:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:39:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:57 INFO - {'append_to_log': False, 02:39:57 INFO - 'base_work_dir': '/builds/slave/test', 02:39:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:39:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:57 INFO - 'branch': 'Mozilla-Aurora', 02:39:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:57 INFO - 'config_files': ('talos/mac_config.py',), 02:39:57 INFO - 'default_actions': ('clobber', 02:39:57 INFO - 'read-buildbot-config', 02:39:57 INFO - 'download-and-extract', 02:39:57 INFO - 'populate-webroot', 02:39:57 INFO - 'create-virtualenv', 02:39:57 INFO - 'install', 02:39:57 INFO - 'run-tests'), 02:39:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:57 INFO - 'download_minidump_stackwalk': True, 02:39:57 INFO - 'download_symbols': 'ondemand', 02:39:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:39:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:39:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:39:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:39:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:57 INFO - 'installer_path': 'installer.exe', 02:39:57 INFO - 'log_level': 'info', 02:39:57 INFO - 'log_name': 'talos', 02:39:57 INFO - 'log_to_console': True, 02:39:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:39:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:39:57 INFO - 'opt_config_files': (), 02:39:57 INFO - 'pip_index': False, 02:39:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:39:57 INFO - 'cmd': ('bash', 02:39:57 INFO - '-c', 02:39:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:39:57 INFO - 'enabled': True, 02:39:57 INFO - 'halt_on_failure': False, 02:39:57 INFO - 'name': 'check_screen_resolution'},), 02:39:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:39:57 INFO - 'cmd': ('bash', 02:39:57 INFO - '-c', 02:39:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:39:57 INFO - 'enabled': True, 02:39:57 INFO - 'halt_on_failure': False, 02:39:57 INFO - 'name': 'check_screen_resolution'},), 02:39:57 INFO - 'run_cmd_checks_enabled': True, 02:39:57 INFO - 'sps_profile': False, 02:39:57 INFO - 'sps_profile_interval': 0, 02:39:57 INFO - 'suite': 'dromaeojs', 02:39:57 INFO - 'system_bits': '64', 02:39:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:57 INFO - 'title': 't-yosemite-r5-0044', 02:39:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:57 INFO - 'use_talos_json': True, 02:39:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:57 INFO - 'work_dir': 'build'} 02:39:57 INFO - ##### 02:39:57 INFO - ##### Running clobber step. 02:39:57 INFO - ##### 02:39:57 INFO - Running pre-action listener: _resource_record_pre_action 02:39:57 INFO - Running main action method: clobber 02:39:57 INFO - rmtree: /builds/slave/test/build 02:39:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:40:02 INFO - Running post-action listener: _resource_record_post_action 02:40:02 INFO - ##### 02:40:02 INFO - ##### Running read-buildbot-config step. 02:40:02 INFO - ##### 02:40:02 INFO - Running pre-action listener: _resource_record_pre_action 02:40:02 INFO - Running main action method: read_buildbot_config 02:40:02 INFO - Using buildbot properties: 02:40:02 INFO - { 02:40:02 INFO - "properties": { 02:40:02 INFO - "buildnumber": 277, 02:40:02 INFO - "product": "firefox", 02:40:02 INFO - "script_repo_revision": "production", 02:40:02 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:40:02 INFO - "repository": "", 02:40:02 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:40:02 INFO - "buildid": "20151124004047", 02:40:02 INFO - "slavename": "t-yosemite-r5-0044", 02:40:02 INFO - "stage_platform": "macosx64", 02:40:02 INFO - "basedir": "/builds/slave/test", 02:40:02 INFO - "nightly_build": "True", 02:40:02 INFO - "project": "", 02:40:02 INFO - "platform": "yosemite", 02:40:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:40:02 INFO - "slavebuilddir": "test", 02:40:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:40:02 INFO - "branch": "mozilla-aurora", 02:40:02 INFO - "repo_path": "releases/mozilla-aurora", 02:40:02 INFO - "pgo_build": "False", 02:40:02 INFO - "builduid": "22d4b47d8ca5473b8e5b5b79590bf003", 02:40:02 INFO - "revision": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5" 02:40:02 INFO - }, 02:40:02 INFO - "sourcestamp": { 02:40:02 INFO - "repository": "", 02:40:02 INFO - "hasPatch": false, 02:40:02 INFO - "project": "", 02:40:02 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:40:02 INFO - "changes": [ 02:40:02 INFO - { 02:40:02 INFO - "category": null, 02:40:02 INFO - "files": [ 02:40:02 INFO - { 02:40:02 INFO - "url": null, 02:40:02 INFO - "name": "https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:40:02 INFO - } 02:40:02 INFO - ], 02:40:02 INFO - "repository": "", 02:40:02 INFO - "rev": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5", 02:40:02 INFO - "who": "sendchange", 02:40:02 INFO - "when": 1448361556, 02:40:02 INFO - "number": 6699609, 02:40:02 INFO - "comments": "", 02:40:02 INFO - "project": "", 02:40:02 INFO - "at": "Tue 24 Nov 2015 02:39:16", 02:40:02 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:40:02 INFO - "revlink": "", 02:40:02 INFO - "properties": [ 02:40:02 INFO - [ 02:40:02 INFO - "buildid", 02:40:02 INFO - "20151124004047", 02:40:02 INFO - "Change" 02:40:02 INFO - ], 02:40:02 INFO - [ 02:40:02 INFO - "builduid", 02:40:02 INFO - "22d4b47d8ca5473b8e5b5b79590bf003", 02:40:02 INFO - "Change" 02:40:02 INFO - ], 02:40:02 INFO - [ 02:40:02 INFO - "nightly_build", 02:40:02 INFO - "True", 02:40:02 INFO - "Change" 02:40:02 INFO - ], 02:40:02 INFO - [ 02:40:02 INFO - "pgo_build", 02:40:02 INFO - "False", 02:40:02 INFO - "Change" 02:40:02 INFO - ] 02:40:02 INFO - ], 02:40:02 INFO - "revision": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5" 02:40:02 INFO - } 02:40:02 INFO - ], 02:40:02 INFO - "revision": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5" 02:40:02 INFO - } 02:40:02 INFO - } 02:40:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:40:02 INFO - Running post-action listener: _resource_record_post_action 02:40:02 INFO - ##### 02:40:02 INFO - ##### Running download-and-extract step. 02:40:02 INFO - ##### 02:40:02 INFO - Running pre-action listener: _resource_record_pre_action 02:40:02 INFO - Running main action method: download_and_extract 02:40:02 INFO - mkdir: /builds/slave/test/build/tests 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/test_packages.json 02:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/test_packages.json 02:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:40:04 INFO - Downloaded 1149 bytes. 02:40:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:40:04 INFO - Using the following test package requirements: 02:40:04 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:40:04 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:40:04 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'jsshell-mac.zip'], 02:40:04 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:40:04 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:40:04 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:40:04 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:40:04 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:40:04 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:40:04 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:40:04 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:40:04 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:40: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')]} 02:40:04 INFO - https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:40:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:40:05 INFO - Downloaded 17448128 bytes. 02:40:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:40:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:40:11 INFO - Return code: 0 02:40:11 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:11 INFO - https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:40:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:40:16 INFO - Downloaded 17448128 bytes. 02:40:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:40:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:40:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:40:22 INFO - Return code: 0 02:40: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')]} 02:40:22 INFO - https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:40:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:40:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:40:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:40:24 INFO - Downloaded 11131307 bytes. 02:40:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:40:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:40:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:40:24 INFO - Return code: 0 02:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:24 INFO - https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:40:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:40:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:40:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:40:28 INFO - Downloaded 107817342 bytes. 02:40:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:40:28 INFO - mkdir: /builds/slave/test/properties 02:40:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:40:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:40:28 INFO - Contents: 02:40:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:40:28 INFO - Running post-action listener: _resource_record_post_action 02:40:28 INFO - Running post-action listener: set_extra_try_arguments 02:40:28 INFO - ##### 02:40:28 INFO - ##### Running populate-webroot step. 02:40:28 INFO - ##### 02:40:28 INFO - Running pre-action listener: _resource_record_pre_action 02:40:28 INFO - Running main action method: populate_webroot 02:40:28 INFO - Guessing talos json url... 02:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:28 INFO - https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:40:28 INFO - Downloaded 107 bytes. 02:40:28 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:40:28 INFO - Contents: 02:40:28 INFO - 20151124004047 02:40:28 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5 02:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:28 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/f8c58b5949/testing/talos/talos.json 02:40:28 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/f8c58b5949/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/f8c58b5949/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:40:29 INFO - Downloaded 4264 bytes. 02:40:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:40:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:40:29 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:40:29 INFO - '../fennec_ids.txt'], 02:40:29 INFO - 'tests': ['tcheck2']}, 02:40:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:40:29 INFO - '--tppagecycles', 02:40:29 INFO - '7'], 02:40:29 INFO - 'tests': ['tsvgm']}}, 02:40:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:40:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:40:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:40:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:40:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'tests': ['damp', 'tps']}, 02:40:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['damp', 'tps']}, 02:40:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:40:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:40:29 INFO - 'other': {'tests': ['a11yr', 02:40:29 INFO - 'ts_paint', 02:40:29 INFO - 'tpaint', 02:40:29 INFO - 'sessionrestore', 02:40:29 INFO - 'sessionrestore_no_auto_restore']}, 02:40:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['a11yr', 02:40:29 INFO - 'ts_paint', 02:40:29 INFO - 'tpaint', 02:40:29 INFO - 'sessionrestore', 02:40:29 INFO - 'sessionrestore_no_auto_restore']}, 02:40:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['a11yr', 02:40:29 INFO - 'ts_paint', 02:40:29 INFO - 'tpaint', 02:40:29 INFO - 'sessionrestore', 02:40:29 INFO - 'sessionrestore_no_auto_restore']}, 02:40:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['a11yr', 02:40:29 INFO - 'ts_paint', 02:40:29 INFO - 'tpaint', 02:40:29 INFO - 'sessionrestore', 02:40:29 INFO - 'sessionrestore_no_auto_restore']}, 02:40:29 INFO - 'other_l64': {'tests': ['a11yr', 02:40:29 INFO - 'ts_paint', 02:40:29 INFO - 'tpaint', 02:40:29 INFO - 'sessionrestore', 02:40:29 INFO - 'sessionrestore_no_auto_restore']}, 02:40:29 INFO - 'other_nol64': {'tests': ['a11yr', 02:40:29 INFO - 'ts_paint', 02:40:29 INFO - 'tpaint', 02:40:29 INFO - 'sessionrestore', 02:40:29 INFO - 'sessionrestore_no_auto_restore']}, 02:40:29 INFO - 'svgr': {'tests': ['tsvgx', 02:40:29 INFO - 'tsvgr_opacity', 02:40:29 INFO - 'tart', 02:40:29 INFO - 'tscrollx', 02:40:29 INFO - 'cart']}, 02:40:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['tsvgx', 02:40:29 INFO - 'tsvgr_opacity', 02:40:29 INFO - 'tart', 02:40:29 INFO - 'tscrollx', 02:40:29 INFO - 'cart']}, 02:40:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'tests': ['tp5o']}, 02:40:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'talos_options': ['--e10s'], 02:40:29 INFO - 'tests': ['tp5o']}, 02:40:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'talos_options': ['--xperf_path', 02:40:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:29 INFO - 'tests': ['tp5n']}, 02:40:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:29 INFO - 'talos_options': ['--e10s', 02:40:29 INFO - '--xperf_path', 02:40:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:40:29 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:40:29 INFO - 'tests': ['tp5n']}}, 02:40:29 INFO - 'talos.zip': {'path': '', 02:40:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:40:29 INFO - Running post-action listener: _resource_record_post_action 02:40:29 INFO - ##### 02:40:29 INFO - ##### Running create-virtualenv step. 02:40:29 INFO - ##### 02:40:29 INFO - Running pre-action listener: _resource_record_pre_action 02:40:29 INFO - Running main action method: create_virtualenv 02:40:29 INFO - Creating virtualenv /builds/slave/test/build/venv 02:40:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:40:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:40:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:40:29 INFO - Using real prefix '/tools/python27' 02:40:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:40:30 INFO - Installing distribute.............................................................................................................................................................................................done. 02:40:34 INFO - Installing pip.................done. 02:40:34 INFO - Return code: 0 02:40:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:34 INFO - 'HOME': '/Users/cltbld', 02:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:34 INFO - 'LOGNAME': 'cltbld', 02:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:34 INFO - 'MOZ_NO_REMOTE': '1', 02:40:34 INFO - 'NO_EM_RESTART': '1', 02:40:34 INFO - 'PAGER': '/bin/cat', 02:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:34 INFO - 'PWD': '/builds/slave/test', 02:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:34 INFO - 'SHELL': '/bin/bash', 02:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:40:34 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:34 INFO - 'USER': 'cltbld', 02:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:34 INFO - 'XPC_FLAGS': '0x0', 02:40:34 INFO - 'XPC_SERVICE_NAME': '0', 02:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:40:35 INFO - Cleaning up... 02:40:35 INFO - Return code: 0 02:40:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:40:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:40:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:35 INFO - 'HOME': '/Users/cltbld', 02:40:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:35 INFO - 'LOGNAME': 'cltbld', 02:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:35 INFO - 'MOZ_NO_REMOTE': '1', 02:40:35 INFO - 'NO_EM_RESTART': '1', 02:40:35 INFO - 'PAGER': '/bin/cat', 02:40:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:35 INFO - 'PWD': '/builds/slave/test', 02:40:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:35 INFO - 'SHELL': '/bin/bash', 02:40:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:40:35 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:40:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:35 INFO - 'USER': 'cltbld', 02:40:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:35 INFO - 'XPC_FLAGS': '0x0', 02:40:35 INFO - 'XPC_SERVICE_NAME': '0', 02:40:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:35 INFO - Downloading/unpacking psutil>=0.7.1 02:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:37 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:40:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:40:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:38 INFO - Installing collected packages: psutil 02:40:38 INFO - Running setup.py install for psutil 02:40:38 INFO - building 'psutil._psutil_osx' extension 02:40:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:40:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:40:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:40:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:40:40 INFO - building 'psutil._psutil_posix' extension 02:40:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:40:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:40:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:40:40 INFO - ^ 02:40:40 INFO - 1 warning generated. 02:40:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:40:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:40 INFO - Successfully installed psutil 02:40:40 INFO - Cleaning up... 02:40:40 INFO - Return code: 0 02:40:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:40 INFO - 'HOME': '/Users/cltbld', 02:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:40 INFO - 'LOGNAME': 'cltbld', 02:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:40 INFO - 'MOZ_NO_REMOTE': '1', 02:40:40 INFO - 'NO_EM_RESTART': '1', 02:40:40 INFO - 'PAGER': '/bin/cat', 02:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:40 INFO - 'PWD': '/builds/slave/test', 02:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:40 INFO - 'SHELL': '/bin/bash', 02:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:40:40 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:40 INFO - 'USER': 'cltbld', 02:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:40 INFO - 'XPC_FLAGS': '0x0', 02:40:40 INFO - 'XPC_SERVICE_NAME': '0', 02:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:40:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:40:43 INFO - Installing collected packages: mozsystemmonitor 02:40:43 INFO - Running setup.py install for mozsystemmonitor 02:40:43 INFO - Successfully installed mozsystemmonitor 02:40:43 INFO - Cleaning up... 02:40:43 INFO - Return code: 0 02:40:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:43 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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:43 INFO - 'HOME': '/Users/cltbld', 02:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:43 INFO - 'LOGNAME': 'cltbld', 02:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:43 INFO - 'MOZ_NO_REMOTE': '1', 02:40:43 INFO - 'NO_EM_RESTART': '1', 02:40:43 INFO - 'PAGER': '/bin/cat', 02:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:43 INFO - 'PWD': '/builds/slave/test', 02:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:43 INFO - 'SHELL': '/bin/bash', 02:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:40:43 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:43 INFO - 'USER': 'cltbld', 02:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:43 INFO - 'XPC_FLAGS': '0x0', 02:40:43 INFO - 'XPC_SERVICE_NAME': '0', 02:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:40:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:40:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:48 INFO - Downloading docopt-0.6.1.tar.gz 02:40:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:48 INFO - Running setup.py install for blobuploader 02:40:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:48 INFO - Running setup.py install for requests 02:40:48 INFO - Running setup.py install for docopt 02:40:49 INFO - Successfully installed blobuploader requests docopt 02:40:49 INFO - Cleaning up... 02:40:49 INFO - Return code: 0 02:40:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:49 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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:49 INFO - 'HOME': '/Users/cltbld', 02:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:49 INFO - 'LOGNAME': 'cltbld', 02:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:49 INFO - 'MOZ_NO_REMOTE': '1', 02:40:49 INFO - 'NO_EM_RESTART': '1', 02:40:49 INFO - 'PAGER': '/bin/cat', 02:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:49 INFO - 'PWD': '/builds/slave/test', 02:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:49 INFO - 'SHELL': '/bin/bash', 02:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:40:49 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:49 INFO - 'USER': 'cltbld', 02:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:49 INFO - 'XPC_FLAGS': '0x0', 02:40:49 INFO - 'XPC_SERVICE_NAME': '0', 02:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:49 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-Y_UPo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:49 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-p93_Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:49 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-rWwZ19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:49 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-xrFS5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:49 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-VPzYwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-kI6uxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-qvDE9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-VQudlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-bS0p6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-MQuDwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-9GzZj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-fEWfHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:50 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-MuLXFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:51 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-bfxUhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:51 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-gpupRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:51 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-WGK9gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:51 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-U0H91L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:51 INFO - Running setup.py install for manifestparser 02:40:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:51 INFO - Running setup.py install for mozcrash 02:40:51 INFO - Running setup.py install for mozdebug 02:40:52 INFO - Running setup.py install for mozdevice 02:40:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Running setup.py install for mozfile 02:40:52 INFO - Running setup.py install for mozhttpd 02:40:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Running setup.py install for mozinfo 02:40:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Running setup.py install for mozInstall 02:40:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:52 INFO - Running setup.py install for mozleak 02:40:53 INFO - Running setup.py install for mozlog 02:40:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:53 INFO - Running setup.py install for moznetwork 02:40:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:53 INFO - Running setup.py install for mozprocess 02:40:53 INFO - Running setup.py install for mozprofile 02:40:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:53 INFO - Running setup.py install for mozrunner 02:40:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:54 INFO - Running setup.py install for mozscreenshot 02:40:54 INFO - Running setup.py install for moztest 02:40:54 INFO - Running setup.py install for mozversion 02:40:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:54 INFO - Cleaning up... 02:40:54 INFO - Return code: 0 02:40:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:54 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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:40:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:54 INFO - 'HOME': '/Users/cltbld', 02:40:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:54 INFO - 'LOGNAME': 'cltbld', 02:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:54 INFO - 'MOZ_NO_REMOTE': '1', 02:40:54 INFO - 'NO_EM_RESTART': '1', 02:40:54 INFO - 'PAGER': '/bin/cat', 02:40:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:54 INFO - 'PWD': '/builds/slave/test', 02:40:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:54 INFO - 'SHELL': '/bin/bash', 02:40:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:40:54 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:40:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:54 INFO - 'USER': 'cltbld', 02:40:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:54 INFO - 'XPC_FLAGS': '0x0', 02:40:54 INFO - 'XPC_SERVICE_NAME': '0', 02:40:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:54 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-eoVlG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-XG1SLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-zyJyFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-Cc4tB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-P8SfiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-3qcRKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-u2BPy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-0E5Xjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:55 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-KakT3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-v5xvcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-r1UTwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-yTRQny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-wNKjjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-RK6Z_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-5badht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-SFJgCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:56 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-rWIqOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:59 INFO - Downloading blessings-1.5.1.tar.gz 02:40:59 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:59 INFO - Installing collected packages: blessings 02:40:59 INFO - Running setup.py install for blessings 02:40:59 INFO - Successfully installed blessings 02:40:59 INFO - Cleaning up... 02:40:59 INFO - Return code: 0 02:40:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:00 INFO - Reading from file tmpfile_stdout 02:41:00 INFO - Current package versions: 02:41:00 INFO - blessings == 1.5.1 02:41:00 INFO - blobuploader == 1.2.4 02:41:00 INFO - docopt == 0.6.1 02:41:00 INFO - manifestparser == 1.1 02:41:00 INFO - mozInstall == 1.12 02:41:00 INFO - mozcrash == 0.16 02:41:00 INFO - mozdebug == 0.1 02:41:00 INFO - mozdevice == 0.46 02:41:00 INFO - mozfile == 1.2 02:41:00 INFO - mozhttpd == 0.7 02:41:00 INFO - mozinfo == 0.8 02:41:00 INFO - mozleak == 0.1 02:41:00 INFO - mozlog == 3.0 02:41:00 INFO - moznetwork == 0.27 02:41:00 INFO - mozprocess == 0.22 02:41:00 INFO - mozprofile == 0.27 02:41:00 INFO - mozrunner == 6.11 02:41:00 INFO - mozscreenshot == 0.1 02:41:00 INFO - mozsystemmonitor == 0.0 02:41:00 INFO - moztest == 0.7 02:41:00 INFO - mozversion == 1.4 02:41:00 INFO - psutil == 3.1.1 02:41:00 INFO - requests == 1.2.3 02:41:00 INFO - wsgiref == 0.1.2 02:41:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x109f70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1ac3ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, '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.Jgqqdkn7lA/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.P0uQldZntB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:41:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:00 INFO - 'HOME': '/Users/cltbld', 02:41:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:00 INFO - 'LOGNAME': 'cltbld', 02:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:00 INFO - 'MOZ_NO_REMOTE': '1', 02:41:00 INFO - 'NO_EM_RESTART': '1', 02:41:00 INFO - 'PAGER': '/bin/cat', 02:41:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:00 INFO - 'PWD': '/builds/slave/test', 02:41:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:00 INFO - 'SHELL': '/bin/bash', 02:41:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:41:00 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:41:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:00 INFO - 'USER': 'cltbld', 02:41:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:00 INFO - 'XPC_FLAGS': '0x0', 02:41:00 INFO - 'XPC_SERVICE_NAME': '0', 02:41:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:00 INFO - Cleaning up... 02:41:00 INFO - Return code: 0 02:41:00 INFO - Running post-action listener: _resource_record_post_action 02:41:00 INFO - Running post-action listener: _start_resource_monitoring 02:41:00 INFO - Starting resource monitoring. 02:41:00 INFO - ##### 02:41:00 INFO - ##### Running install step. 02:41:00 INFO - ##### 02:41:00 INFO - Running pre-action listener: _resource_record_pre_action 02:41:00 INFO - Running main action method: install 02:41:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:00 INFO - Reading from file tmpfile_stdout 02:41:00 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:01 INFO - Reading from file tmpfile_stdout 02:41:01 INFO - Output received: 02:41:01 INFO - Usage: mozinstall [options] installer 02:41:01 INFO - Options: 02:41:01 INFO - -h, --help show this help message and exit 02:41:01 INFO - -d DEST, --destination=DEST 02:41:01 INFO - Directory to install application into. [default: 02:41:01 INFO - "/builds/slave/test"] 02:41:01 INFO - --app=APP Application being installed. [default: firefox] 02:41:01 INFO - mkdir: /builds/slave/test/build/application 02:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:41:38 INFO - Reading from file tmpfile_stdout 02:41:38 INFO - Output received: 02:41:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:41:38 INFO - Running post-action listener: _resource_record_post_action 02:41:38 INFO - ##### 02:41:38 INFO - ##### Running run-tests step. 02:41:38 INFO - ##### 02:41:38 INFO - Running pre-action listener: _resource_record_pre_action 02:41:38 INFO - Running main action method: run_tests 02:41:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:41:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:41:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:41:38 INFO - 2015-11-24 02:41:38.720 screenresolution[1640:9214] starting screenresolution argv=screenresolution get 02:41:38 INFO - 2015-11-24 02:41:38.723 screenresolution[1640:9214] Display 0: 1600x1200x32@60 02:41:38 INFO - 2015-11-24 02:41:38.730 screenresolution[1641:9216] starting screenresolution argv=screenresolution list 02:41:38 INFO - Available Modes on Display 0 02:41:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:41:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:41:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:41:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:41:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:41:38 INFO - Intel HD Graphics 3000: 02:41:38 INFO - Chipset Model: Intel HD Graphics 3000 02:41:38 INFO - Type: GPU 02:41:38 INFO - Bus: Built-In 02:41:38 INFO - VRAM (Total): 512 MB 02:41:38 INFO - VRAM (Dynamic, Max): 10 02:41:38 INFO - Vendor: Intel (0x8086) 02:41:38 INFO - Device ID: 0x0116 02:41:38 INFO - Revision ID: 0x0009 02:41:38 INFO - Displays: 02:41:38 INFO - Display: 02:41:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:41:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:41:38 INFO - Display Serial Number: 1600x1200 60 02:41:38 INFO - Main Display: Yes 02:41:38 INFO - Mirror: Off 02:41:38 INFO - Online: Yes 02:41:38 INFO - Rotation: Supported 02:41:38 INFO - Return code: 0 02:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:41:38 INFO - Python 2.7.3 02:41:38 INFO - Return code: 0 02:41:38 INFO - grabbing minidump binary from tooltool 02:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:38 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 0x109f259f0>, '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 0x109c84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eef990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:41:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:41:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:41:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:41:39 INFO - Return code: 0 02:41:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:41:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:41:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:41:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:41:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:41:39 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/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0044', '--webServer', 'localhost'] in /builds/slave/test/build 02:41:39 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/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0044 --webServer localhost 02:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgqqdkn7lA/Render', 02:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:39 INFO - 'HOME': '/Users/cltbld', 02:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:39 INFO - 'LOGNAME': 'cltbld', 02:41:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:41:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:39 INFO - 'MOZ_NO_REMOTE': '1', 02:41:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:41:39 INFO - 'NO_EM_RESTART': '1', 02:41:39 INFO - 'PAGER': '/bin/cat', 02:41:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:39 INFO - 'PWD': '/builds/slave/test', 02:41:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:39 INFO - 'SHELL': '/bin/bash', 02:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0uQldZntB/Listeners', 02:41:39 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 02:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:39 INFO - 'USER': 'cltbld', 02:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:39 INFO - 'XPC_FLAGS': '0x0', 02:41:39 INFO - 'XPC_SERVICE_NAME': '0', 02:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:41:39 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/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0044', '--webServer', 'localhost'] with output_timeout 3600 02:41:39 INFO - mozversion INFO | application_buildid: 20151124004047 02:41:39 INFO - mozversion INFO | application_changeset: f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5 02:41:39 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:41:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:41:39 INFO - mozversion INFO | application_name: Firefox 02:41:39 INFO - mozversion INFO | application_remotingname: firefox-dev 02:41:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:41:39 INFO - mozversion INFO | application_vendor: Mozilla 02:41:39 INFO - mozversion INFO | application_version: 44.0a2 02:41:39 INFO - mozversion INFO | platform_buildid: 20151124004047 02:41:39 INFO - mozversion INFO | platform_changeset: f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5 02:41:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:41:39 INFO - mozversion INFO | platform_version: 44.0a2 02:41:39 INFO - 2015-11-24 02:41:39,446 DEBUG : using testdate: 1448361699 02:41:39 INFO - 2015-11-24 02:41:39,446 DEBUG : actual date: 1448361699 02:41:39 INFO - 2015-11-24 02:41:39,525 INFO : starting webserver on 'localhost:49267' 02:41:39 INFO - 2015-11-24 02:41:39,526 INFO : Starting test suite t-yosemite-r5-0044 02:41:39 INFO - 2015-11-24 02:41:39,527 INFO : Starting test dromaeo_css 02:41:39 INFO - 2015-11-24 02:41:39,527 DEBUG : operating with platform_type : mac_ 02:41:39 INFO - 2015-11-24 02:41:39,528 INFO : Initialising browser for dromaeo_css test... 02:41:39 INFO - 2015-11-24 02:41:39,559 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmpN8ZKl1/profile http://localhost:49267/getInfo.html 02:41:42 INFO - 2015-11-24 02:41:42,656 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:41:42 INFO - 2015-11-24 02:41:42,656 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:41:42 INFO - 2015-11-24 02:41:42,656 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:41:42 INFO - 2015-11-24 02:41:42,656 DEBUG : BROWSER_OUTPUT: __metrics 02:41:42 INFO - 2015-11-24 02:41:42,672 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:41:43 INFO - 2015-11-24 02:41:43,388 INFO : Browser initialized. 02:41:43 INFO - 2015-11-24 02:41:43,389 INFO : Running cycle 1/1 for dromaeo_css test... 02:41:43 INFO - 2015-11-24 02:41:43,389 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmpN8ZKl1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:41:55 INFO - 2015-11-24 02:41:55,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 199090176 02:41:55 INFO - 2015-11-24 02:41:55,339 DEBUG : BROWSER_OUTPUT: 02:42:47 INFO - 2015-11-24 02:42:47,176 DEBUG : BROWSER_OUTPUT: 1448361767173 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:44:57 INFO - 2015-11-24 02:44:57,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 02:44:58 INFO - 2015-11-24 02:44:58,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 300130304 02:44:58 INFO - 2015-11-24 02:44:58,635 DEBUG : BROWSER_OUTPUT: 02:48:01 INFO - 2015-11-24 02:48:01,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 02:48:01 INFO - 2015-11-24 02:48:01,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 345600000 02:48:01 INFO - 2015-11-24 02:48:01,796 DEBUG : BROWSER_OUTPUT: 02:51:04 INFO - 2015-11-24 02:51:04,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 02:51:04 INFO - 2015-11-24 02:51:04,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 337899520 02:51:04 INFO - 2015-11-24 02:51:04,654 DEBUG : BROWSER_OUTPUT: 02:54:06 INFO - 2015-11-24 02:54:06,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 02:54:07 INFO - 2015-11-24 02:54:07,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 302178304 02:54:07 INFO - 2015-11-24 02:54:07,241 DEBUG : BROWSER_OUTPUT: 02:57:10 INFO - 2015-11-24 02:57:10,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 02:57:10 INFO - 2015-11-24 02:57:10,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 302125056 02:57:10 INFO - 2015-11-24 02:57:10,841 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 03:00:13 INFO - 2015-11-24 03:00:13,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 348090368 03:00:13 INFO - 2015-11-24 03:00:13,561 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,561 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:00:13 INFO - 2015-11-24 03:00:13,561 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:00:13 INFO - 2015-11-24 03:00:13,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:00:13 INFO - 2015-11-24 03:00:13,562 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:00:13 INFO - 2015-11-24 03:00:13,562 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3065;3074.0931425229555;3156.779025468218;3189.2186414328485;3220.1627576830024;5012.951622321708;5068.898622027562;5078.238264260358;5091.083604951107;5095.312132862072;5094.363204599425;5107.846764597068;5126.345181195778;5126.897462050766;5144.485551444854;4725.3384526166365;4762.499937506564;4804.83183088592;4833.178359678863;4879.609631229511;4694.483606803249;4774.952250477503;4860.1494738420815;4870.293807397925;4878.853634390974;4871.853844384656;4975.12935236334;4976.552110310071;4977.576905962997;5003.724795136266;4899.265110233458;4932.112219800434;4936.90126197474;4958.231474121517;4961.950380496185;4607.493175750665;4653.58117769399;4721.905561888743;4756.762161891892;4772.451168115676;5077.695338279715;5115.5396014358885;5120.743962801882;5158.12311906973;5247.86880327991;5110.565601923841;5537.778488860441;5539.335279766414;5543.722813859331;5543.833684989457;5438.809641662562;5505.504504594605;5516.696581688006;5523.972380138114;5539.501444869981;5177.689338639619;5191.714455704935;5215.765290561896;5231.921521177185;5239;5428.782848686008;5638.379778224392;5772.191893134965;5774.566907481955;5831.183634291203;5339.092354299778;5366.6779993200535;5367.651102678392;5453.863653408617;5491.2312276281355;5562.02664533705;5583.246261754693;5603.355614104348;5610.242617246619;5644.153376993484;5253.317068781034;5498.560115190775;5508.256385388001;5519.779208831602;5556.638818476786;5291.682499050069;5398.46015398457;5412.891742165135;5441.102218133963;5467.398586155519;4217.493900731871;4241.830326786956;4261.659067274611;4264.87205383839;4280.165367753259;3749.9625003750157;3858.1897801462005;3865.091703449687;3877.1470276539117;3882.0488980199466;5043.067032598908;5179.61152913533;5181.4041385240425;5185.066687996197;5211.5049070338255;5531.363893152258;5553.4724201200825;5558.027345214571;5565.610407271533;5575.498205161473;4955.702657840541;5172.379314482287;5186.429492755794;5199.870003249874;5224.791008359623;4635.258358662665;4721.881952951204;4745.098431298112;4754.23932170851;4778.665493415497;5580.358258800209;5671.801486947937;5679.744411501575;5706.144078388275;5733.942660573508;5326;5612.635178713534;5642.153676948491;5654.434556544313;5683.261176047087;5499.037668407933;5519.034169020486;5535.474129957647;5622.662640241599;5628.634138780966;5510.063289240758;5556;5574.052411090205;5580.888382232414;5616.438356164351;5161.380634323755;5606.467385598362;5613.46672066153;5631.183478395692;5633.492985631313;5274.261603375608;5277.472252774692;5279.076161671769;5344.919826202688;5390.946090539044;5404.162354835007;5431.592630552804;5455.399906010415;5460.31746031746;5478.753456094406;5135.563477104339;5374.516293533445;5389.7035663038905;5390.62265641417;5395.2176934343515;5322.148456246982;5411.134218525017;5413.350397952271;5434.049041417815;5455.427180146186;5260.579153667774;5276.973615131899;5311.601629877698;5311.814086506954;5358 03:00:13 INFO - 2015-11-24 03:00:13,562 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.4595404595404;544.0207626272709;547.7179252684869;548.659830904839;561.9831405057845;31501.212469688267;32385.51421728676;38553.228935421306;38704;38929.22141557167;41142.177156456855;41177;41602;41611.37582936259;41621.16757664845;8175.836483270331;8874.733757987271;8985.820283594325;8988.011318754965;9026.097390260955;8330.166983301682;10663.78672426551;10708.089812365919;10818.945905270502;10905.509252083675;10361.326513776618;10603.416812075333;10628.521716522775;10667.679969600924;10677.145828333754;8348.958255208745;8560.743177704679;10493.160547156209;10542.525586348633;10625.043746062853;10373.11828494579;10406.843897341547;10541.736456588647;10547.103496202832;10560.102391296672;38018.80990595057;38345.61654383476;38365.61634383648;38450;38496.80751596252;2846.9430611387866;2916.1251624512774;2952.9557056644167;2971.8514074296413;3392.1689186149306;25847;26060.8696956514;26624.20127396181;26777.330566735793;27847.30381740473;2264.569731750962;2279.806216471602;2287.0508738873345;2292.071710957065;2299.9540009199723;275141;276092;276103;277005;281017;53068;54314.185287220724;56295.43704562984;56478;57472.71263643655;52311.73844130755;52547.474525254256;52633;52669;52896;16576.585585360463;16647.66704665924;16656.50030499087;16672.083035432926;16693.165341733107;12602.81095783564;12871.871281287067;12876.291803950686;12901.870981290254;12966.22202667824;18061.638767224846;18153.636927261647;18276.26894924215;18287.817121828877;18288.177032033323;7307.123145222501;7511.474196806171;7522.172561018284;7554.2823431773895;7585.62071896403;899.9325050621229;917.6191880369572;990;1033.2973577966904;1059.95230214639;26948.191554253404;28024.43951120966;28135.155945321672;28205.858970705016;28331.460814420563;985.3201291109111;1024.6516184497307;1056.804491169136;1058.99470502647;1099.120703437263;13335.599932002055;14354.641133971525;14378.85621143796;14583;14613.634659133395;310240;315482;315634;316912;318646;53770;54217.72891135598;54222.186667200025;54263.18605220925;54950;1338.7924871644911;1363.175278956237;1367.4325155060737;1369.0553518072497;1379.344811214665;26639;27050;27416.451670966868;27424;27909.16272511828;46491.76754116208;46884.7655761719;47021;47069;47122;273365;279031;282635;381338;392736;26829.731702683504;26923.92304307806;26989.59515607307;27469.31326716768;27717.722822771513;36251.81874090613;39049.414258785575;39626.60373396229;39674.80162599284;40270.39594406028;30814.845925770227;31119;32956.67043329632;33985.490217646264;34369.14077148091;33036.66963330336;33101.66898330986;33563.32873342568;34457.138571535914;35106.47340289847;34192.658073419945;34712.652873471954;34901.8254908734;34929;35041.474377883846;26653.7334626659;29933.401331973673;30131;30359;31320.530192047594;22889.427764306027;23159.536809264057;23459.88270058639;23505.41236469102;23733 03:00:13 INFO - 2015-11-24 03:00:13,562 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.3803945838305;342.6248258157317;343.6288808087266;344.21347221598654;347.53430403259625;13818.516351927685;14169.362378692958;17022.404215852446;17067.487975360742;17625.471235862944;14855.480058197965;16082.758758618631;18006.369777057807;18587;18753.62492750144;5267.683938963655;5378.031954248234;5395.0558652235895;5401.945980540203;5435.565154787608;4043.65628921542;4184.351425529033;4561.270196768518;6045.546584006195;6053.1828203192445;5748.626339287933;5888.146218798272;5931.228940237763;5946.316173640022;5958;4421.425214722098;4525.615322697575;4541.931871021938;5889.7644094236175;5932.792352267671;3879.670228030621;3886.203328317688;3888.9611103889165;3891.007793012792;3902.6487616114687;12201.20692155007;12576.748465030649;12622.81065784014;12677.809832852423;12685.302308373035;1800.3158799656178;1870.644577530265;1872.9250829966784;1989.8607097503182;2035.6742921132548;9115.5442227889;9205.309601779827;9454.716358509255;9479.194268487186;9625.807483850354;1474.0934325389808;1504;1533.8159420869456;1550.7286224910595;1583.1688363609082;55544;55776;56022;57702.42297577055;58422.41577584212;6369.299377068519;6508.934910650928;6509.511786616023;6546.24718157418;6563.8359041023405;7521.811954701177;7535.660895259726;7540.472166948261;7551.433642476836;7632.618369081523;5298.841034768963;5314.73426328682;5332.68003919766;5338.839834804962;5340.652857564246;5547.278853749068;5570.275864137636;5596.160575913564;5604.32748070226;5644.379118296984;2895.7972941893863;2948.174511136885;2973.093206571973;2974.5538169274782;2975.6577993530586;1015.2994433840627;1038.9636362727267;1043.7025447747355;1052.852390893914;1088.6189833558192;414.2646801926544;417.58855069863665;433.6899117131266;443.5143517847951;446.62706639955354;10581.57673693059;11228.214025018333;11633.127515436207;11866.288022718665;11970.162088653711;454.19380599436266;460.63609748298467;461.61916418954496;466.62203615071223;478.38288607696376;6093.360197179321;6217.533684973645;6286.968565157145;6300.432961033529;6334.524910631629;609244;620849;623688.8815555893;637141;638289;61213;62418.375816242165;62588.68705656443;63237;70589.64705176442;444.9911001779946;453.4898239480584;455.90198107407065;456.4408599465628;457.77568991194073;9871;9917.504124793588;10012.299139060196;10144.797104058025;10429.895701042893;33529.49705754367;33806.49290260599;34208.486872697424;34495.827520862236;35259.47110793289;46699.76650116728;46909.76545117253;47180.52819471761;49227.26159107545;49327.753361232964;14339.283035848375;14705.191214482878;15175.772363414337;15225.923870380577;15354.232288385312;18162.182701778187;18199.181036853108;18407.53981150482;18895;19103.617927641648;14577.416903323749;14619.342129603981;14903.62740931442;15133.924330378277;15220.391184352502;7257.129144502694;8949.955250223707;9132.589033493641;9168.862467063132;14260.358283877458;8963.507007114671;9357.06429357059;9412.576434060347;9427.952860235655;9614.759631009001;13925.72148557003;14243.786343205067;14398.856011439751;14585.051971621811;14687.943687883491;8699.69551065735;14245.64385890361;14460.710785784437;14639.194844283667;14724.77912831287 03:00:13 INFO - 2015-11-24 03:00:13,562 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1265.886070253677;1353.3368649361812;1536.492957324083;1556.2218890554723;1800.6488734696738;6943.583384996904;7634.58009809461;7738.148803631596;7743;7812.296893279604;7445.702171913117;7589.582572958485;7628.084629844427;7643.082830060401;7657.961710191441;2116.968245476319;2117.0473287020827;2132.360291912428;2134.4770531219797;2139.6255655260343;2196.439907823503;2196.967045494319;2230.174835310929;2234.0728597631964;2236.6197746383073;2067.3384516954507;2081.646120159569;2097.056324653904;2101.5901899129676;2125.9255926042592;2123.214410668055;2134.423705599487;2135.3273718778537;2137.593857167133;2141.892905354734;2134.413036414983;2179.24815938501;2184.3337781976493;2186.7375914890313;2187.201671389947;6926.099607051102;7115.89326160108;7500.287472690085;7537.849243015164;7543.057117860268;4518.977405112986;4674.135284972291;4679.578837904571;4684.8360307389075;4695.5069717679835;2636.6967798703204;2681.3564744461382;2713.8236014658983;2732.0301293040884;2742.4515096980685;793.4683761879554;814.3200427642926;826.8718348655968;830.4560512864084;833.0919297965247;10115.291929564934;10170.745731356701;10179.643712470028;10181;10205.336653117523;4177.937330940038;4177.97911010443;4229.175310814423;4237.343211802176;4240.49114106303;8882.51146186953;8926.776830579287;8935.597898094602;8944.5080520572;8996.685116020908;4680.95319046812;4684.859454216379;4693.460252070987;4699.671023028423;4711.882202944954;4244.405783190356;4273.316269396882;4278.828846846091;4279.593438623326;4303.2469317869245;3490.458978858281;3504.404251277289;3508.5789705235534;3521.6478352164577;3556.0398692353438;1113.9417553324374;1125.943702814856;1126.6113190949109;1142.5087212498538;1146.644540192543;1257.4655771297346;1260.5084017233287;1290.9870901291056;1299.0841456772953;1302.947882084725;6964;7261.237570055068;7316.268373162641;7434.070741157356;7503;1096.8245080787035;1106.242224076494;1120.2158489057692;1120.8094623913955;1136.6249137784512;5536.474034966672;5743.4256574342235;5801.071828507503;5818.8254352369495;5826.650400975955;7903.170167132484;8821.161989610977;8957.059508751487;8966.417182883091;8972;8874.689385871592;8876.289896808239;8893.4663920165;8914.55427228636;8917.955410223038;7125.216226215112;7164.498485105993;7222.602756848319;7240.674169662378;7247.565146091251;7109.928900711134;7164.749233776793;7175.748848790267;7176.067111275501;7191.7842464726145;7667.386609071149;7956.482828616122;8000.879986800319;8051.114377418597;8051.798705032421;7783.066032076187;8342.332613391036;8352.791180220544;8365.707200248205;8366.372522060748;6823;6930.549514281555;6941.548799328028;6945.895811562932;6959;7406.333429991111;7465.552066876005;7522.623868806429;7524.322810947041;7543.245675432413;6940.722371105099;6996.370326670624;7048.506604537633;7071.328223818729;7079.2566780487305;6809.455243580403;6869.175698916162;6880.415164711056;6924.965375173092;6962.1297337832775;6895.448364130958;7041.049458323266;7052.647367631701;7073.045138906387;7096.929030709627;6306.558540902093;6325.841853953504;6331.493480521455;6343.55595108338;6348.873022539431;6377.202849643794;6476.028595710681;6497.610143391223;6506.02409638558;6506.154199953976 03:00:13 INFO - 2015-11-24 03:00:13,566 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.2937522762309;323.44529132537707;323.97084262416377;327.74927180706754;332.26900818199965;5817.360090390064;5822.854428639286;5841.474267315941;5843.152742852284;5873.324567674718;5638.915416268759;5676.858078548038;5733.770649174028;5801.883962320751;5817.767289308433;4532.592066713995;4568.360429539867;4570.040291538781;4601.838935637254;4608.930866037021;4459.375687403766;4571.3600095986585;4577.450705915295;4592.173408786417;4618.884527886796;4499.662525310615;4506.954930450703;4542.386777785006;4546.022605139894;4570.565796249351;4498.460184777815;4539.615417297723;4543.591076803087;4549.749763762991;4560.703554268962;3954.4859168307935;3958.2281455116263;3966.9008274793073;3970.3647416413523;3971.344728119857;5458.972705136449;5578.163275508666;5593.692346920918;5603.523700485463;5617.129344951539;5036.244563315532;5096.490350964911;5126.6923984561045;5128.666636668642;5134.383873935114;6165.10605962133;6165.383461653843;6175.104609831549;6175.135481032659;6224.470919971808;4256.616904478612;4273.059926816096;4274.081072569413;4275.251830929575;4297.269464191064;6253.218347706536;6331.493480521547;6423.87152256957;6448.774292899726;6460.676966151674;4333.696641235147;4351.26028575143;4352.064306174125;4357.825686972549;4362.476502819619;4429.379886815848;4442.711223770445;4458;4464.9107017860115;4464.955350446519;5084.644074914794;5094.337736094284;5099.59203263738;5106.846794596168;5140.228965655182;5971.223740913741;6130.540209484307;6143.477804386588;6161.876762464725;6201.379862013853;1556.2452210678039;1602.6874759422035;1605.229489844881;1606.229010075147;1612.9354825806836;1052.7999680060764;1058.9523471443804;1072.254782925859;1077.186724023373;1080.7568297133082;5895.204147440127;5898.64608123514;5913.319968203712;5927.051671732588;5943.494802941798;6374.362563743589;6385.425311721968;6387;6410.839729006812;6416.133821934072;5752.856178595485;5765.279340082489;5783.103618939072;5819.447152520504;5841.532677385799;3513.3675938331344;3513.7540372174212;3518.225990282134;3522.735794815399;3528.4178110611974;6401.135846660734;6401.9039714404325;6420.422162005349;6508.772192973223;6532.771353002622;6444.452221561126;6547.410733034049;6550.639714815731;6554.279029306773;6569.80290591283;6394.296627370985;6461.321561236003;6470.061841033118;6476.676166191766;6533;6377.840553986002;6382.808515744535;6395.936040639534;6408.14163892466;6422.454091402096;6182.752689892533;6288.591241569284;6292.465140463112;6348.143000695032;6373.808785736435;6461.57999730016;6465.967670161619;6472.805815825533;6473.643949582818;6484.254310754323;4069.003094241811;4070.1859628075094;4087.1417002428634;4092.672586193157;4097.8770636880945;6191.876162476815;6335.746570137143;6337.936620633919;6340.968295158495;6389.520785941166;6222.222222222223;6234.407731265523;6240.469560087444;6247.250329960252;6273.874522509615;6220.502359811114;6232.688365581794;6235.127082208585;6242.937570624235;6244.406781355764;5948.702564871825;6106.816795496142;6107.6640784757265;6110;6116.5412594056515;6214.564980451325;6232.470240029648;6283.905741413974;6289.842753931189;6292.119103325446;6080.8783824324155;6097.695115244132;6127.877442451037;6145.877082458236;6151.2618485781995 03:00:13 INFO - 2015-11-24 03:00:13,567 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.278375746073;739.3789217057671;741.066256516789;744.6202436757254;745.6905384265526;13173;13528.661783455405;13538.593842184726;13559;13562.05065645404;12101.818472722916;12143.878561214386;12252.387380630955;13623.114497557652;13770.380332885019;699.7131176217752;857.8327226190895;858.5921687198593;859.7678626770768;862.1981557151846;701.6667083135495;833.8832563441123;849.6346570974479;853.8975322961253;856.6958729650946;880.5113162194979;880.5289170293894;880.5553195636195;880.6433394475248;883.6244596046687;727.3599232675239;733.1239169192817;881.801594641207;902.2917010147036;930.7207837648679;652.4682383857189;653.598037207119;653.8692261547709;666.4435196610835;671.9899201511981;13541.05212635116;14151.29243537819;14168.645783855383;14206.431742730278;14476;10938.343699378063;11428.599999000078;11628.709282267926;11984.460699268553;12451.315177665316;8841.602127904196;8944.508052057134;8982.10178982103;9066.138716821892;9180.17378435944;3217.9195520112185;3233.854476548561;3325.8503367348526;3329.28420389615;3355.781874178195;48708.756456217845;49229.75385123052;49530.7523462384;49790.253146202835;50089;8839.911600883908;9061.637534498677;9161.175494205554;9198.586063627154;9268.953655231815;18963.241470341032;19005.714914276297;19055.61888762217;19075.523111922314;19090.427287181406;6545.181852268466;6792;6873.278305777922;7002.229754726976;7056.6118863463;3718.200586873835;3829.9617003830163;3871.090293780959;3887.7278590498395;3910.3743401055694;2904.9273768155545;2954.4681957247903;2960.83715395651;2963.185124090849;2966.006387860091;432.9675274354436;439.04069607906825;443.45898004434537;446.9910601788011;447.2151374338016;477.9808807647655;497.9775910084055;520.3339725151811;543.3642638113416;564.610418811019;8110.391720620977;8147.79630509242;8318.334533237326;8448.619812108469;8647.827043459096;455.4193403410612;468.4308565093428;495.6530826536347;568.3464016381195;610.386561505684;3425.246445781924;3752.9061773455337;3780.0738818989525;3835.2521258354354;3922.8626998054933;53289.73355133199;53507.732461337444;54021;54364.18453723197;57896;46288.768556157;46578.30132548015;47990.28014579784;50543.24185137226;51261;46020;46540.7672961633;46617.30074048892;47181.5281847184;47608.5239147611;7817.765467035998;7917.327027202752;8118.431709780259;8307.127751585997;8316.62575184106;34499.65500345065;34645.65354346424;35128.29743405169;35397.46903796497;35620;43602;45934.54065459436;46817.297740533235;46856.7657161712;47089.764551177024;7431.777046688608;7435.814104647211;7545;7621.009268795021;7727.227277272228;10790.1367890567;11133.777324453627;11196.66410007701;11320.37737924422;11739.413029348327;9764.414135151914;10109.39343639384;10169.89830101719;10172.033656802592;10250.38497690141;10214.438205898747;10500.842487362543;10513.158947284352;10526.736831579272;10631.840522392326;10296.485175741333;10354.482275886025;10412.114970227312;10415.895841041493;10419.947900260753;9084.500352480676;9117.680881169128;9487.952560237154;9533.761655958378;9603.519824008912;8803.911960880308;8893.644254230017;9048.230900373543;9050.547472626211;9067.183953443959 03:00:13 INFO - 2015-11-24 03:00:13,567 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:00:13 INFO - 2015-11-24 03:00:13,567 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1028 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: __startTimestamp1448362813553__endTimestamp 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:00:13 INFO - 2015-11-24 03:00:13,568 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,569 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5146.70 Median:5277.47 stddev:544.58 (10.3%) stddev-sans-first:521.19 03:00:13 INFO - 2015-11-24 03:00:13,569 DEBUG : BROWSER_OUTPUT: Values: 3065.0 3074.1 3156.8 3189.2 3220.2 5013.0 5068.9 5078.2 5091.1 5095.3 5094.4 5107.8 5126.3 5126.9 5144.5 4725.3 4762.5 4804.8 4833.2 4879.6 4694.5 4775.0 4860.1 4870.3 4878.9 4871.9 4975.1 4976.6 4977.6 5003.7 4899.3 4932.1 4936.9 4958.2 4962.0 4607.5 4653.6 4721.9 4756.8 4772.5 5077.7 5115.5 5120.7 5158.1 5247.9 5110.6 5537.8 5539.3 5543.7 5543.8 5438.8 5505.5 5516.7 5524.0 5539.5 5177.7 5191.7 5215.8 5231.9 5239.0 5428.8 5638.4 5772.2 5774.6 5831.2 5339.1 5366.7 5367.7 5453.9 5491.2 5562.0 5583.2 5603.4 5610.2 5644.2 5253.3 5498.6 5508.3 5519.8 5556.6 5291.7 5398.5 5412.9 5441.1 5467.4 4217.5 4241.8 4261.7 4264.9 4280.2 3750.0 3858.2 3865.1 3877.1 3882.0 5043.1 5179.6 5181.4 5185.1 5211.5 5531.4 5553.5 5558.0 5565.6 5575.5 4955.7 5172.4 5186.4 5199.9 5224.8 4635.3 4721.9 4745.1 4754.2 4778.7 5580.4 5671.8 5679.7 5706.1 5733.9 5326.0 5612.6 5642.2 5654.4 5683.3 5499.0 5519.0 5535.5 5622.7 5628.6 5510.1 5556.0 5574.1 5580.9 5616.4 5161.4 5606.5 5613.5 5631.2 5633.5 5274.3 5277.5 5279.1 5344.9 5390.9 5404.2 5431.6 5455.4 5460.3 5478.8 5135.6 5374.5 5389.7 5390.6 5395.2 5322.1 5411.1 5413.4 5434.0 5455.4 5260.6 5277.0 5311.6 5311.8 5358.0 03:00:13 INFO - 2015-11-24 03:00:13,569 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,569 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46396.32 Median:16452.63 stddev:80427.56 (488.8%) stddev-sans-first:80579.48 03:00:13 INFO - 2015-11-24 03:00:13,570 DEBUG : BROWSER_OUTPUT: Values: 540.5 544.0 547.7 548.7 562.0 31501.2 32385.5 38553.2 38704.0 38929.2 41142.2 41177.0 41602.0 41611.4 41621.2 8175.8 8874.7 8985.8 8988.0 9026.1 8330.2 10663.8 10708.1 10818.9 10905.5 10361.3 10603.4 10628.5 10667.7 10677.1 8349.0 8560.7 10493.2 10542.5 10625.0 10373.1 10406.8 10541.7 10547.1 10560.1 38018.8 38345.6 38365.6 38450.0 38496.8 2846.9 2916.1 2953.0 2971.9 3392.2 25847.0 26060.9 26624.2 26777.3 27847.3 2264.6 2279.8 2287.1 2292.1 2300.0 275141.0 276092.0 276103.0 277005.0 281017.0 53068.0 54314.2 56295.4 56478.0 57472.7 52311.7 52547.5 52633.0 52669.0 52896.0 16576.6 16647.7 16656.5 16672.1 16693.2 12602.8 12871.9 12876.3 12901.9 12966.2 18061.6 18153.6 18276.3 18287.8 18288.2 7307.1 7511.5 7522.2 7554.3 7585.6 899.9 917.6 990.0 1033.3 1060.0 26948.2 28024.4 28135.2 28205.9 28331.5 985.3 1024.7 1056.8 1059.0 1099.1 13335.6 14354.6 14378.9 14583.0 14613.6 310240.0 315482.0 315634.0 316912.0 318646.0 53770.0 54217.7 54222.2 54263.2 54950.0 1338.8 1363.2 1367.4 1369.1 1379.3 26639.0 27050.0 27416.5 27424.0 27909.2 46491.8 46884.8 47021.0 47069.0 47122.0 273365.0 279031.0 282635.0 381338.0 392736.0 26829.7 26923.9 26989.6 27469.3 27717.7 36251.8 39049.4 39626.6 39674.8 40270.4 30814.8 31119.0 32956.7 33985.5 34369.1 33036.7 33101.7 33563.3 34457.1 35106.5 34192.7 34712.7 34901.8 34929.0 35041.5 26653.7 29933.4 30131.0 30359.0 31320.5 22889.4 23159.5 23459.9 23505.4 23733.0 03:00:13 INFO - 2015-11-24 03:00:13,571 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,571 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29614.57 Median:445.81 stddev:102177.87 (22919.6%) stddev-sans-first:102440.86 03:00:13 INFO - 2015-11-24 03:00:13,573 DEBUG : BROWSER_OUTPUT: Values: 341.4 342.6 343.6 344.2 347.5 13818.5 14169.4 17022.4 17067.5 17625.5 14855.5 16082.8 18006.4 18587.0 18753.6 5267.7 5378.0 5395.1 5401.9 5435.6 4043.7 4184.4 4561.3 6045.5 6053.2 5748.6 5888.1 5931.2 5946.3 5958.0 4421.4 4525.6 4541.9 5889.8 5932.8 3879.7 3886.2 3889.0 3891.0 3902.6 12201.2 12576.7 12622.8 12677.8 12685.3 1800.3 1870.6 1872.9 1989.9 2035.7 9115.5 9205.3 9454.7 9479.2 9625.8 1474.1 1504.0 1533.8 1550.7 1583.2 55544.0 55776.0 56022.0 57702.4 58422.4 6369.3 6508.9 6509.5 6546.2 6563.8 7521.8 7535.7 7540.5 7551.4 7632.6 5298.8 5314.7 5332.7 5338.8 5340.7 5547.3 5570.3 5596.2 5604.3 5644.4 2895.8 2948.2 2973.1 2974.6 2975.7 1015.3 1039.0 1043.7 1052.9 1088.6 414.3 417.6 433.7 443.5 446.6 10581.6 11228.2 11633.1 11866.3 11970.2 454.2 460.6 461.6 466.6 478.4 6093.4 6217.5 6287.0 6300.4 6334.5 609244.0 620849.0 623688.9 637141.0 638289.0 61213.0 62418.4 62588.7 63237.0 70589.6 445.0 453.5 455.9 456.4 457.8 9871.0 9917.5 10012.3 10144.8 10429.9 33529.5 33806.5 34208.5 34495.8 35259.5 46699.8 46909.8 47180.5 49227.3 49327.8 14339.3 14705.2 15175.8 15225.9 15354.2 18162.2 18199.2 18407.5 18895.0 19103.6 14577.4 14619.3 14903.6 15133.9 15220.4 7257.1 8950.0 9132.6 9168.9 14260.4 8963.5 9357.1 9412.6 9428.0 9614.8 13925.7 14243.8 14398.9 14585.1 14687.9 8699.7 14245.6 14460.7 14639.2 14724.8 03:00:13 INFO - 2015-11-24 03:00:13,573 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,573 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5323.02 Median:6426.62 stddev:2746.43 (42.7%) stddev-sans-first:2737.20 03:00:13 INFO - 2015-11-24 03:00:13,574 DEBUG : BROWSER_OUTPUT: Values: 1265.9 1353.3 1536.5 1556.2 1800.6 6943.6 7634.6 7738.1 7743.0 7812.3 7445.7 7589.6 7628.1 7643.1 7658.0 2117.0 2117.0 2132.4 2134.5 2139.6 2196.4 2197.0 2230.2 2234.1 2236.6 2067.3 2081.6 2097.1 2101.6 2125.9 2123.2 2134.4 2135.3 2137.6 2141.9 2134.4 2179.2 2184.3 2186.7 2187.2 6926.1 7115.9 7500.3 7537.8 7543.1 4519.0 4674.1 4679.6 4684.8 4695.5 2636.7 2681.4 2713.8 2732.0 2742.5 793.5 814.3 826.9 830.5 833.1 10115.3 10170.7 10179.6 10181.0 10205.3 4177.9 4178.0 4229.2 4237.3 4240.5 8882.5 8926.8 8935.6 8944.5 8996.7 4681.0 4684.9 4693.5 4699.7 4711.9 4244.4 4273.3 4278.8 4279.6 4303.2 3490.5 3504.4 3508.6 3521.6 3556.0 1113.9 1125.9 1126.6 1142.5 1146.6 1257.5 1260.5 1291.0 1299.1 1302.9 6964.0 7261.2 7316.3 7434.1 7503.0 1096.8 1106.2 1120.2 1120.8 1136.6 5536.5 5743.4 5801.1 5818.8 5826.7 7903.2 8821.2 8957.1 8966.4 8972.0 8874.7 8876.3 8893.5 8914.6 8918.0 7125.2 7164.5 7222.6 7240.7 7247.6 7109.9 7164.7 7175.7 7176.1 7191.8 7667.4 7956.5 8000.9 8051.1 8051.8 7783.1 8342.3 8352.8 8365.7 8366.4 6823.0 6930.5 6941.5 6945.9 6959.0 7406.3 7465.6 7522.6 7524.3 7543.2 6940.7 6996.4 7048.5 7071.3 7079.3 6809.5 6869.2 6880.4 6925.0 6962.1 6895.4 7041.0 7052.6 7073.0 7096.9 6306.6 6325.8 6331.5 6343.6 6348.9 6377.2 6476.0 6497.6 6506.0 6506.2 03:00:13 INFO - 2015-11-24 03:00:13,574 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,574 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5163.04 Median:5832.16 stddev:1540.42 (26.4%) stddev-sans-first:1501.25 03:00:13 INFO - 2015-11-24 03:00:13,576 DEBUG : BROWSER_OUTPUT: Values: 320.3 323.4 324.0 327.7 332.3 5817.4 5822.9 5841.5 5843.2 5873.3 5638.9 5676.9 5733.8 5801.9 5817.8 4532.6 4568.4 4570.0 4601.8 4608.9 4459.4 4571.4 4577.5 4592.2 4618.9 4499.7 4507.0 4542.4 4546.0 4570.6 4498.5 4539.6 4543.6 4549.7 4560.7 3954.5 3958.2 3966.9 3970.4 3971.3 5459.0 5578.2 5593.7 5603.5 5617.1 5036.2 5096.5 5126.7 5128.7 5134.4 6165.1 6165.4 6175.1 6175.1 6224.5 4256.6 4273.1 4274.1 4275.3 4297.3 6253.2 6331.5 6423.9 6448.8 6460.7 4333.7 4351.3 4352.1 4357.8 4362.5 4429.4 4442.7 4458.0 4464.9 4465.0 5084.6 5094.3 5099.6 5106.8 5140.2 5971.2 6130.5 6143.5 6161.9 6201.4 1556.2 1602.7 1605.2 1606.2 1612.9 1052.8 1059.0 1072.3 1077.2 1080.8 5895.2 5898.6 5913.3 5927.1 5943.5 6374.4 6385.4 6387.0 6410.8 6416.1 5752.9 5765.3 5783.1 5819.4 5841.5 3513.4 3513.8 3518.2 3522.7 3528.4 6401.1 6401.9 6420.4 6508.8 6532.8 6444.5 6547.4 6550.6 6554.3 6569.8 6394.3 6461.3 6470.1 6476.7 6533.0 6377.8 6382.8 6395.9 6408.1 6422.5 6182.8 6288.6 6292.5 6348.1 6373.8 6461.6 6466.0 6472.8 6473.6 6484.3 4069.0 4070.2 4087.1 4092.7 4097.9 6191.9 6335.7 6337.9 6341.0 6389.5 6222.2 6234.4 6240.5 6247.3 6273.9 6220.5 6232.7 6235.1 6242.9 6244.4 5948.7 6106.8 6107.7 6110.0 6116.5 6214.6 6232.5 6283.9 6289.8 6292.1 6080.9 6097.7 6127.9 6145.9 6151.3 03:00:13 INFO - 2015-11-24 03:00:13,576 DEBUG : BROWSER_OUTPUT: 03:00:13 INFO - 2015-11-24 03:00:13,576 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13365.16 Median:48969.26 stddev:15871.73 (32.4%) stddev-sans-first:15887.63 03:00:13 INFO - 2015-11-24 03:00:13,576 DEBUG : BROWSER_OUTPUT: Values: 671.3 739.4 741.1 744.6 745.7 13173.0 13528.7 13538.6 13559.0 13562.1 12101.8 12143.9 12252.4 13623.1 13770.4 699.7 857.8 858.6 859.8 862.2 701.7 833.9 849.6 853.9 856.7 880.5 880.5 880.6 880.6 883.6 727.4 733.1 881.8 902.3 930.7 652.5 653.6 653.9 666.4 672.0 13541.1 14151.3 14168.6 14206.4 14476.0 10938.3 11428.6 11628.7 11984.5 12451.3 8841.6 8944.5 8982.1 9066.1 9180.2 3217.9 3233.9 3325.9 3329.3 3355.8 48708.8 49229.8 49530.8 49790.3 50089.0 8839.9 9061.6 9161.2 9198.6 9269.0 18963.2 19005.7 19055.6 19075.5 19090.4 6545.2 6792.0 6873.3 7002.2 7056.6 3718.2 3830.0 3871.1 3887.7 3910.4 2904.9 2954.5 2960.8 2963.2 2966.0 433.0 439.0 443.5 447.0 447.2 478.0 498.0 520.3 543.4 564.6 8110.4 8147.8 8318.3 8448.6 8647.8 455.4 468.4 495.7 568.3 610.4 3425.2 3752.9 3780.1 3835.3 3922.9 53289.7 53507.7 54021.0 54364.2 57896.0 46288.8 46578.3 47990.3 50543.2 51261.0 46020.0 46540.8 46617.3 47181.5 47608.5 7817.8 7917.3 8118.4 8307.1 8316.6 34499.7 34645.7 35128.3 35397.5 35620.0 43602.0 45934.5 46817.3 46856.8 47089.8 7431.8 7435.8 7545.0 7621.0 7727.2 10790.1 11133.8 11196.7 11320.4 11739.4 9764.4 10109.4 10169.9 10172.0 10250.4 10214.4 10500.8 10513.2 10526.7 10631.8 10296.5 10354.5 10412.1 10415.9 10419.9 9084.5 9117.7 9488.0 9533.8 9603.5 8803.9 8893.6 9048.2 9050.5 9067.2 03:00:13 INFO - 2015-11-24 03:00:13,576 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:00:13 INFO - 2015-11-24 03:00:13,576 DEBUG : BROWSER_OUTPUT: 03:00:14 INFO - 2015-11-24 03:00:14,201 INFO : Browser exited with error code: 0 03:00:14 INFO - 2015-11-24 03:00:14,228 INFO : Completed test dromaeo_css (00:18:34) 03:00:14 INFO - 2015-11-24 03:00:14,228 INFO : Starting test kraken 03:00:14 INFO - 2015-11-24 03:00:14,228 DEBUG : operating with platform_type : mac_ 03:00:14 INFO - 2015-11-24 03:00:14,229 INFO : Initialising browser for kraken test... 03:00:14 INFO - 2015-11-24 03:00:14,242 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmp6PIXoy/profile http://localhost:49267/getInfo.html 03:00:16 INFO - 2015-11-24 03:00:16,607 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:00:16 INFO - 2015-11-24 03:00:16,608 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:00:16 INFO - 2015-11-24 03:00:16,608 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:00:16 INFO - 2015-11-24 03:00:16,608 DEBUG : BROWSER_OUTPUT: __metrics 03:00:16 INFO - 2015-11-24 03:00:16,624 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:17 INFO - 2015-11-24 03:00:17,316 INFO : Browser initialized. 03:00:17 INFO - 2015-11-24 03:00:17,316 INFO : Running cycle 1/1 for kraken test... 03:00:17 INFO - 2015-11-24 03:00:17,317 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmp6PIXoy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:00:29 INFO - 2015-11-24 03:00:29,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 199172096 03:00:29 INFO - 2015-11-24 03:00:29,219 DEBUG : BROWSER_OUTPUT: 03:00:31 INFO - 2015-11-24 03:00:31,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 03:00:32 INFO - 2015-11-24 03:00:32,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 266551296 03:00:32 INFO - 2015-11-24 03:00:32,401 DEBUG : BROWSER_OUTPUT: 03:00:35 INFO - 2015-11-24 03:00:35,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 03:00:35 INFO - 2015-11-24 03:00:35,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 279019520 03:00:35 INFO - 2015-11-24 03:00:35,633 DEBUG : BROWSER_OUTPUT: 03:00:38 INFO - 2015-11-24 03:00:38,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 03:00:39 INFO - 2015-11-24 03:00:39,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 269672448 03:00:39 INFO - 2015-11-24 03:00:39,121 DEBUG : BROWSER_OUTPUT: 03:00:41 INFO - 2015-11-24 03:00:41,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 03:00:41 INFO - 2015-11-24 03:00:41,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 269893632 03:00:41 INFO - 2015-11-24 03:00:41,793 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-11-24 03:00:44,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:00:44 INFO - 2015-11-24 03:00:44,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 269881344 03:00:44 INFO - 2015-11-24 03:00:44,617 DEBUG : BROWSER_OUTPUT: 03:00:47 INFO - 2015-11-24 03:00:47,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 03:00:48 INFO - 2015-11-24 03:00:48,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 270565376 03:00:48 INFO - 2015-11-24 03:00:48,317 DEBUG : BROWSER_OUTPUT: 03:00:51 INFO - 2015-11-24 03:00:51,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 03:00:52 INFO - 2015-11-24 03:00:52,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 270831616 03:00:52 INFO - 2015-11-24 03:00:52,117 DEBUG : BROWSER_OUTPUT: 03:00:55 INFO - 2015-11-24 03:00:55,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 03:00:55 INFO - 2015-11-24 03:00:55,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 271273984 03:00:55 INFO - 2015-11-24 03:00:55,661 DEBUG : BROWSER_OUTPUT: 03:00:57 INFO - 2015-11-24 03:00:57,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:00:57 INFO - 2015-11-24 03:00:57,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 302006272 03:00:57 INFO - 2015-11-24 03:00:57,840 DEBUG : BROWSER_OUTPUT: 03:00:59 INFO - 2015-11-24 03:00:59,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:00 INFO - 2015-11-24 03:01:00,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 303173632 03:01:00 INFO - 2015-11-24 03:01:00,299 DEBUG : BROWSER_OUTPUT: 03:01:02 INFO - 2015-11-24 03:01:02,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:03 INFO - 2015-11-24 03:01:03,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 309116928 03:01:03 INFO - 2015-11-24 03:01:03,010 DEBUG : BROWSER_OUTPUT: 03:01:05 INFO - 2015-11-24 03:01:05,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:06 INFO - 2015-11-24 03:01:06,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 311443456 03:01:06 INFO - 2015-11-24 03:01:06,239 DEBUG : BROWSER_OUTPUT: 03:01:08 INFO - 2015-11-24 03:01:08,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:09 INFO - 2015-11-24 03:01:09,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 310427648 03:01:09 INFO - 2015-11-24 03:01:09,449 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 03:01:11 INFO - 2015-11-24 03:01:11,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 369545216 03:01:11 INFO - 2015-11-24 03:01:11,435 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,436 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:01:11 INFO - 2015-11-24 03:01:11,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:01:11 INFO - 2015-11-24 03:01:11,437 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:01:11 INFO - 2015-11-24 03:01:11,437 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:01:11 INFO - 2015-11-24 03:01:11,437 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;107;108;111;111;112;111;108;109 03:01:11 INFO - 2015-11-24 03:01:11,437 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;129;164;152;125;147;130;162;155;127 03:01:11 INFO - 2015-11-24 03:01:11,437 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;163;165;171;173;173;167;169;173 03:01:11 INFO - 2015-11-24 03:01:11,438 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;80;78;120;68;71;73;75;123;68 03:01:11 INFO - 2015-11-24 03:01:11,438 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;101;136;90;89;93;138;96;95;141 03:01:11 INFO - 2015-11-24 03:01:11,438 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;120;117;118;123;130;123;124;124;124 03:01:11 INFO - 2015-11-24 03:01:11,438 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;125;129;135;134;134;129;134;134;135 03:01:11 INFO - 2015-11-24 03:01:11,438 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;99;101;103;109;108;109;108;108;109;109 03:01:11 INFO - 2015-11-24 03:01:11,439 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;63;64;64;64;64;64;72;59;61 03:01:11 INFO - 2015-11-24 03:01:11,439 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;65;67;66;67;68;69;69;72 03:01:11 INFO - 2015-11-24 03:01:11,439 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;82;87;86;89;91;91;91;97 03:01:11 INFO - 2015-11-24 03:01:11,439 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;121;126;127;143;135;138;130;128;135 03:01:11 INFO - 2015-11-24 03:01:11,439 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;142;144;154;156;155;154;151;152;156 03:01:11 INFO - 2015-11-24 03:01:11,439 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;67;68;69;69;68;72;73;72 03:01:11 INFO - 2015-11-24 03:01:11,440 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:01:11 INFO - 2015-11-24 03:01:11,440 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:01:11 INFO - 2015-11-24 03:01:11,441 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,898 03:01:11 INFO - 2015-11-24 03:01:11,442 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:01:11 INFO - 2015-11-24 03:01:11,442 DEBUG : BROWSER_OUTPUT: __startTimestamp1448362871436__endTimestamp 03:01:11 INFO - 2015-11-24 03:01:11,442 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,442 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:01:11 INFO - 2015-11-24 03:01:11,442 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:01:11 INFO - 2015-11-24 03:01:11,442 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,443 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.32 03:01:11 INFO - 2015-11-24 03:01:11,443 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 107.0 108.0 111.0 111.0 112.0 111.0 108.0 109.0 03:01:11 INFO - 2015-11-24 03:01:11,443 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,443 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:152.00 stddev:15.10 (9.9%) stddev-sans-first:15.76 03:01:11 INFO - 2015-11-24 03:01:11,443 DEBUG : BROWSER_OUTPUT: Values: 152.0 129.0 164.0 152.0 125.0 147.0 130.0 162.0 155.0 127.0 03:01:11 INFO - 2015-11-24 03:01:11,443 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:167.50 Median:170.00 stddev:5.06 (3.0%) stddev-sans-first:4.79 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 163.0 165.0 171.0 173.0 173.0 167.0 169.0 173.0 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.40 Median:74.00 stddev:20.51 (27.7%) stddev-sans-first:21.66 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 78.0 120.0 68.0 71.0 73.0 75.0 123.0 68.0 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,444 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:89.50 stddev:21.37 (23.9%) stddev-sans-first:22.47 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: Values: 100.0 101.0 136.0 90.0 89.0 93.0 138.0 96.0 95.0 141.0 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:122.40 Median:123.50 stddev:3.69 (3.0%) stddev-sans-first:3.88 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: Values: 121.0 120.0 117.0 118.0 123.0 130.0 123.0 124.0 124.0 124.0 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.30 Median:134.00 stddev:4.22 (3.1%) stddev-sans-first:3.55 03:01:11 INFO - 2015-11-24 03:01:11,445 DEBUG : BROWSER_OUTPUT: Values: 124.0 125.0 129.0 135.0 134.0 134.0 129.0 134.0 134.0 135.0 03:01:11 INFO - 2015-11-24 03:01:11,446 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,446 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:106.30 Median:109.00 stddev:3.80 (3.5%) stddev-sans-first:2.98 03:01:11 INFO - 2015-11-24 03:01:11,446 DEBUG : BROWSER_OUTPUT: Values: 99.0 101.0 103.0 109.0 108.0 109.0 108.0 108.0 109.0 109.0 03:01:11 INFO - 2015-11-24 03:01:11,446 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,446 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:3.80 (5.9%) stddev-sans-first:3.52 03:01:11 INFO - 2015-11-24 03:01:11,446 DEBUG : BROWSER_OUTPUT: Values: 58.0 63.0 64.0 64.0 64.0 64.0 64.0 72.0 59.0 61.0 03:01:11 INFO - 2015-11-24 03:01:11,447 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,447 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:2.07 (3.1%) stddev-sans-first:2.12 03:01:11 INFO - 2015-11-24 03:01:11,447 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 67.0 66.0 67.0 68.0 69.0 69.0 72.0 03:01:11 INFO - 2015-11-24 03:01:11,447 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,447 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:90.00 stddev:4.74 (5.3%) stddev-sans-first:4.50 03:01:11 INFO - 2015-11-24 03:01:11,447 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 82.0 87.0 86.0 89.0 91.0 91.0 91.0 97.0 03:01:11 INFO - 2015-11-24 03:01:11,448 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,448 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:132.50 stddev:7.39 (5.6%) stddev-sans-first:6.84 03:01:11 INFO - 2015-11-24 03:01:11,449 DEBUG : BROWSER_OUTPUT: Values: 120.0 121.0 126.0 127.0 143.0 135.0 138.0 130.0 128.0 135.0 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:154.00 stddev:6.69 (4.3%) stddev-sans-first:5.15 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: Values: 137.0 142.0 144.0 154.0 156.0 155.0 154.0 151.0 152.0 156.0 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:2.01 (2.9%) stddev-sans-first:2.12 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 67.0 68.0 69.0 69.0 68.0 72.0 73.0 72.0 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:01:11 INFO - 2015-11-24 03:01:11,450 DEBUG : BROWSER_OUTPUT: 03:01:12 INFO - 2015-11-24 03:01:12,096 INFO : Browser exited with error code: 0 03:01:12 INFO - 2015-11-24 03:01:12,147 INFO : Completed test kraken (00:00:57) 03:01:12 INFO - 2015-11-24 03:01:12,147 INFO : Starting test v8_7 03:01:12 INFO - 2015-11-24 03:01:12,148 DEBUG : operating with platform_type : mac_ 03:01:12 INFO - 2015-11-24 03:01:12,148 INFO : Initialising browser for v8_7 test... 03:01:12 INFO - 2015-11-24 03:01:12,161 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmpN9ccxx/profile http://localhost:49267/getInfo.html 03:01:14 INFO - 2015-11-24 03:01:14,376 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:01:14 INFO - 2015-11-24 03:01:14,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:01:14 INFO - 2015-11-24 03:01:14,377 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:01:14 INFO - 2015-11-24 03:01:14,377 DEBUG : BROWSER_OUTPUT: __metrics 03:01:14 INFO - 2015-11-24 03:01:14,396 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:15 INFO - 2015-11-24 03:01:15,104 INFO : Browser initialized. 03:01:15 INFO - 2015-11-24 03:01:15,105 INFO : Running cycle 1/1 for v8_7 test... 03:01:15 INFO - 2015-11-24 03:01:15,105 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmpN9ccxx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:01:27 INFO - 2015-11-24 03:01:27,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 199614464 03:01:27 INFO - 2015-11-24 03:01:27,008 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 03:01:48 INFO - 2015-11-24 03:01:48,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 537677824 03:01:48 INFO - 2015-11-24 03:01:48,689 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,689 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:01:48 INFO - 2015-11-24 03:01:48,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:01:48 INFO - 2015-11-24 03:01:48,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:01:48 INFO - 2015-11-24 03:01:48,691 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:01:48 INFO - 2015-11-24 03:01:48,692 DEBUG : BROWSER_OUTPUT: |0;Richards;166.00265604249668 03:01:48 INFO - 2015-11-24 03:01:48,692 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.8761213972132 03:01:48 INFO - 2015-11-24 03:01:48,692 DEBUG : BROWSER_OUTPUT: |2;Encrypt;333.4444814938313 03:01:48 INFO - 2015-11-24 03:01:48,692 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6211.180124223602 03:01:48 INFO - 2015-11-24 03:01:48,692 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1053.740779768177 03:01:48 INFO - 2015-11-24 03:01:48,692 DEBUG : BROWSER_OUTPUT: |5;Earley;728.3321194464676 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: |6;Boyer;12858.97435897436 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: |7;RegExp;30575.757575757576 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: |8;Splay;620.7324643078833 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5923.076923076923 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1448362908689__endTimestamp 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: Values: 166.0 03:01:48 INFO - 2015-11-24 03:01:48,693 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: Values: 190.9 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:333.44 Median:333.44 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: Values: 333.4 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6211.18 Median:6211.18 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: Values: 6211.2 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,694 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: Values: 1053.7 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:728.33 Median:728.33 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: Values: 728.3 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12858.97 Median:12858.97 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: Values: 12859.0 03:01:48 INFO - 2015-11-24 03:01:48,695 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30575.76 Median:30575.76 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: Values: 30575.8 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.73 Median:620.73 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: Values: 620.7 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5923.08 Median:5923.08 stddev:0.00 (0.0%) 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: Values: 5923.1 03:01:48 INFO - 2015-11-24 03:01:48,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:01:48 INFO - 2015-11-24 03:01:48,697 DEBUG : BROWSER_OUTPUT: 03:01:49 INFO - 2015-11-24 03:01:49,333 INFO : Browser exited with error code: 0 03:01:49 INFO - 2015-11-24 03:01:49,355 INFO : Completed test v8_7 (00:00:37) 03:01:49 INFO - 2015-11-24 03:01:49,817 INFO : Completed test suite (00:20:10) 03:01:49 INFO - 2015-11-24 03:01:49,817 DEBUG : Working with test: dromaeo_css 03:01:49 INFO - 2015-11-24 03:01:49,817 DEBUG : Generating results file: dromaeo_css 03:01:49 INFO - 2015-11-24 03:01:49,818 DEBUG : Working with test: kraken 03:01:49 INFO - 2015-11-24 03:01:49,818 DEBUG : Generating results file: kraken 03:01:49 INFO - 2015-11-24 03:01:49,818 INFO : javascript benchmark 03:01:49 INFO - 2015-11-24 03:01:49,818 DEBUG : Working with test: v8_7 03:01:49 INFO - 2015-11-24 03:01:49,818 DEBUG : Generating results file: v8_7 03:01:49 INFO - 2015-11-24 03:01:49,819 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:01:49 INFO - 2015-11-24 03:01:49,874 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:01:49 INFO - 2015-11-24 03:01:49,874 DEBUG : process_Request line: dromaeo_css 6563.13 graph.html#tests=[[72,52,55]] 03:01:49 INFO - 2015-11-24 03:01:49,874 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:01:49 INFO - 2015-11-24 03:01:49,903 DEBUG : process_Request line: kraken 1541.20 graph.html#tests=[[232,52,55]] 03:01:49 INFO - 2015-11-24 03:01:49,903 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:01:49 INFO - 2015-11-24 03:01:49,931 DEBUG : process_Request line: v8_7 19659.45 graph.html#tests=[[230,52,55]] 03:01:49 INFO - 2015-11-24 03:01:49,932 INFO : javascript benchmark 03:01:49 INFO - 2015-11-24 03:01:49,933 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [341.3803945838305, 342.6248258157317, 343.6288808087266, 344.21347221598654, 347.53430403259625, 13818.516351927685, 14169.362378692958, 17022.404215852446, 17067.487975360742, 17625.471235862944, 14855.480058197965, 16082.758758618631, 18006.369777057807, 18587.0, 18753.62492750144, 5267.683938963655, 5378.031954248234, 5395.0558652235895, 5401.945980540203, 5435.565154787608, 4043.65628921542, 4184.351425529033, 4561.270196768518, 6045.546584006195, 6053.1828203192445, 5748.626339287933, 5888.146218798272, 5931.228940237763, 5946.316173640022, 5958.0, 4421.425214722098, 4525.615322697575, 4541.931871021938, 5889.7644094236175, 5932.792352267671, 3879.670228030621, 3886.203328317688, 3888.9611103889165, 3891.007793012792, 3902.6487616114687, 12201.20692155007, 12576.748465030649, 12622.81065784014, 12677.809832852423, 12685.302308373035, 1800.3158799656178, 1870.644577530265, 1872.9250829966784, 1989.8607097503182, 2035.6742921132548, 9115.5442227889, 9205.309601779827, 9454.716358509255, 9479.194268487186, 9625.807483850354, 1474.0934325389808, 1504.0, 1533.8159420869456, 1550.7286224910595, 1583.1688363609082, 55544.0, 55776.0, 56022.0, 57702.42297577055, 58422.41577584212, 6369.299377068519, 6508.934910650928, 6509.511786616023, 6546.24718157418, 6563.8359041023405, 7521.811954701177, 7535.660895259726, 7540.472166948261, 7551.433642476836, 7632.618369081523, 5298.841034768963, 5314.73426328682, 5332.68003919766, 5338.839834804962, 5340.652857564246, 5547.278853749068, 5570.275864137636, 5596.160575913564, 5604.32748070226, 5644.379118296984, 2895.7972941893863, 2948.174511136885, 2973.093206571973, 2974.5538169274782, 2975.6577993530586, 1015.2994433840627, 1038.9636362727267, 1043.7025447747355, 1052.852390893914, 1088.6189833558192, 414.2646801926544, 417.58855069863665, 433.6899117131266, 443.5143517847951, 446.62706639955354, 10581.57673693059, 11228.214025018333, 11633.127515436207, 11866.288022718665, 11970.162088653711, 454.19380599436266, 460.63609748298467, 461.61916418954496, 466.62203615071223, 478.38288607696376, 6093.360197179321, 6217.533684973645, 6286.968565157145, 6300.432961033529, 6334.524910631629, 609244.0, 620849.0, 623688.8815555893, 637141.0, 638289.0, 61213.0, 62418.375816242165, 62588.68705656443, 63237.0, 70589.64705176442, 444.9911001779946, 453.4898239480584, 455.90198107407065, 456.4408599465628, 457.77568991194073, 9871.0, 9917.504124793588, 10012.299139060196, 10144.797104058025, 10429.895701042893, 33529.49705754367, 33806.49290260599, 34208.486872697424, 34495.827520862236, 35259.47110793289, 46699.76650116728, 46909.76545117253, 47180.52819471761, 49227.26159107545, 49327.753361232964, 14339.283035848375, 14705.191214482878, 15175.772363414337, 15225.923870380577, 15354.232288385312, 18162.182701778187, 18199.181036853108, 18407.53981150482, 18895.0, 19103.617927641648, 14577.416903323749, 14619.342129603981, 14903.62740931442, 15133.924330378277, 15220.391184352502, 7257.129144502694, 8949.955250223707, 9132.589033493641, 9168.862467063132, 14260.358283877458, 8963.507007114671, 9357.06429357059, 9412.576434060347, 9427.952860235655, 9614.759631009001, 13925.72148557003, 14243.786343205067, 14398.856011439751, 14585.051971621811, 14687.943687883491, 8699.69551065735, 14245.64385890361, 14460.710785784437, 14639.194844283667, 14724.77912831287], "dojo.html": [3065.0, 3074.0931425229555, 3156.779025468218, 3189.2186414328485, 3220.1627576830024, 5012.951622321708, 5068.898622027562, 5078.238264260358, 5091.083604951107, 5095.312132862072, 5094.363204599425, 5107.846764597068, 5126.345181195778, 5126.897462050766, 5144.485551444854, 4725.3384526166365, 4762.499937506564, 4804.83183088592, 4833.178359678863, 4879.609631229511, 4694.483606803249, 4774.952250477503, 4860.1494738420815, 4870.293807397925, 4878.853634390974, 4871.853844384656, 4975.12935236334, 4976.552110310071, 4977.576905962997, 5003.724795136266, 4899.265110233458, 4932.112219800434, 4936.90126197474, 4958.231474121517, 4961.950380496185, 4607.493175750665, 4653.58117769399, 4721.905561888743, 4756.762161891892, 4772.451168115676, 5077.695338279715, 5115.5396014358885, 5120.743962801882, 5158.12311906973, 5247.86880327991, 5110.565601923841, 5537.778488860441, 5539.335279766414, 5543.722813859331, 5543.833684989457, 5438.809641662562, 5505.504504594605, 5516.696581688006, 5523.972380138114, 5539.501444869981, 5177.689338639619, 5191.714455704935, 5215.765290561896, 5231.921521177185, 5239.0, 5428.782848686008, 5638.379778224392, 5772.191893134965, 5774.566907481955, 5831.183634291203, 5339.092354299778, 5366.6779993200535, 5367.651102678392, 5453.863653408617, 5491.2312276281355, 5562.02664533705, 5583.246261754693, 5603.355614104348, 5610.242617246619, 5644.153376993484, 5253.317068781034, 5498.560115190775, 5508.256385388001, 5519.779208831602, 5556.638818476786, 5291.682499050069, 5398.46015398457, 5412.891742165135, 5441.102218133963, 5467.398586155519, 4217.493900731871, 4241.830326786956, 4261.659067274611, 4264.87205383839, 4280.165367753259, 3749.9625003750157, 3858.1897801462005, 3865.091703449687, 3877.1470276539117, 3882.0488980199466, 5043.067032598908, 5179.61152913533, 5181.4041385240425, 5185.066687996197, 5211.5049070338255, 5531.363893152258, 5553.4724201200825, 5558.027345214571, 5565.610407271533, 5575.498205161473, 4955.702657840541, 5172.379314482287, 5186.429492755794, 5199.870003249874, 5224.791008359623, 4635.258358662665, 4721.881952951204, 4745.098431298112, 4754.23932170851, 4778.665493415497, 5580.358258800209, 5671.801486947937, 5679.744411501575, 5706.144078388275, 5733.942660573508, 5326.0, 5612.635178713534, 5642.153676948491, 5654.434556544313, 5683.261176047087, 5499.037668407933, 5519.034169020486, 5535.474129957647, 5622.662640241599, 5628.634138780966, 5510.063289240758, 5556.0, 5574.052411090205, 5580.888382232414, 5616.438356164351, 5161.380634323755, 5606.467385598362, 5613.46672066153, 5631.183478395692, 5633.492985631313, 5274.261603375608, 5277.472252774692, 5279.076161671769, 5344.919826202688, 5390.946090539044, 5404.162354835007, 5431.592630552804, 5455.399906010415, 5460.31746031746, 5478.753456094406, 5135.563477104339, 5374.516293533445, 5389.7035663038905, 5390.62265641417, 5395.2176934343515, 5322.148456246982, 5411.134218525017, 5413.350397952271, 5434.049041417815, 5455.427180146186, 5260.579153667774, 5276.973615131899, 5311.601629877698, 5311.814086506954, 5358.0], "mootools.html": [1265.886070253677, 1353.3368649361812, 1536.492957324083, 1556.2218890554723, 1800.6488734696738, 6943.583384996904, 7634.58009809461, 7738.148803631596, 7743.0, 7812.296893279604, 7445.702171913117, 7589.582572958485, 7628.084629844427, 7643.082830060401, 7657.961710191441, 2116.968245476319, 2117.0473287020827, 2132.360291912428, 2134.4770531219797, 2139.6255655260343, 2196.439907823503, 2196.967045494319, 2230.174835310929, 2234.0728597631964, 2236.6197746383073, 2067.3384516954507, 2081.646120159569, 2097.056324653904, 2101.5901899129676, 2125.9255926042592, 2123.214410668055, 2134.423705599487, 2135.3273718778537, 2137.593857167133, 2141.892905354734, 2134.413036414983, 2179.24815938501, 2184.3337781976493, 2186.7375914890313, 2187.201671389947, 6926.099607051102, 7115.89326160108, 7500.287472690085, 7537.849243015164, 7543.057117860268, 4518.977405112986, 4674.135284972291, 4679.578837904571, 4684.8360307389075, 4695.5069717679835, 2636.6967798703204, 2681.3564744461382, 2713.8236014658983, 2732.0301293040884, 2742.4515096980685, 793.4683761879554, 814.3200427642926, 826.8718348655968, 830.4560512864084, 833.0919297965247, 10115.291929564934, 10170.745731356701, 10179.643712470028, 10181.0, 10205.336653117523, 4177.937330940038, 4177.97911010443, 4229.175310814423, 4237.343211802176, 4240.49114106303, 8882.51146186953, 8926.776830579287, 8935.597898094602, 8944.5080520572, 8996.685116020908, 4680.95319046812, 4684.859454216379, 4693.460252070987, 4699.671023028423, 4711.882202944954, 4244.405783190356, 4273.316269396882, 4278.828846846091, 4279.593438623326, 4303.2469317869245, 3490.458978858281, 3504.404251277289, 3508.5789705235534, 3521.6478352164577, 3556.0398692353438, 1113.9417553324374, 1125.943702814856, 1126.6113190949109, 1142.5087212498538, 1146.644540192543, 1257.4655771297346, 1260.5084017233287, 1290.9870901291056, 1299.0841456772953, 1302.947882084725, 6964.0, 7261.237570055068, 7316.268373162641, 7434.070741157356, 7503.0, 1096.8245080787035, 1106.242224076494, 1120.2158489057692, 1120.8094623913955, 1136.6249137784512, 5536.474034966672, 5743.4256574342235, 5801.071828507503, 5818.8254352369495, 5826.650400975955, 7903.170167132484, 8821.161989610977, 8957.059508751487, 8966.417182883091, 8972.0, 8874.689385871592, 8876.289896808239, 8893.4663920165, 8914.55427228636, 8917.955410223038, 7125.216226215112, 7164.498485105993, 7222.602756848319, 7240.674169662378, 7247.565146091251, 7109.928900711134, 7164.749233776793, 7175.748848790267, 7176.067111275501, 7191.7842464726145, 7667.386609071149, 7956.482828616122, 8000.879986800319, 8051.114377418597, 8051.798705032421, 7783.066032076187, 8342.332613391036, 8352.791180220544, 8365.707200248205, 8366.372522060748, 6823.0, 6930.549514281555, 6941.548799328028, 6945.895811562932, 6959.0, 7406.333429991111, 7465.552066876005, 7522.623868806429, 7524.322810947041, 7543.245675432413, 6940.722371105099, 6996.370326670624, 7048.506604537633, 7071.328223818729, 7079.2566780487305, 6809.455243580403, 6869.175698916162, 6880.415164711056, 6924.965375173092, 6962.1297337832775, 6895.448364130958, 7041.049458323266, 7052.647367631701, 7073.045138906387, 7096.929030709627, 6306.558540902093, 6325.841853953504, 6331.493480521455, 6343.55595108338, 6348.873022539431, 6377.202849643794, 6476.028595710681, 6497.610143391223, 6506.02409638558, 6506.154199953976], "ext.html": [540.4595404595404, 544.0207626272709, 547.7179252684869, 548.659830904839, 561.9831405057845, 31501.212469688267, 32385.51421728676, 38553.228935421306, 38704.0, 38929.22141557167, 41142.177156456855, 41177.0, 41602.0, 41611.37582936259, 41621.16757664845, 8175.836483270331, 8874.733757987271, 8985.820283594325, 8988.011318754965, 9026.097390260955, 8330.166983301682, 10663.78672426551, 10708.089812365919, 10818.945905270502, 10905.509252083675, 10361.326513776618, 10603.416812075333, 10628.521716522775, 10667.679969600924, 10677.145828333754, 8348.958255208745, 8560.743177704679, 10493.160547156209, 10542.525586348633, 10625.043746062853, 10373.11828494579, 10406.843897341547, 10541.736456588647, 10547.103496202832, 10560.102391296672, 38018.80990595057, 38345.61654383476, 38365.61634383648, 38450.0, 38496.80751596252, 2846.9430611387866, 2916.1251624512774, 2952.9557056644167, 2971.8514074296413, 3392.1689186149306, 25847.0, 26060.8696956514, 26624.20127396181, 26777.330566735793, 27847.30381740473, 2264.569731750962, 2279.806216471602, 2287.0508738873345, 2292.071710957065, 2299.9540009199723, 275141.0, 276092.0, 276103.0, 277005.0, 281017.0, 53068.0, 54314.185287220724, 56295.43704562984, 56478.0, 57472.71263643655, 52311.73844130755, 52547.474525254256, 52633.0, 52669.0, 52896.0, 16576.585585360463, 16647.66704665924, 16656.50030499087, 16672.083035432926, 16693.165341733107, 12602.81095783564, 12871.871281287067, 12876.291803950686, 12901.870981290254, 12966.22202667824, 18061.638767224846, 18153.636927261647, 18276.26894924215, 18287.817121828877, 18288.177032033323, 7307.123145222501, 7511.474196806171, 7522.172561018284, 7554.2823431773895, 7585.62071896403, 899.9325050621229, 917.6191880369572, 990.0, 1033.2973577966904, 1059.95230214639, 26948.191554253404, 28024.43951120966, 28135.155945321672, 28205.858970705016, 28331.460814420563, 985.3201291109111, 1024.6516184497307, 1056.804491169136, 1058.99470502647, 1099.120703437263, 13335.599932002055, 14354.641133971525, 14378.85621143796, 14583.0, 14613.634659133395, 310240.0, 315482.0, 315634.0, 316912.0, 318646.0, 53770.0, 54217.72891135598, 54222.186667200025, 54263.18605220925, 54950.0, 1338.7924871644911, 1363.175278956237, 1367.4325155060737, 1369.0553518072497, 1379.344811214665, 26639.0, 27050.0, 27416.451670966868, 27424.0, 27909.16272511828, 46491.76754116208, 46884.7655761719, 47021.0, 47069.0, 47122.0, 273365.0, 279031.0, 282635.0, 381338.0, 392736.0, 26829.731702683504, 26923.92304307806, 26989.59515607307, 27469.31326716768, 27717.722822771513, 36251.81874090613, 39049.414258785575, 39626.60373396229, 39674.80162599284, 40270.39594406028, 30814.845925770227, 31119.0, 32956.67043329632, 33985.490217646264, 34369.14077148091, 33036.66963330336, 33101.66898330986, 33563.32873342568, 34457.138571535914, 35106.47340289847, 34192.658073419945, 34712.652873471954, 34901.8254908734, 34929.0, 35041.474377883846, 26653.7334626659, 29933.401331973673, 30131.0, 30359.0, 31320.530192047594, 22889.427764306027, 23159.536809264057, 23459.88270058639, 23505.41236469102, 23733.0], "prototype.html": [320.2937522762309, 323.44529132537707, 323.97084262416377, 327.74927180706754, 332.26900818199965, 5817.360090390064, 5822.854428639286, 5841.474267315941, 5843.152742852284, 5873.324567674718, 5638.915416268759, 5676.858078548038, 5733.770649174028, 5801.883962320751, 5817.767289308433, 4532.592066713995, 4568.360429539867, 4570.040291538781, 4601.838935637254, 4608.930866037021, 4459.375687403766, 4571.3600095986585, 4577.450705915295, 4592.173408786417, 4618.884527886796, 4499.662525310615, 4506.954930450703, 4542.386777785006, 4546.022605139894, 4570.565796249351, 4498.460184777815, 4539.615417297723, 4543.591076803087, 4549.749763762991, 4560.703554268962, 3954.4859168307935, 3958.2281455116263, 3966.9008274793073, 3970.3647416413523, 3971.344728119857, 5458.972705136449, 5578.163275508666, 5593.692346920918, 5603.523700485463, 5617.129344951539, 5036.244563315532, 5096.490350964911, 5126.6923984561045, 5128.666636668642, 5134.383873935114, 6165.10605962133, 6165.383461653843, 6175.104609831549, 6175.135481032659, 6224.470919971808, 4256.616904478612, 4273.059926816096, 4274.081072569413, 4275.251830929575, 4297.269464191064, 6253.218347706536, 6331.493480521547, 6423.87152256957, 6448.774292899726, 6460.676966151674, 4333.696641235147, 4351.26028575143, 4352.064306174125, 4357.825686972549, 4362.476502819619, 4429.379886815848, 4442.711223770445, 4458.0, 4464.9107017860115, 4464.955350446519, 5084.644074914794, 5094.337736094284, 5099.59203263738, 5106.846794596168, 5140.228965655182, 5971.223740913741, 6130.540209484307, 6143.477804386588, 6161.876762464725, 6201.379862013853, 1556.2452210678039, 1602.6874759422035, 1605.229489844881, 1606.229010075147, 1612.9354825806836, 1052.7999680060764, 1058.9523471443804, 1072.254782925859, 1077.186724023373, 1080.7568297133082, 5895.204147440127, 5898.64608123514, 5913.319968203712, 5927.051671732588, 5943.494802941798, 6374.362563743589, 6385.425311721968, 6387.0, 6410.839729006812, 6416.133821934072, 5752.856178595485, 5765.279340082489, 5783.103618939072, 5819.447152520504, 5841.532677385799, 3513.3675938331344, 3513.7540372174212, 3518.225990282134, 3522.735794815399, 3528.4178110611974, 6401.135846660734, 6401.9039714404325, 6420.422162005349, 6508.772192973223, 6532.771353002622, 6444.452221561126, 6547.410733034049, 6550.639714815731, 6554.279029306773, 6569.80290591283, 6394.296627370985, 6461.321561236003, 6470.061841033118, 6476.676166191766, 6533.0, 6377.840553986002, 6382.808515744535, 6395.936040639534, 6408.14163892466, 6422.454091402096, 6182.752689892533, 6288.591241569284, 6292.465140463112, 6348.143000695032, 6373.808785736435, 6461.57999730016, 6465.967670161619, 6472.805815825533, 6473.643949582818, 6484.254310754323, 4069.003094241811, 4070.1859628075094, 4087.1417002428634, 4092.672586193157, 4097.8770636880945, 6191.876162476815, 6335.746570137143, 6337.936620633919, 6340.968295158495, 6389.520785941166, 6222.222222222223, 6234.407731265523, 6240.469560087444, 6247.250329960252, 6273.874522509615, 6220.502359811114, 6232.688365581794, 6235.127082208585, 6242.937570624235, 6244.406781355764, 5948.702564871825, 6106.816795496142, 6107.6640784757265, 6110.0, 6116.5412594056515, 6214.564980451325, 6232.470240029648, 6283.905741413974, 6289.842753931189, 6292.119103325446, 6080.8783824324155, 6097.695115244132, 6127.877442451037, 6145.877082458236, 6151.2618485781995], "yui.html": [671.278375746073, 739.3789217057671, 741.066256516789, 744.6202436757254, 745.6905384265526, 13173.0, 13528.661783455405, 13538.593842184726, 13559.0, 13562.05065645404, 12101.818472722916, 12143.878561214386, 12252.387380630955, 13623.114497557652, 13770.380332885019, 699.7131176217752, 857.8327226190895, 858.5921687198593, 859.7678626770768, 862.1981557151846, 701.6667083135495, 833.8832563441123, 849.6346570974479, 853.8975322961253, 856.6958729650946, 880.5113162194979, 880.5289170293894, 880.5553195636195, 880.6433394475248, 883.6244596046687, 727.3599232675239, 733.1239169192817, 881.801594641207, 902.2917010147036, 930.7207837648679, 652.4682383857189, 653.598037207119, 653.8692261547709, 666.4435196610835, 671.9899201511981, 13541.05212635116, 14151.29243537819, 14168.645783855383, 14206.431742730278, 14476.0, 10938.343699378063, 11428.599999000078, 11628.709282267926, 11984.460699268553, 12451.315177665316, 8841.602127904196, 8944.508052057134, 8982.10178982103, 9066.138716821892, 9180.17378435944, 3217.9195520112185, 3233.854476548561, 3325.8503367348526, 3329.28420389615, 3355.781874178195, 48708.756456217845, 49229.75385123052, 49530.7523462384, 49790.253146202835, 50089.0, 8839.911600883908, 9061.637534498677, 9161.175494205554, 9198.586063627154, 9268.953655231815, 18963.241470341032, 19005.714914276297, 19055.61888762217, 19075.523111922314, 19090.427287181406, 6545.181852268466, 6792.0, 6873.278305777922, 7002.229754726976, 7056.6118863463, 3718.200586873835, 3829.9617003830163, 3871.090293780959, 3887.7278590498395, 3910.3743401055694, 2904.9273768155545, 2954.4681957247903, 2960.83715395651, 2963.185124090849, 2966.006387860091, 432.9675274354436, 439.04069607906825, 443.45898004434537, 446.9910601788011, 447.2151374338016, 477.9808807647655, 497.9775910084055, 520.3339725151811, 543.3642638113416, 564.610418811019, 8110.391720620977, 8147.79630509242, 8318.334533237326, 8448.619812108469, 8647.827043459096, 455.4193403410612, 468.4308565093428, 495.6530826536347, 568.3464016381195, 610.386561505684, 3425.246445781924, 3752.9061773455337, 3780.0738818989525, 3835.2521258354354, 3922.8626998054933, 53289.73355133199, 53507.732461337444, 54021.0, 54364.18453723197, 57896.0, 46288.768556157, 46578.30132548015, 47990.28014579784, 50543.24185137226, 51261.0, 46020.0, 46540.7672961633, 46617.30074048892, 47181.5281847184, 47608.5239147611, 7817.765467035998, 7917.327027202752, 8118.431709780259, 8307.127751585997, 8316.62575184106, 34499.65500345065, 34645.65354346424, 35128.29743405169, 35397.46903796497, 35620.0, 43602.0, 45934.54065459436, 46817.297740533235, 46856.7657161712, 47089.764551177024, 7431.777046688608, 7435.814104647211, 7545.0, 7621.009268795021, 7727.227277272228, 10790.1367890567, 11133.777324453627, 11196.66410007701, 11320.37737924422, 11739.413029348327, 9764.414135151914, 10109.39343639384, 10169.89830101719, 10172.033656802592, 10250.38497690141, 10214.438205898747, 10500.842487362543, 10513.158947284352, 10526.736831579272, 10631.840522392326, 10296.485175741333, 10354.482275886025, 10412.114970227312, 10415.895841041493, 10419.947900260753, 9084.500352480676, 9117.680881169128, 9487.952560237154, 9533.761655958378, 9603.519824008912, 8803.911960880308, 8893.644254230017, 9048.230900373543, 9050.547472626211, 9067.183953443959]}, "summary": {"suite": 6563.133001793368, "subtests": {"jquery.html": {"filtered": 7222.156286747145, "value": 7222.156286747145}, "dojo.html": {"filtered": 5113.229369731821, "value": 5113.229369731821}, "mootools.html": {"filtered": 4359.098518364817, "value": 4359.098518364817}, "ext.html": {"filtered": 17976.794681071227, "value": 17976.794681071227}, "prototype.html": {"filtered": 4663.371624033856, "value": 4663.371624033856}, "yui.html": {"filtered": 5921.855750509951, "value": 5921.855750509951}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0044"}, "testrun": {"date": 1448361699, "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": "20151124004047", "branch": "Mozilla-Aurora", "revision": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 163.0, 165.0, 171.0, 173.0, 173.0, 167.0, 169.0, 173.0], "ai-astar": [111.0, 105.0, 107.0, 108.0, 111.0, 111.0, 112.0, 111.0, 108.0, 109.0], "imaging-gaussian-blur": [121.0, 120.0, 117.0, 118.0, 123.0, 130.0, 123.0, 124.0, 124.0, 124.0], "audio-beat-detection": [152.0, 129.0, 164.0, 152.0, 125.0, 147.0, 130.0, 162.0, 155.0, 127.0], "json-stringify-tinderbox": [66.0, 66.0, 65.0, 67.0, 66.0, 67.0, 68.0, 69.0, 69.0, 72.0], "stanford-crypto-pbkdf2": [137.0, 142.0, 144.0, 154.0, 156.0, 155.0, 154.0, 151.0, 152.0, 156.0], "json-parse-financial": [58.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 72.0, 59.0, 61.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 67.0, 68.0, 69.0, 69.0, 68.0, 72.0, 73.0, 72.0], "audio-fft": [78.0, 80.0, 78.0, 120.0, 68.0, 71.0, 73.0, 75.0, 123.0, 68.0], "imaging-darkroom": [124.0, 125.0, 129.0, 135.0, 134.0, 134.0, 129.0, 134.0, 134.0, 135.0], "stanford-crypto-ccm": [120.0, 121.0, 126.0, 127.0, 143.0, 135.0, 138.0, 130.0, 128.0, 135.0], "audio-oscillator": [100.0, 101.0, 136.0, 90.0, 89.0, 93.0, 138.0, 96.0, 95.0, 141.0], "stanford-crypto-aes": [82.0, 84.0, 82.0, 87.0, 86.0, 89.0, 91.0, 91.0, 91.0, 97.0], "imaging-desaturate": [99.0, 101.0, 103.0, 109.0, 108.0, 109.0, 108.0, 108.0, 109.0, 109.0]}, "summary": {"suite": 1541.1999999999996, "subtests": {"audio-fft": {"filtered": 83.4, "value": 83.4}, "stanford-crypto-pbkdf2": {"filtered": 150.1, "value": 150.1}, "audio-beat-detection": {"filtered": 144.3, "value": 144.3}, "stanford-crypto-ccm": {"filtered": 130.3, "value": 130.3}, "imaging-darkroom": {"filtered": 131.3, "value": 131.3}, "json-parse-financial": {"filtered": 63.3, "value": 63.3}, "audio-oscillator": {"filtered": 107.9, "value": 107.9}, "ai-astar": {"filtered": 109.3, "value": 109.3}, "audio-dft": {"filtered": 167.5, "value": 167.5}, "stanford-crypto-sha256-iterative": {"filtered": 69.6, "value": 69.6}, "json-stringify-tinderbox": {"filtered": 67.5, "value": 67.5}, "imaging-gaussian-blur": {"filtered": 122.4, "value": 122.4}, "stanford-crypto-aes": {"filtered": 88.0, "value": 88.0}, "imaging-desaturate": {"filtered": 106.3, "value": 106.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0044"}, "testrun": {"date": 1448361699, "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": "20151124004047", "branch": "Mozilla-Aurora", "revision": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.8761213972132], "Encrypt": [333.4444814938313], "NavierStokes": [5923.076923076923], "Decrypt": [6211.180124223602], "Splay": [620.7324643078833], "Richards": [166.00265604249668], "RegExp": [30575.757575757576], "Earley": [728.3321194464676], "Boyer": [12858.97435897436], "RayTrace": [1053.740779768177]}, "summary": {"suite": 19659.44571988389, "subtests": {"DeltaBlue": {"filtered": 346.39220200000005, "value": 346.39220200000005}, "Encrypt": {"filtered": 798.2768190000003, "value": 798.2768190000003}, "NavierStokes": {"filtered": 250.54545454545445, "value": 250.54545454545445}, "Decrypt": {"filtered": 42.855141000000025, "value": 42.855141000000025}, "Splay": {"filtered": 131.28200099999995, "value": 131.28200099999995}, "RegExp": {"filtered": 29.794355797819634, "value": 29.794355797819634}, "Richards": {"filtered": 212.659248, "value": 212.659248}, "Earley": {"filtered": 915.0536989999997, "value": 915.0536989999997}, "Boyer": {"filtered": 51.828628115653075, "value": 51.828628115653075}, "RayTrace": {"filtered": 702.2495610000001, "value": 702.2495610000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0044"}, "testrun": {"date": 1448361699, "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": "20151124004047", "branch": "Mozilla-Aurora", "revision": "f8c58b5949a963d1d38f28b8f5fc17c96af0a7e5"}}] 03:01:49 INFO - RETURN: dromaeo_css: 6563.13 03:01:49 INFO - RETURN: kraken: 1541.20 03:01:49 INFO - RETURN: v8_7: 19659.45 03:01:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "19659.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1541.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6563.13"}}} 03:01:50 INFO - Return code: 0 03:01:50 INFO - # TBPL SUCCESS # 03:01:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:50 INFO - 2015-11-24 03:01:50.055 screenresolution[1669:11437] starting screenresolution argv=screenresolution get 03:01:50 INFO - 2015-11-24 03:01:50.059 screenresolution[1669:11437] Display 0: 1600x1200x32@60 03:01:50 INFO - 2015-11-24 03:01:50.065 screenresolution[1670:11440] starting screenresolution argv=screenresolution list 03:01:50 INFO - Available Modes on Display 0 03:01:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:50 INFO - Intel HD Graphics 3000: 03:01:50 INFO - Chipset Model: Intel HD Graphics 3000 03:01:50 INFO - Type: GPU 03:01:50 INFO - Bus: Built-In 03:01:50 INFO - VRAM (Total): 512 MB 03:01:50 INFO - VRAM (Dynamic, Max): 10 03:01:50 INFO - Vendor: Intel (0x8086) 03:01:50 INFO - Device ID: 0x0116 03:01:50 INFO - Revision ID: 0x0009 03:01:50 INFO - Displays: 03:01:50 INFO - Display: 03:01:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:50 INFO - Display Serial Number: 1600x1200 60 03:01:50 INFO - Main Display: Yes 03:01:50 INFO - Mirror: Off 03:01:50 INFO - Online: Yes 03:01:50 INFO - Rotation: Supported 03:01:50 INFO - Return code: 0 03:01:50 INFO - Running post-action listener: _resource_record_post_action 03:01:50 INFO - Running post-run listener: _resource_record_post_run 03:01:51 INFO - Total resource usage - Wall time: 1249s; CPU: 30.0%; Read bytes: 39666688; Write bytes: 688055296; Read time: 4391; Write time: 69512 03:01:51 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 876544; Write bytes: 344266752; Read time: 192; Write time: 8691 03:01:51 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 37598208; Write bytes: 342584320; Read time: 4035; Write time: 60800 03:01:51 INFO - Running post-run listener: _upload_blobber_files 03:01:51 INFO - Blob upload gear active. 03:01:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:01:51 INFO - Copying logs to upload dir... 03:01:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1313.869431 ========= master_lag: 233.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 46 secs) (at 2015-11-24 03:05:44.512379) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-24 03:05:44.516189) ========= 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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010666 build_url: 'https://queue.taskcluster.net/v1/task/ddD4509FQp2757VYMVD6jg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 1.29 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-24 03:05:45.820642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:05:45.820967) ========= 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.Jgqqdkn7lA/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.P0uQldZntB/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.004889 ========= master_lag: 0.74 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:05:46.564668) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-24 03:05:46.564959) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-24 03:05:49.996309) ========= ========= Total master_lag: 235.59 =========