builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0049 starttime: 1446556169.42 results: success (0) buildid: 20151103031432 builduid: ae524ad82edf490d8f992b69c7e1bcdc revision: c10c657afbe1fb64a9ed2e62a399c52c4038c186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.419491) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.420450) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.420947) ========= 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.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.006198 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.447440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.447992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.465635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.466203) ========= 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.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.005243 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.518004) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.518514) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.519130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.519636) ========= 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.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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-03 05:09:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-03 05:09:29 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.660027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.660338) ========= 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.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.020012 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:29.709484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-03 05:09:29.709843) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c10c657afbe1fb64a9ed2e62a399c52c4038c186 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c10c657afbe1fb64a9ed2e62a399c52c4038c186 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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-03 05:09:29,782 truncating revision to first 12 chars 2015-11-03 05:09:29,783 Setting DEBUG logging. 2015-11-03 05:09:29,783 attempt 1/10 2015-11-03 05:09:29,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c10c657afbe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-03 05:09:30,718 unpacking tar archive at: fx-team-c10c657afbe1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-03 05:09:31.079776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:31.080195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:31.094124) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:31.094499) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 05:09:31.094975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-03 05:09:31.095282) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:09:31 INFO - MultiFileLogger online at 20151103 05:09:31 in /builds/slave/test 05:09:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:09:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:31 INFO - {'append_to_log': False, 05:09:31 INFO - 'base_work_dir': '/builds/slave/test', 05:09:31 INFO - 'blob_upload_branch': 'Fx-Team', 05:09:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:31 INFO - 'branch': 'Fx-Team', 05:09:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:31 INFO - 'config_files': ('talos/mac_config.py',), 05:09:31 INFO - 'default_actions': ('clobber', 05:09:31 INFO - 'read-buildbot-config', 05:09:31 INFO - 'download-and-extract', 05:09:31 INFO - 'populate-webroot', 05:09:31 INFO - 'create-virtualenv', 05:09:31 INFO - 'install', 05:09:31 INFO - 'run-tests'), 05:09:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:31 INFO - 'download_minidump_stackwalk': True, 05:09:31 INFO - 'download_symbols': 'ondemand', 05:09:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:31 INFO - 'installer_path': 'installer.exe', 05:09:31 INFO - 'log_level': 'info', 05:09:31 INFO - 'log_name': 'talos', 05:09:31 INFO - 'log_to_console': True, 05:09:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:09:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:09:31 INFO - 'opt_config_files': (), 05:09:31 INFO - 'pip_index': False, 05:09:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:31 INFO - 'cmd': ('bash', 05:09:31 INFO - '-c', 05:09:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:31 INFO - 'enabled': True, 05:09:31 INFO - 'halt_on_failure': False, 05:09:31 INFO - 'name': 'check_screen_resolution'},), 05:09:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:31 INFO - 'cmd': ('bash', 05:09:31 INFO - '-c', 05:09:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:31 INFO - 'enabled': True, 05:09:31 INFO - 'halt_on_failure': False, 05:09:31 INFO - 'name': 'check_screen_resolution'},), 05:09:31 INFO - 'run_cmd_checks_enabled': True, 05:09:31 INFO - 'sps_profile': False, 05:09:31 INFO - 'sps_profile_interval': 0, 05:09:31 INFO - 'suite': 'dromaeojs', 05:09:31 INFO - 'system_bits': '64', 05:09:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:31 INFO - 'title': 't-yosemite-r5-0049', 05:09:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:31 INFO - 'use_talos_json': True, 05:09:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:31 INFO - 'work_dir': 'build'} 05:09:31 INFO - ##### 05:09:31 INFO - ##### Running clobber step. 05:09:31 INFO - ##### 05:09:31 INFO - Running pre-action listener: _resource_record_pre_action 05:09:31 INFO - Running main action method: clobber 05:09:31 INFO - rmtree: /builds/slave/test/build 05:09:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:33 INFO - Running post-action listener: _resource_record_post_action 05:09:33 INFO - ##### 05:09:33 INFO - ##### Running read-buildbot-config step. 05:09:33 INFO - ##### 05:09:33 INFO - Running pre-action listener: _resource_record_pre_action 05:09:33 INFO - Running main action method: read_buildbot_config 05:09:33 INFO - Using buildbot properties: 05:09:33 INFO - { 05:09:33 INFO - "properties": { 05:09:33 INFO - "buildnumber": 1191, 05:09:33 INFO - "product": "firefox", 05:09:33 INFO - "script_repo_revision": "production", 05:09:33 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 05:09:33 INFO - "repository": "", 05:09:33 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 05:09:33 INFO - "buildid": "20151103031432", 05:09:33 INFO - "slavename": "t-yosemite-r5-0049", 05:09:33 INFO - "pgo_build": "False", 05:09:33 INFO - "basedir": "/builds/slave/test", 05:09:33 INFO - "project": "", 05:09:33 INFO - "platform": "yosemite", 05:09:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:09:33 INFO - "slavebuilddir": "test", 05:09:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:09:33 INFO - "branch": "fx-team", 05:09:33 INFO - "repo_path": "integration/fx-team", 05:09:33 INFO - "stage_platform": "macosx64", 05:09:33 INFO - "builduid": "ae524ad82edf490d8f992b69c7e1bcdc", 05:09:33 INFO - "revision": "c10c657afbe1fb64a9ed2e62a399c52c4038c186" 05:09:33 INFO - }, 05:09:33 INFO - "sourcestamp": { 05:09:33 INFO - "repository": "", 05:09:33 INFO - "hasPatch": false, 05:09:33 INFO - "project": "", 05:09:33 INFO - "branch": "fx-team-macosx64-talos", 05:09:33 INFO - "changes": [ 05:09:33 INFO - { 05:09:33 INFO - "category": null, 05:09:33 INFO - "files": [ 05:09:33 INFO - { 05:09:33 INFO - "url": null, 05:09:33 INFO - "name": "https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:09:33 INFO - } 05:09:33 INFO - ], 05:09:33 INFO - "repository": "", 05:09:33 INFO - "rev": "c10c657afbe1fb64a9ed2e62a399c52c4038c186", 05:09:33 INFO - "who": "cbook@mozilla.com", 05:09:33 INFO - "when": 1446555992, 05:09:33 INFO - "number": 6614803, 05:09:33 INFO - "comments": "Merge mozilla-central to fx-team", 05:09:33 INFO - "project": "", 05:09:33 INFO - "at": "Tue 03 Nov 2015 05:06:32", 05:09:33 INFO - "branch": "fx-team-macosx64-talos", 05:09:33 INFO - "revlink": "", 05:09:33 INFO - "properties": [ 05:09:33 INFO - [ 05:09:33 INFO - "buildid", 05:09:33 INFO - "20151103031432", 05:09:33 INFO - "Change" 05:09:33 INFO - ], 05:09:33 INFO - [ 05:09:33 INFO - "builduid", 05:09:33 INFO - "ae524ad82edf490d8f992b69c7e1bcdc", 05:09:33 INFO - "Change" 05:09:33 INFO - ], 05:09:33 INFO - [ 05:09:33 INFO - "pgo_build", 05:09:33 INFO - "False", 05:09:33 INFO - "Change" 05:09:33 INFO - ] 05:09:33 INFO - ], 05:09:33 INFO - "revision": "c10c657afbe1fb64a9ed2e62a399c52c4038c186" 05:09:33 INFO - } 05:09:33 INFO - ], 05:09:33 INFO - "revision": "c10c657afbe1fb64a9ed2e62a399c52c4038c186" 05:09:33 INFO - } 05:09:33 INFO - } 05:09:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:09:33 INFO - Running post-action listener: _resource_record_post_action 05:09:33 INFO - ##### 05:09:33 INFO - ##### Running download-and-extract step. 05:09:33 INFO - ##### 05:09:33 INFO - Running pre-action listener: _resource_record_pre_action 05:09:33 INFO - Running main action method: download_and_extract 05:09:33 INFO - mkdir: /builds/slave/test/build/tests 05:09:33 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')]} 05:09:33 INFO - https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/test_packages.json 05:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/test_packages.json 05:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:09:34 INFO - Downloaded 1149 bytes. 05:09:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:09:34 INFO - Using the following test package requirements: 05:09:34 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:09:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'jsshell-mac.zip'], 05:09:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:09:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:09:34 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:09:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:09:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:34 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:09:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:09: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')]} 05:09:34 INFO - https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:35 INFO - Downloaded 17452623 bytes. 05:09:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:09:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:09:39 INFO - Return code: 0 05:09:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:09:39 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')]} 05:09:39 INFO - https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:40 INFO - Downloaded 17452623 bytes. 05:09:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:09:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:09:46 INFO - Return code: 0 05:09:46 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')]} 05:09:46 INFO - https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:09:47 INFO - Downloaded 11131307 bytes. 05:09:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:09:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:09:47 INFO - Return code: 0 05:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:47 INFO - https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:09:50 INFO - Downloaded 108634402 bytes. 05:09:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:50 INFO - mkdir: /builds/slave/test/properties 05:09:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:50 INFO - Contents: 05:09:50 INFO - build_url:https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:50 INFO - Running post-action listener: _resource_record_post_action 05:09:50 INFO - Running post-action listener: set_extra_try_arguments 05:09:50 INFO - ##### 05:09:50 INFO - ##### Running populate-webroot step. 05:09:50 INFO - ##### 05:09:50 INFO - Running pre-action listener: _resource_record_pre_action 05:09:50 INFO - Running main action method: populate_webroot 05:09:50 INFO - Guessing talos json url... 05:09:50 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')]} 05:09:50 INFO - https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:09:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:09:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:09:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:09:51 INFO - Downloaded 103 bytes. 05:09:51 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:09:51 INFO - Contents: 05:09:51 INFO - 20151103031432 05:09:51 INFO - https://hg.mozilla.org/integration/fx-team/rev/c10c657afbe1fb64a9ed2e62a399c52c4038c186 05:09:51 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')]} 05:09:51 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/c10c657afb/testing/talos/talos.json 05:09:51 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/c10c657afb/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/c10c657afb/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:09:51 INFO - Downloaded 4264 bytes. 05:09:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:09:51 INFO - '../fennec_ids.txt'], 05:09:51 INFO - 'tests': ['tcheck2']}, 05:09:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:51 INFO - '--tppagecycles', 05:09:51 INFO - '7'], 05:09:51 INFO - 'tests': ['tsvgm']}}, 05:09:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:09:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'tests': ['damp', 'tps']}, 05:09:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['damp', 'tps']}, 05:09:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:09:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:51 INFO - 'other': {'tests': ['a11yr', 05:09:51 INFO - 'ts_paint', 05:09:51 INFO - 'tpaint', 05:09:51 INFO - 'sessionrestore', 05:09:51 INFO - 'sessionrestore_no_auto_restore']}, 05:09:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['a11yr', 05:09:51 INFO - 'ts_paint', 05:09:51 INFO - 'tpaint', 05:09:51 INFO - 'sessionrestore', 05:09:51 INFO - 'sessionrestore_no_auto_restore']}, 05:09:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['a11yr', 05:09:51 INFO - 'ts_paint', 05:09:51 INFO - 'tpaint', 05:09:51 INFO - 'sessionrestore', 05:09:51 INFO - 'sessionrestore_no_auto_restore']}, 05:09:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['a11yr', 05:09:51 INFO - 'ts_paint', 05:09:51 INFO - 'tpaint', 05:09:51 INFO - 'sessionrestore', 05:09:51 INFO - 'sessionrestore_no_auto_restore']}, 05:09:51 INFO - 'other_l64': {'tests': ['a11yr', 05:09:51 INFO - 'ts_paint', 05:09:51 INFO - 'tpaint', 05:09:51 INFO - 'sessionrestore', 05:09:51 INFO - 'sessionrestore_no_auto_restore']}, 05:09:51 INFO - 'other_nol64': {'tests': ['a11yr', 05:09:51 INFO - 'ts_paint', 05:09:51 INFO - 'tpaint', 05:09:51 INFO - 'sessionrestore', 05:09:51 INFO - 'sessionrestore_no_auto_restore']}, 05:09:51 INFO - 'svgr': {'tests': ['tsvgx', 05:09:51 INFO - 'tsvgr_opacity', 05:09:51 INFO - 'tart', 05:09:51 INFO - 'tscrollx', 05:09:51 INFO - 'cart']}, 05:09:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['tsvgx', 05:09:51 INFO - 'tsvgr_opacity', 05:09:51 INFO - 'tart', 05:09:51 INFO - 'tscrollx', 05:09:51 INFO - 'cart']}, 05:09:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'tests': ['tp5o']}, 05:09:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'talos_options': ['--e10s'], 05:09:51 INFO - 'tests': ['tp5o']}, 05:09:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'talos_options': ['--xperf_path', 05:09:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:51 INFO - 'tests': ['tp5n']}, 05:09:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:51 INFO - 'talos_options': ['--e10s', 05:09:51 INFO - '--xperf_path', 05:09:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:09:51 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:09:51 INFO - 'tests': ['tp5n']}}, 05:09:51 INFO - 'talos.zip': {'path': '', 05:09:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:51 INFO - Running post-action listener: _resource_record_post_action 05:09:51 INFO - ##### 05:09:51 INFO - ##### Running create-virtualenv step. 05:09:51 INFO - ##### 05:09:51 INFO - Running pre-action listener: _resource_record_pre_action 05:09:51 INFO - Running main action method: create_virtualenv 05:09:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:51 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 05:09:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:51 INFO - Using real prefix '/tools/python27' 05:09:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:55 INFO - Installing pip.................done. 05:09:55 INFO - Return code: 0 05:09:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:55 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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:09:55 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 05:09:55 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 05:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:55 INFO - 'HOME': '/Users/cltbld', 05:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:55 INFO - 'LOGNAME': 'cltbld', 05:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:55 INFO - 'MOZ_NO_REMOTE': '1', 05:09:55 INFO - 'NO_EM_RESTART': '1', 05:09:55 INFO - 'PAGER': '/bin/cat', 05:09:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:55 INFO - 'PWD': '/builds/slave/test', 05:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:55 INFO - 'SHELL': '/bin/bash', 05:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:09:55 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:55 INFO - 'USER': 'cltbld', 05:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:55 INFO - 'XPC_FLAGS': '0x0', 05:09:55 INFO - 'XPC_SERVICE_NAME': '0', 05:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:56 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 05:09:56 INFO - Cleaning up... 05:09:56 INFO - Return code: 0 05:09:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09:56 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')]} 05:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:56 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')]} 05:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:56 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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:09:56 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 05:09:56 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 05:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:56 INFO - 'HOME': '/Users/cltbld', 05:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:56 INFO - 'LOGNAME': 'cltbld', 05:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:56 INFO - 'MOZ_NO_REMOTE': '1', 05:09:56 INFO - 'NO_EM_RESTART': '1', 05:09:56 INFO - 'PAGER': '/bin/cat', 05:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:56 INFO - 'PWD': '/builds/slave/test', 05:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:56 INFO - 'SHELL': '/bin/bash', 05:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:09:56 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:56 INFO - 'USER': 'cltbld', 05:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:56 INFO - 'XPC_FLAGS': '0x0', 05:09:56 INFO - 'XPC_SERVICE_NAME': '0', 05:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:56 INFO - Downloading/unpacking psutil>=0.7.1 05:09:56 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 05:09:56 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 05:09:56 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 05:09:56 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 05:09:56 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 05:09:56 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 05:09:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:09:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:58 INFO - Installing collected packages: psutil 05:09:58 INFO - Running setup.py install for psutil 05:09:58 INFO - building 'psutil._psutil_osx' extension 05:09:58 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 05:09:59 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 05:09:59 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 05:09:59 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 05:09:59 INFO - building 'psutil._psutil_posix' extension 05:09:59 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 05:09:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:59 INFO - ^ 05:09:59 INFO - 1 warning generated. 05:09:59 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 05:09:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:59 INFO - Successfully installed psutil 05:09:59 INFO - Cleaning up... 05:09:59 INFO - Return code: 0 05:09:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:59 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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:09:59 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 05:09:59 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 05:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:59 INFO - 'HOME': '/Users/cltbld', 05:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:59 INFO - 'LOGNAME': 'cltbld', 05:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:59 INFO - 'MOZ_NO_REMOTE': '1', 05:09:59 INFO - 'NO_EM_RESTART': '1', 05:09:59 INFO - 'PAGER': '/bin/cat', 05:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:59 INFO - 'PWD': '/builds/slave/test', 05:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:59 INFO - 'SHELL': '/bin/bash', 05:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:09:59 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:59 INFO - 'USER': 'cltbld', 05:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:59 INFO - 'XPC_FLAGS': '0x0', 05:09:59 INFO - 'XPC_SERVICE_NAME': '0', 05:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:10:02 INFO - Installing collected packages: mozsystemmonitor 05:10:02 INFO - Running setup.py install for mozsystemmonitor 05:10:02 INFO - Successfully installed mozsystemmonitor 05:10:02 INFO - Cleaning up... 05:10:02 INFO - Return code: 0 05:10:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:02 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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:10:02 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 05:10:02 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 05:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:02 INFO - 'HOME': '/Users/cltbld', 05:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:02 INFO - 'LOGNAME': 'cltbld', 05:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:02 INFO - 'MOZ_NO_REMOTE': '1', 05:10:02 INFO - 'NO_EM_RESTART': '1', 05:10:02 INFO - 'PAGER': '/bin/cat', 05:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:02 INFO - 'PWD': '/builds/slave/test', 05:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:02 INFO - 'SHELL': '/bin/bash', 05:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:10:02 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:02 INFO - 'USER': 'cltbld', 05:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:02 INFO - 'XPC_FLAGS': '0x0', 05:10:02 INFO - 'XPC_SERVICE_NAME': '0', 05:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:03 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 05:10:03 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 05:10:03 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 05:10:03 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 05:10:03 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 05:10:03 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 05:10:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:05 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 05:10:05 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 05:10:05 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 05:10:05 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 05:10:05 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 05:10:05 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 05:10:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:06 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 05:10:06 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 05:10:06 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 05:10:06 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 05:10:06 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 05:10:06 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 05:10:06 INFO - Downloading docopt-0.6.1.tar.gz 05:10:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:06 INFO - Running setup.py install for blobuploader 05:10:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:06 INFO - Running setup.py install for requests 05:10:07 INFO - Running setup.py install for docopt 05:10:07 INFO - Successfully installed blobuploader requests docopt 05:10:07 INFO - Cleaning up... 05:10:07 INFO - Return code: 0 05:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:07 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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:10:07 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 05:10:07 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 05:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:07 INFO - 'HOME': '/Users/cltbld', 05:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:07 INFO - 'LOGNAME': 'cltbld', 05:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:07 INFO - 'MOZ_NO_REMOTE': '1', 05:10:07 INFO - 'NO_EM_RESTART': '1', 05:10:07 INFO - 'PAGER': '/bin/cat', 05:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:07 INFO - 'PWD': '/builds/slave/test', 05:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:07 INFO - 'SHELL': '/bin/bash', 05:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:10:07 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:07 INFO - 'USER': 'cltbld', 05:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:07 INFO - 'XPC_FLAGS': '0x0', 05:10:07 INFO - 'XPC_SERVICE_NAME': '0', 05:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:07 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-6z3y3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-dJ7D5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-cjatll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-_pw_AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-kekarS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-neL_UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-uGy13t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-u5TTmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-7ikh8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:08 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-tYErd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Ijs17G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-k0K6QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-xvODhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-4TbLB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-bOASaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-bd7ZFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:09 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-KfUZrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:09 INFO - Running setup.py install for manifestparser 05:10:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Running setup.py install for mozcrash 05:10:10 INFO - Running setup.py install for mozdebug 05:10:10 INFO - Running setup.py install for mozdevice 05:10:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Running setup.py install for mozfile 05:10:10 INFO - Running setup.py install for mozhttpd 05:10:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Running setup.py install for mozinfo 05:10:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for mozInstall 05:10:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for mozleak 05:10:11 INFO - Running setup.py install for mozlog 05:10:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for moznetwork 05:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for mozprocess 05:10:11 INFO - Running setup.py install for mozprofile 05:10:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Running setup.py install for mozrunner 05:10:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Running setup.py install for mozscreenshot 05:10:12 INFO - Running setup.py install for moztest 05:10:12 INFO - Running setup.py install for mozversion 05:10:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:12 INFO - Cleaning up... 05:10:12 INFO - Return code: 0 05:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:12 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')]} 05:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:12 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')]} 05:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:12 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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:10:12 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 05:10:12 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 05:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:12 INFO - 'HOME': '/Users/cltbld', 05:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:12 INFO - 'LOGNAME': 'cltbld', 05:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:12 INFO - 'MOZ_NO_REMOTE': '1', 05:10:12 INFO - 'NO_EM_RESTART': '1', 05:10:12 INFO - 'PAGER': '/bin/cat', 05:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:12 INFO - 'PWD': '/builds/slave/test', 05:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:12 INFO - 'SHELL': '/bin/bash', 05:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:10:12 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:12 INFO - 'USER': 'cltbld', 05:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:12 INFO - 'XPC_FLAGS': '0x0', 05:10:12 INFO - 'XPC_SERVICE_NAME': '0', 05:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Spe72v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:13 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-7g52iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:13 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-ShYX72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:13 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-lolBDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-eXj4T9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:13 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-hvToDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:13 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-SqdsN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:13 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-tULBUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-lgvupE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-9hV_fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-nx6qw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-U7dNF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-iQCqag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-9lI3kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-ma4XST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:14 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-vuagu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:15 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)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:15 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-_uZAAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:15 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)) 05:10:15 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)) 05:10:15 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)) 05:10:15 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)) 05:10:15 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:15 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:17 INFO - Downloading blessings-1.5.1.tar.gz 05:10:17 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 05:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:17 INFO - Installing collected packages: blessings 05:10:17 INFO - Running setup.py install for blessings 05:10:17 INFO - Successfully installed blessings 05:10:17 INFO - Cleaning up... 05:10:17 INFO - Return code: 0 05:10:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:18 INFO - Reading from file tmpfile_stdout 05:10:18 INFO - Current package versions: 05:10:18 INFO - blessings == 1.5.1 05:10:18 INFO - blobuploader == 1.2.4 05:10:18 INFO - docopt == 0.6.1 05:10:18 INFO - manifestparser == 1.1 05:10:18 INFO - mozInstall == 1.12 05:10:18 INFO - mozcrash == 0.16 05:10:18 INFO - mozdebug == 0.1 05:10:18 INFO - mozdevice == 0.47 05:10:18 INFO - mozfile == 1.2 05:10:18 INFO - mozhttpd == 0.7 05:10:18 INFO - mozinfo == 0.9 05:10:18 INFO - mozleak == 0.1 05:10:18 INFO - mozlog == 3.0 05:10:18 INFO - moznetwork == 0.27 05:10:18 INFO - mozprocess == 0.22 05:10:18 INFO - mozprofile == 0.27 05:10:18 INFO - mozrunner == 6.11 05:10:18 INFO - mozscreenshot == 0.1 05:10:18 INFO - mozsystemmonitor == 0.0 05:10:18 INFO - moztest == 0.7 05:10:18 INFO - mozversion == 1.4 05:10:18 INFO - psutil == 3.1.1 05:10:18 INFO - requests == 1.2.3 05:10:18 INFO - wsgiref == 0.1.2 05:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10446da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80e4a8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, '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.REIbY4dmDl/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.ydhW9dmyky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 05:10:18 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 05:10:18 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 05:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:18 INFO - 'HOME': '/Users/cltbld', 05:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:18 INFO - 'LOGNAME': 'cltbld', 05:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:18 INFO - 'MOZ_NO_REMOTE': '1', 05:10:18 INFO - 'NO_EM_RESTART': '1', 05:10:18 INFO - 'PAGER': '/bin/cat', 05:10:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:18 INFO - 'PWD': '/builds/slave/test', 05:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:18 INFO - 'SHELL': '/bin/bash', 05:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:10:18 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:18 INFO - 'USER': 'cltbld', 05:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:18 INFO - 'XPC_FLAGS': '0x0', 05:10:18 INFO - 'XPC_SERVICE_NAME': '0', 05:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 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)) 05:10:18 INFO - Cleaning up... 05:10:18 INFO - Return code: 0 05:10:18 INFO - Running post-action listener: _resource_record_post_action 05:10:18 INFO - Running post-action listener: _start_resource_monitoring 05:10:18 INFO - Starting resource monitoring. 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running install step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: install 05:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:18 INFO - Reading from file tmpfile_stdout 05:10:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:18 INFO - Reading from file tmpfile_stdout 05:10:18 INFO - Output received: 05:10:18 INFO - Usage: mozinstall [options] installer 05:10:18 INFO - Options: 05:10:18 INFO - -h, --help show this help message and exit 05:10:18 INFO - -d DEST, --destination=DEST 05:10:18 INFO - Directory to install application into. [default: 05:10:18 INFO - "/builds/slave/test"] 05:10:18 INFO - --app=APP Application being installed. [default: firefox] 05:10:18 INFO - mkdir: /builds/slave/test/build/application 05:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:10:54 INFO - Reading from file tmpfile_stdout 05:10:54 INFO - Output received: 05:10:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:10:54 INFO - Running post-action listener: _resource_record_post_action 05:10:54 INFO - ##### 05:10:54 INFO - ##### Running run-tests step. 05:10:54 INFO - ##### 05:10:54 INFO - Running pre-action listener: _resource_record_pre_action 05:10:54 INFO - Running main action method: run_tests 05:10:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:54 INFO - 2015-11-03 05:10:54.304 screenresolution[1957:14070] starting screenresolution argv=screenresolution get 05:10:54 INFO - 2015-11-03 05:10:54.308 screenresolution[1957:14070] Display 0: 1600x1200x32@60 05:10:54 INFO - 2015-11-03 05:10:54.314 screenresolution[1958:14072] starting screenresolution argv=screenresolution list 05:10:54 INFO - Available Modes on Display 0 05:10:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:54 INFO - Intel HD Graphics 3000: 05:10:54 INFO - Chipset Model: Intel HD Graphics 3000 05:10:54 INFO - Type: GPU 05:10:54 INFO - Bus: Built-In 05:10:54 INFO - VRAM (Total): 512 MB 05:10:54 INFO - VRAM (Dynamic, Max): 10 05:10:54 INFO - Vendor: Intel (0x8086) 05:10:54 INFO - Device ID: 0x0116 05:10:54 INFO - Revision ID: 0x0009 05:10:54 INFO - Displays: 05:10:54 INFO - Display: 05:10:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:54 INFO - Display Serial Number: 1600x1200 60 05:10:54 INFO - Main Display: Yes 05:10:54 INFO - Mirror: Off 05:10:54 INFO - Online: Yes 05:10:54 INFO - Rotation: Supported 05:10:54 INFO - Return code: 0 05:10:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:54 INFO - Python 2.7.3 05:10:54 INFO - Return code: 0 05:10:54 INFO - grabbing minidump binary from tooltool 05:10: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')]} 05:10:54 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 0x1044229f0>, '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 0x104181cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ec990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:54 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 05:10:54 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 05:10:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:54 INFO - Return code: 0 05:10:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:10:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:10:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] in /builds/slave/test/build 05:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0049 --webServer localhost 05:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.REIbY4dmDl/Render', 05:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:54 INFO - 'HOME': '/Users/cltbld', 05:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:54 INFO - 'LOGNAME': 'cltbld', 05:10:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:54 INFO - 'MOZ_NO_REMOTE': '1', 05:10:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:54 INFO - 'NO_EM_RESTART': '1', 05:10:54 INFO - 'PAGER': '/bin/cat', 05:10:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:54 INFO - 'PWD': '/builds/slave/test', 05:10:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:54 INFO - 'SHELL': '/bin/bash', 05:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ydhW9dmyky/Listeners', 05:10:54 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 05:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:54 INFO - 'USER': 'cltbld', 05:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:54 INFO - 'XPC_FLAGS': '0x0', 05:10:54 INFO - 'XPC_SERVICE_NAME': '0', 05:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] with output_timeout 3600 05:10:54 INFO - mozversion INFO | application_buildid: 20151103031432 05:10:54 INFO - mozversion INFO | application_changeset: c10c657afbe1fb64a9ed2e62a399c52c4038c186 05:10:54 INFO - mozversion INFO | application_display_name: Nightly 05:10:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:54 INFO - mozversion INFO | application_name: Firefox 05:10:54 INFO - mozversion INFO | application_remotingname: firefox 05:10:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:10:54 INFO - mozversion INFO | application_vendor: Mozilla 05:10:54 INFO - mozversion INFO | application_version: 45.0a1 05:10:54 INFO - mozversion INFO | platform_buildid: 20151103031432 05:10:54 INFO - mozversion INFO | platform_changeset: c10c657afbe1fb64a9ed2e62a399c52c4038c186 05:10:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:54 INFO - mozversion INFO | platform_version: 45.0a1 05:10:54 INFO - 2015-11-03 05:10:54,891 DEBUG : using testdate: 1446556254 05:10:54 INFO - 2015-11-03 05:10:54,891 DEBUG : actual date: 1446556254 05:10:54 INFO - 2015-11-03 05:10:54,972 INFO : starting webserver on 'localhost:49494' 05:10:54 INFO - 2015-11-03 05:10:54,973 INFO : Starting test suite t-yosemite-r5-0049 05:10:54 INFO - 2015-11-03 05:10:54,974 INFO : Starting test dromaeo_css 05:10:54 INFO - 2015-11-03 05:10:54,974 DEBUG : operating with platform_type : mac_ 05:10:54 INFO - 2015-11-03 05:10:54,974 INFO : Initialising browser for dromaeo_css test... 05:10:54 INFO - 2015-11-03 05:10:54,987 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmp9iWzVj/profile http://localhost:49494/getInfo.html 05:10:57 INFO - 2015-11-03 05:10:57,186 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:10:57 INFO - 2015-11-03 05:10:57,186 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:10:57 INFO - 2015-11-03 05:10:57,186 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:10:57 INFO - 2015-11-03 05:10:57,186 DEBUG : BROWSER_OUTPUT: __metrics 05:10:57 INFO - 2015-11-03 05:10:57,202 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:57 INFO - 2015-11-03 05:10:57,861 INFO : Browser initialized. 05:10:57 INFO - 2015-11-03 05:10:57,861 INFO : Running cycle 1/1 for dromaeo_css test... 05:10:57 INFO - 2015-11-03 05:10:57,861 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmp9iWzVj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:09 INFO - 2015-11-03 05:11:09,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 220438528 05:11:09 INFO - 2015-11-03 05:11:09,743 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-03 05:12:00,648 DEBUG : BROWSER_OUTPUT: 1446556320641 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] 05:14:11 INFO - 2015-11-03 05:14:11,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49494/tests/dromaeo/cssquery-ext.html) 05:14:13 INFO - 2015-11-03 05:14:13,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 363376640 05:14:13 INFO - 2015-11-03 05:14:13,098 DEBUG : BROWSER_OUTPUT: 05:17:15 INFO - 2015-11-03 05:17:15,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-ext.html (next: http://localhost:49494/tests/dromaeo/cssquery-jquery.html) 05:17:16 INFO - 2015-11-03 05:17:16,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 359845888 05:17:16 INFO - 2015-11-03 05:17:16,418 DEBUG : BROWSER_OUTPUT: 05:20:18 INFO - 2015-11-03 05:20:18,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49494/tests/dromaeo/cssquery-mootools.html) 05:20:19 INFO - 2015-11-03 05:20:19,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 338542592 05:20:19 INFO - 2015-11-03 05:20:19,079 DEBUG : BROWSER_OUTPUT: 05:23:21 INFO - 2015-11-03 05:23:21,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49494/tests/dromaeo/cssquery-prototype.html) 05:23:21 INFO - 2015-11-03 05:23:21,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 315359232 05:23:21 INFO - 2015-11-03 05:23:21,683 DEBUG : BROWSER_OUTPUT: 05:26:24 INFO - 2015-11-03 05:26:24,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49494/tests/dromaeo/cssquery-yui.html) 05:26:25 INFO - 2015-11-03 05:26:25,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 314859520 05:26:25 INFO - 2015-11-03 05:26:25,297 DEBUG : BROWSER_OUTPUT: 05:29:27 INFO - 2015-11-03 05:29:27,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-yui.html (next: http://localhost:49494/tests/dromaeo/cssquery-dojo.html) 05:29:28 INFO - 2015-11-03 05:29:28,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 359530496 05:29:28 INFO - 2015-11-03 05:29:28,103 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,103 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:28 INFO - 2015-11-03 05:29:28,103 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:28 INFO - 2015-11-03 05:29:28,103 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:28 INFO - 2015-11-03 05:29:28,103 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:28 INFO - 2015-11-03 05:29:28,104 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3228.209088773251;3256.6906143916335;3267.5262086997395;3301.570795796546;3313.072339744871;5162.354705661793;5285.6300058995885;5463.071277882759;5479.890402191959;5493.011257973563;5329.600279979008;5338.62629615927;5358.410574836765;5378.784848606051;5464.644798088121;4941.431735350445;4966.379202599675;4981.576565991895;4999.650024498286;5028.207380062815;5024.974875125619;5096.337476128117;5104.489551044903;5105.106606343894;5187.844364669066;4858.854234372974;4891.755412229374;4984.750762461862;5000.249962505617;5083.364579427572;5030.597552195815;5045.596352291845;5055.51972562606;5061.519155680205;5097.515736005073;4995.250712393134;5005.57452616528;5015.774290156915;5026.874328141789;5030.396352437694;5174.715390653512;5176.818811341623;5284.81503147388;5310.840674779763;5342.652727572734;5686.886262274773;5687.971560142173;5690;5698.8290351289115;5766.682832444214;5758.481736643722;5771.422857714237;5775.711214439261;5777.393373695743;5793.971030144864;5245.816396426107;5278.947210527922;5353.9732301338245;5374.27447294618;5439.265699130607;5874.118882167623;5887.528997680175;5888.087346461305;5910.734016969247;5911.379305172981;5624.268845050199;5630.380658127603;5638.689872057076;5655.575831812631;5671.773129074873;5533;5639.971800141055;5645.802396916089;5679.488846003879;5765.1640512125505;5690.2033715279895;5691.601587888891;5704.3154821421695;5710.514606258432;5756.42435756421;5674.546036317085;5686.687232202268;5687.175359572839;5691.658500489983;5691.9146212806845;4316.503602085801;4430.822767089345;4446.488653804854;4449.310356894686;4480.484744254387;4086.7139300248696;4110.05468742191;4120.196561670446;4126.319157339006;4126.896827579335;5226.372835259793;5269.420363759983;5277.9472205278225;5303.840884773463;5312.335958005249;5563.860903477445;5581.581381396411;5586.35756887955;5589.413111623221;5893.2928048633585;5166.483351664879;5169.302144210484;5191.2472691459525;5215.452377500384;5244.475552444801;4938.456769755324;4984.27727979441;5021.673591216632;5040.092783299041;5048.62135339851;5773.6824474654295;5782.508486778671;5790.247267855152;5795.362510123883;5842.824715258549;5705.400932902152;5735.655860648374;5746;5759.65442073477;5768.105943578752;5578.804741834017;5687.488126068673;5702.372738998624;5709.857253568694;5742.626729262584;5706.087026075808;5711.600187986801;5719.170720245625;5723.971380143073;5725.312962444534;5823.970880145572;5826.213461182856;5837;5837.708114594168;5839.883202336015;5245.763940622604;5355.571554275726;5374.140137577969;5515.117581186991;5629.408912064175;5586.301712285965;5591.384947655673;5602.047651899268;5607.691576963306;5683.658980461186;5485.4788795064405;5498.835034948958;5515.751791169327;5517.558595312285;5521.723913804374;5459.2629994950175;5462.91805622908;5568.470995255444;5611.971940140274;5633.324001119892;5494.670319780666;5500.752466138953;5528.004959107399;5542.140968149944;5595.832125036255 05:29:28 INFO - 2015-11-03 05:29:28,105 DEBUG : BROWSER_OUTPUT: |1;ext.html;500.6020213929925;528.281537109531;540.0225591679061;544.5725105791954;558.1599692462847;31700.52449213261;32510.187245318877;32525.349493010184;32728.836355818217;39503.209935801264;43494.34758478625;44070.77964610173;44122.7793861031;44238.11523769522;44558.10883782322;9107.316951228668;9288.349815512884;9291.48896810675;9311.255099592016;9418.952905235465;8438.493690378566;8633.69782057628;9104.271658267357;11259.493322800452;11315.717107072307;11117.055050320732;11121.610743623974;11146.777064458705;11171.553137874474;11293;8381.245687888058;11092.33445993243;11152.721181970435;11186.552537898515;11248.325100493996;8283.08886022537;10994.450277486174;11207.887921120848;11238.438078096062;11382.658520244406;39903.60096399057;39910.20179596392;39969;39984.80007599943;40475;2919.44530539199;3000.3999200160056;3052.0494112835963;3422.19578399076;3569.1790888095625;27345.86327068372;27355.589666155025;27982.580261296098;28171.29571760702;28175.295617609725;2374.169040835711;2424.260600516859;2430.1615942499984;2475.4306509502917;2553.8340007899615;283936;284147;284809;285519;286472;54965.450345496836;56171.71914140403;60296.39703602908;60547;60873.695631522445;60436;61451;61534.38465615376;61613;62244.37755622476;16368;16625.168741562873;16630;16657.750133748003;16663.16684165787;12644.114911956258;12713.046521510923;12721.173123746927;12733.045021623415;12735.108542401942;19129.426117216506;19167;19192.13635386411;19200.231990720495;19245.615087698166;8137.8372432552205;8351.123132071167;8379.62291696875;8397.328213742885;8398.958005209935;938.7090002099371;997.6957028106352;1007.9143272821892;1031.6801791444677;1115.3976852499559;28086.578701319497;28136.71863281382;28150.71849281522;28182.43635127286;28420.43159136847;1050.9159267258601;1052.5000624703357;1082.3181395720803;1102.9687242428195;1154.924929879555;14438.783418248735;14468.157367682372;14575.271236438348;14731.926340368229;14732.484363047242;322317;330158;330272;330353;330754;54055.72972135193;54088;54130.18804717933;54405.72797135989;54746.43042834885;1377.937992790327;1387.0775934003975;1406.8382136054486;1410.168000879486;1412.7386433509835;27308.453830923667;28131.296717582223;28132.85933570319;28344.574831377133;29033.274168145967;45688.771556142005;47195.764021179675;47242.76378618085;47395.76302118467;47878.5212147888;239480;296875;302857;303395;304185;28504.857475712488;29070.27324316909;29082.27294317659;29414.852925735235;29441.85279073591;39795.40306895457;40278;40338;40338.798306009456;41292.587074128875;34172.48741268933;34599.13502162466;34991.475127872596;35104.47343289904;35285.64714352926;33170.5024424629;33471.330573388885;33538;33773.15567110842;34917.650823492455;33094.5035824458;33148.86192640145;33501;33539.83230083931;33856.322873541896;27713.722862771116;29910.102696919126;29931.102066938027;30008.3998320028;30067;22445.32664020082;22770.886145569828;22970.425739355982;22989.770102298764;23787.881060594587 05:29:28 INFO - 2015-11-03 05:29:28,109 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.4797715563721;338.07634559357257;339.40942759598306;344.14480017157365;349.9728297446993;13991.580252592414;14518.927405362985;17007.31970721171;17755.911220443897;19196.808031919678;14170;15428.845711542881;17896.463106106807;17939.820601793977;18868.90565547174;5295.576353891689;5439.673619582818;5506;5513.2005859150395;5526.143447765603;3890.1247219375555;4017.2969730297227;4394;5963.105534169866;5991.2510936132985;5681.744321505522;5804.912926306109;5852;5864.970675146639;5872.148538461921;5664.54683625309;5801.100829371412;5851.356350801409;5852.092925596518;5856.121581762727;4973.850784476472;4997.275395067732;5005.599552035828;5039.974800126012;5060.342155519796;20163.79836201634;20862.16551337945;20949.581008379748;21397.893010534848;21616.135354585796;1885.7359969604267;1950.8439324853978;2000.3598848368529;2091.989540052305;2097.6538871086254;12477.875221247763;12636.2418254905;13093.738125237538;13313.800292995613;13518.932405338008;1587.4920025591816;1629.8451647093507;1643.318023020445;1660.5848537865534;1676.924538395775;56499.43500565024;58287.12569311421;58578.12132818011;59340.10989835199;59386.40613593852;9515.096065873731;9581.329306948446;9584.808303833885;9712.514374281258;9771.316007879523;11790.764184716258;11794.705132371588;11815.468303926344;11820.94089529564;11944.104192185621;7537.9623101884135;7580.924190758022;7655.655495502716;7667.118281397599;7792.259735325135;7448.553086814808;7498.775036748906;7518.812029699301;7561.546307221474;7564.659590318449;5634.070378387521;5677.659340439587;5679.886402271932;5734.569907256889;5755;1543.9536813895602;1598.3446786817349;1603.0782300177445;1617.5956010997252;1653.4378311374192;829.4815740162398;882.2765332427348;990.7919336939179;1018.1803648063232;1086.4241951765578;18377.356792512197;18524.722129168073;18571;18664.253429862652;18868.245270189313;811.7158994351929;907.4691305586174;922.2253307221831;943.9528023598792;1021.875936469892;10044.29689921713;10243.795124097476;10258.384496930208;10283.94858025705;10304;515565;527788;538299;538418;548149;66438.66780666163;68068.31931680719;68696;69692.65153674199;69734.65132674304;1097.8188598881254;1106.4965440724452;1121.4616983847798;1127.7237076916208;1140.880207578209;15936.20318984023;15974.8402515978;16013.119278439332;16027.599310017344;16233.107179105262;30504.389912201186;31022.37955240928;31106.22234444157;31202;31538.526922096647;44218.557814421445;44522.3321650169;44704.32943505785;44881.55118448774;45063.32405013993;8886.555672216493;8934.687285944961;9000.459972401677;9002.414843035182;9006.36955413141;17504.387346442814;17556.473305800337;17995.2801887923;18049;18107.09464526795;13997.440102396198;14058.297085145907;14482.420703171754;14615.707685846437;14632.70734585281;13929.442822286996;14041.5085472008;14071.859281407054;14351.784723228951;14710.19093949843;11782.764344713229;14689.70620587561;14911;15233.847661523687;15311.310991005208;7517.210692877388;7597.467177762146;7836.216378362346;7869.960650196941;9076;14398.784018239525;14633.780493292395;14643.194624295766;14876.330565124812;14924.552263432115 05:29:28 INFO - 2015-11-03 05:29:28,110 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1389.944402223911;1729.6021914959558;1828.5680342151118;1829.1316108014405;1846.806085361037;7085.929140708591;7152.570845749258;7387.667554960026;7791.610419479025;7817.452778305514;7321.231270716578;7341.926580734191;7477.476576639638;7507.887381689279;7564.092308922924;2175.0973346061405;2217.4013016485537;2217.789310015546;2224.232639739287;2228.8439809213282;2040.459278291254;2085.405659387075;2181.9563608727817;2229.6766968789516;2230;2167.035669127239;2180.8364372672036;2181.803637672609;2189.6168170570168;2193.7915897989665;1979.1094007696595;2211.535577528713;2217.4899773052125;2224.1992882562345;2230.029936977412;1972.3491247888162;2142.1003178664996;2201.1085510368325;2208.977910220893;2221.2225720997685;7514.54912705234;7582.317591416744;7583.090029196476;7596.08846938371;7702.114256860421;4667.13657973276;4724.196886529264;4745.3593764842;4745.715257084586;4787.234042553175;2905.8547072646284;2930.238138084092;2942.4703553360387;2967.6883927187764;2998.5202367621296;908.2416182487631;962.4321650226331;985.7781999050228;1562.3828587707792;1566.3343079191297;9875.308728389016;9978.850317245247;9981.25140614464;9988.250881183867;10002.949985250027;4102.774347410921;4119.649829764444;4192.832286708497;4204.600562946515;4247.830086796494;8334.374921880883;8344.83310333802;8346.165383461605;8358.414910956175;8358.916410835815;4766.451858036301;4777.95222047775;4778;4783.521647835189;4846.36997190363;4432.49026361966;4441.511433742286;4442.222611043055;4467.463904331501;4488.4165058542185;3436.9484457733156;3448.8448019839166;3458.429359155711;3481.56480439945;3491.4762785582366;1026.8049070676548;1039.9376037437778;1041.8541404203418;1046.863907691995;1055.3140458701905;1318.3408295852073;1330.042369493982;1331.3010669398643;1333.926634035118;1370.6093763277418;7341.3392794648735;7362.226966168582;7617.238276172338;7622.5045372051745;7625.771226863203;1137.7496950670838;1151.1826603111717;1153.9076873850072;1160.8316794064813;1171.2035815645443;5591.245181900473;5682.914756278659;5909.261342332208;5957.523398128139;6021.849453763603;8853.15894989975;9018.09819018093;9038.412503187403;9065.274778017743;9096.408733432305;8846.292296616255;9013.504257265782;9077.591508382138;9091.36360454775;9119.361644684808;7299.59852208123;7309.488335816548;7341.669624866894;7363.926360736431;7417.480776345604;7101.644917753988;7197.244289349543;7273.454490913308;7280.381167600814;7286.344229019413;7937.206279372017;8179.141190174946;8220.83558328842;8248.13394593583;8257.463264887763;8161;8353.373496987871;8409.62156702962;8470.068292487698;8577.82844343122;6462.192225971754;6545.14913061318;6553.901691474727;6577.210734711865;6632.071509988702;7267.0552828132;7431.4054875608745;7482.476226664299;7509.023826902686;7519.887201692089;6880.759173428906;6930.61881596517;7002.719891204295;7038.085048943809;7060.117485314336;6775.627340496123;6811.557248778813;6849.691763870737;6930.7227710891;6962.651867406508;7039.260877607982;7041.718331266692;7043.401310888426;7052.18899826506;7058.929410706032;6339.049142628643;6344.460720838596;6419.871602568016;6424.421802037652;6437.066625339393;6434.742610295536;6494.1232933553365;6497.870042599027;6499.545031847914;6534 05:29:28 INFO - 2015-11-03 05:29:28,111 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.5844642161709;300.25686426095416;321.6494021516548;326.78268951147476;330.83788943417704;5818.709064546777;5908.172855800191;6025.849353766158;6053.727582258798;6072.180255665484;5876.618019828708;5888.852778680524;5913.73388197531;5974.223350964368;5982.61113027654;4463.754493502856;4620;4687.203175460163;4705.552972467619;4742.33607294979;4580.038191979688;4650.209464391061;4673.976630116845;4712.656892785557;4735.124002059612;4645.953540464603;4648.930266046012;4665.253559430492;4676.532346765331;4693.765311734417;4439.933400998988;4481.708688935209;4605.585497305258;4677.228257337535;4696.835610753641;3976.7415118017525;4023.054582173187;4040.0505881117915;4048.9797551012352;4049.493813273341;5730.312362516483;5806;5809.738561764731;5819.330776960662;5830.708464576796;5136.332276804029;5145.511176438233;5155.381354237478;5167.948320516784;5198.870028249286;6122.96938515309;6188.381161883821;6251.4061164189325;6277.87444251117;6283.654399008053;4223.176480586287;4229.70392072555;4241.618254357123;4252.277112890816;4266.786660666985;6430.453411460032;6447.161868957052;6458.354164583504;6528.738850445977;6543.149390579242;4152.2525945330135;4250.3836943643;4299.462567179103;4317.244482215599;4320.135972805451;4334.241507736134;4336.739795612273;4338.848140315074;4378.343248512749;4394.802233899482;5062.620303477254;5063.898722025612;5096.719680417538;5098.974505127525;5101.132807422747;6221.751129954841;6223.066540018943;6275.937240627535;6304.684765761694;6305.527085468517;1522.1856306875989;1558.75059990401;1582.2168026826794;1583.200483755696;1590.721623715845;1003.4481035430484;1008.6873069348526;1020.7601213714771;1021.402479549457;1022.9590816367262;5838.299404071538;5850.268716410449;5915.645061296336;5926.4369884861735;5935.228420305332;6411;6429.260635027032;6488;6488.772892948724;6502.252240992347;5907.025340818716;5914.8817023659285;5930.347661757203;5975.7609695612555;5986.311574168939;3381.7125544328514;3472.5138480612736;3540.539729835105;3624.3294990426857;3643.3259846928404;6531.11829902957;6540.149780528501;6599;6630.9668451657435;6648.833779155463;6666.899996500057;6684.2981486944145;6717.832054198684;6754.493412994045;6785.42323902464;6352.4918006559365;6495.837604059841;6563.343665633494;6573.638449885207;6715.4963377747845;6562.146920900253;6575.4410875076155;6642.136522252076;6650.501212409185;6666.433353165035;6410.391012853772;6440.710168042356;6488.837779055561;6502.869942601216;6508.837279068061;6495.935040649722;6629.403353698191;6632.668366581748;6681.76613818514;6693.933060669331;4355.477342718767;4368.563143685733;4385.605295523418;4388.670849686222;4400.62594679443;6542.83642908912;6584.868302634016;6606.372394622503;6611.239707433514;6621.668916554249;6242.53181011435;6307.36926307384;6335.524835637438;6342.23893132827;6416.197975253093;6299.685015749286;6318.431341179132;6350.7142178603;6368.522360822864;6394.072859435449;6219.906701399573;6229.190205273286;6230.470410015199;6246.063090536456;6270.216222972129;6062.696865156637;6226.346233645402;6251.46862516673;6341.778037768656;6428.4214420702365;6026.126211699191;6109.75560977556;6145.170401995673;6168;6199.16311297969 05:29:28 INFO - 2015-11-03 05:29:28,115 DEBUG : BROWSER_OUTPUT: |5;yui.html;665.2848188197687;687.3298533929417;713.0373995106603;762.8779395296754;769.3345256353255;13222.53721119761;13500.662483437918;13551.593452196425;13719.039667223298;14317.713645727079;12532.436040378183;12596.748065038693;12639.052071094658;12692.619221423372;12767.042471814628;691.761342336893;710.0981753173467;859.1151114352211;876.1632640827994;897.6947837735169;877.3069275272559;881.9603117859712;890.0698769785557;891.9509426981514;892.4823602310677;744.8435828476026;928.0255731481917;931.4644079654192;932.2495391210073;932.6875496708611;750.1673142811475;897.0760117079419;913.5706218077493;914.0448231597996;914.3005600715425;681.8125015620744;682.7985744205422;683.1631251716657;683.770936736194;684.5447777228137;13520.12119212248;13679.658008549766;13723.588292351245;13834.861651383559;13879.930600346934;11379.772404551863;11419.657410277705;11583.478743456564;11749.060075193964;11874.881251187464;9362.765930851716;9450.33847630666;9469.573869175834;9502.334836561444;10062.345947513388;3257.1857035741064;3290.243244053881;3318.8340582970754;3342.3148254607745;3484.3205574912904;47105.52894471046;47517.81205469857;47607;47783.52216477825;47982.520174798155;8761.430507017023;8876.644934202559;8952.731418057469;9034.23209027227;9042.86435703465;11884.108691848145;19357.12892919822;19370.225190992485;19375;19408;6223.159873417121;6370.044493325945;6435.388638079375;6490.740370385226;6511.772087976993;3709.7217708671956;3728.422094575345;3748.887533374003;3793.6585707285926;3842.7886466244067;2848.4730324889547;2882.0489238551227;2882.8702708378173;2888.1479963410843;2899.4635992341487;423.21916064860284;427.83742177972795;428.34035585198444;431.42189466115553;482.1538200458173;416.11783019997796;458.5574920202021;502.2466300549176;537.2961420539107;595.624756403463;7028.1917579477995;7653.540787552764;7680.116786569504;7703.653335599912;7757.68969241224;566.6005466146357;576.2681394628798;596.1981135372916;598.3687209993499;609.2780055634088;3528.523649307362;3572.1248294168095;3588.2644057968055;3617.366960781905;3674.9448758268645;60024.69987650121;60082.09876851851;60315.39684603186;60531.69734151301;60584.697076515215;48535.51464485381;49204.50795492071;49364.75317623389;49597.75201123971;49704.75147624239;47314.76342618334;47331.290030649565;47391.763041185266;47926.28110578344;48147;7787.332922881229;7847;7919.802004949923;8014.675744034164;8168.877466838121;34949.47575786416;34994.82502587471;35549.644503554635;35698.643013569534;35914.64085359113;43854.561454385046;45347.773261134804;48080.759596201795;48471.51528484811;49065.26402104043;7006.5095443320515;7109.431245500451;7155.677874835492;7158.1768096667465;7167.390771784457;10552.472376381304;10808.351498910091;10854.67435976922;11599.536018559163;11860.76278474443;10390;10525.631602893862;10529.894701053197;10543.578256869947;10601.946990265;10035.749106272402;10245.948770256102;10370.377777333384;10507.211959103252;10722.624708135178;10143.492825358555;10155.289129761142;10164.949175254076;10668.146548275965;11087.72280692989;8043.316318113026;8250.422470427253;8300.70947516834;8420.368472364475;8739.475631462132;8182;8461.280791132576;8570.78573035679;8639.784005399915;8894.73315800527 05:29:28 INFO - 2015-11-03 05:29:28,115 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:28 INFO - 2015-11-03 05:29:28,115 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:28 INFO - 2015-11-03 05:29:28,115 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1174 05:29:28 INFO - 2015-11-03 05:29:28,115 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:28 INFO - 2015-11-03 05:29:28,116 DEBUG : BROWSER_OUTPUT: __startTimestamp1446557368100__endTimestamp 05:29:28 INFO - 2015-11-03 05:29:28,116 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,116 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:28 INFO - 2015-11-03 05:29:28,116 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:29:28 INFO - 2015-11-03 05:29:28,116 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,117 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5329.63 Median:5498.84 stddev:540.98 (9.8%) stddev-sans-first:516.91 05:29:28 INFO - 2015-11-03 05:29:28,117 DEBUG : BROWSER_OUTPUT: Values: 3228.2 3256.7 3267.5 3301.6 3313.1 5162.4 5285.6 5463.1 5479.9 5493.0 5329.6 5338.6 5358.4 5378.8 5464.6 4941.4 4966.4 4981.6 4999.7 5028.2 5025.0 5096.3 5104.5 5105.1 5187.8 4858.9 4891.8 4984.8 5000.2 5083.4 5030.6 5045.6 5055.5 5061.5 5097.5 4995.3 5005.6 5015.8 5026.9 5030.4 5174.7 5176.8 5284.8 5310.8 5342.7 5686.9 5688.0 5690.0 5698.8 5766.7 5758.5 5771.4 5775.7 5777.4 5794.0 5245.8 5278.9 5354.0 5374.3 5439.3 5874.1 5887.5 5888.1 5910.7 5911.4 5624.3 5630.4 5638.7 5655.6 5671.8 5533.0 5640.0 5645.8 5679.5 5765.2 5690.2 5691.6 5704.3 5710.5 5756.4 5674.5 5686.7 5687.2 5691.7 5691.9 4316.5 4430.8 4446.5 4449.3 4480.5 4086.7 4110.1 4120.2 4126.3 4126.9 5226.4 5269.4 5277.9 5303.8 5312.3 5563.9 5581.6 5586.4 5589.4 5893.3 5166.5 5169.3 5191.2 5215.5 5244.5 4938.5 4984.3 5021.7 5040.1 5048.6 5773.7 5782.5 5790.2 5795.4 5842.8 5705.4 5735.7 5746.0 5759.7 5768.1 5578.8 5687.5 5702.4 5709.9 5742.6 5706.1 5711.6 5719.2 5724.0 5725.3 5824.0 5826.2 5837.0 5837.7 5839.9 5245.8 5355.6 5374.1 5515.1 5629.4 5586.3 5591.4 5602.0 5607.7 5683.7 5485.5 5498.8 5515.8 5517.6 5521.7 5459.3 5462.9 5568.5 5612.0 5633.3 5494.7 5500.8 5528.0 5542.1 5595.8 05:29:28 INFO - 2015-11-03 05:29:28,117 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,117 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46756.13 Median:30037.70 stddev:78996.25 (263.0%) stddev-sans-first:79141.51 05:29:28 INFO - 2015-11-03 05:29:28,118 DEBUG : BROWSER_OUTPUT: Values: 500.6 528.3 540.0 544.6 558.2 31700.5 32510.2 32525.3 32728.8 39503.2 43494.3 44070.8 44122.8 44238.1 44558.1 9107.3 9288.3 9291.5 9311.3 9419.0 8438.5 8633.7 9104.3 11259.5 11315.7 11117.1 11121.6 11146.8 11171.6 11293.0 8381.2 11092.3 11152.7 11186.6 11248.3 8283.1 10994.5 11207.9 11238.4 11382.7 39903.6 39910.2 39969.0 39984.8 40475.0 2919.4 3000.4 3052.0 3422.2 3569.2 27345.9 27355.6 27982.6 28171.3 28175.3 2374.2 2424.3 2430.2 2475.4 2553.8 283936.0 284147.0 284809.0 285519.0 286472.0 54965.5 56171.7 60296.4 60547.0 60873.7 60436.0 61451.0 61534.4 61613.0 62244.4 16368.0 16625.2 16630.0 16657.8 16663.2 12644.1 12713.0 12721.2 12733.0 12735.1 19129.4 19167.0 19192.1 19200.2 19245.6 8137.8 8351.1 8379.6 8397.3 8399.0 938.7 997.7 1007.9 1031.7 1115.4 28086.6 28136.7 28150.7 28182.4 28420.4 1050.9 1052.5 1082.3 1103.0 1154.9 14438.8 14468.2 14575.3 14731.9 14732.5 322317.0 330158.0 330272.0 330353.0 330754.0 54055.7 54088.0 54130.2 54405.7 54746.4 1377.9 1387.1 1406.8 1410.2 1412.7 27308.5 28131.3 28132.9 28344.6 29033.3 45688.8 47195.8 47242.8 47395.8 47878.5 239480.0 296875.0 302857.0 303395.0 304185.0 28504.9 29070.3 29082.3 29414.9 29441.9 39795.4 40278.0 40338.0 40338.8 41292.6 34172.5 34599.1 34991.5 35104.5 35285.6 33170.5 33471.3 33538.0 33773.2 34917.7 33094.5 33148.9 33501.0 33539.8 33856.3 27713.7 29910.1 29931.1 30008.4 30067.0 22445.3 22770.9 22970.4 22989.8 23787.9 05:29:28 INFO - 2015-11-03 05:29:28,119 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,119 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28302.10 Median:31154.11 stddev:86981.17 (279.2%) stddev-sans-first:87199.82 05:29:28 INFO - 2015-11-03 05:29:28,120 DEBUG : BROWSER_OUTPUT: Values: 333.5 338.1 339.4 344.1 350.0 13991.6 14518.9 17007.3 17755.9 19196.8 14170.0 15428.8 17896.5 17939.8 18868.9 5295.6 5439.7 5506.0 5513.2 5526.1 3890.1 4017.3 4394.0 5963.1 5991.3 5681.7 5804.9 5852.0 5865.0 5872.1 5664.5 5801.1 5851.4 5852.1 5856.1 4973.9 4997.3 5005.6 5040.0 5060.3 20163.8 20862.2 20949.6 21397.9 21616.1 1885.7 1950.8 2000.4 2092.0 2097.7 12477.9 12636.2 13093.7 13313.8 13518.9 1587.5 1629.8 1643.3 1660.6 1676.9 56499.4 58287.1 58578.1 59340.1 59386.4 9515.1 9581.3 9584.8 9712.5 9771.3 11790.8 11794.7 11815.5 11820.9 11944.1 7538.0 7580.9 7655.7 7667.1 7792.3 7448.6 7498.8 7518.8 7561.5 7564.7 5634.1 5677.7 5679.9 5734.6 5755.0 1544.0 1598.3 1603.1 1617.6 1653.4 829.5 882.3 990.8 1018.2 1086.4 18377.4 18524.7 18571.0 18664.3 18868.2 811.7 907.5 922.2 944.0 1021.9 10044.3 10243.8 10258.4 10283.9 10304.0 515565.0 527788.0 538299.0 538418.0 548149.0 66438.7 68068.3 68696.0 69692.7 69734.7 1097.8 1106.5 1121.5 1127.7 1140.9 15936.2 15974.8 16013.1 16027.6 16233.1 30504.4 31022.4 31106.2 31202.0 31538.5 44218.6 44522.3 44704.3 44881.6 45063.3 8886.6 8934.7 9000.5 9002.4 9006.4 17504.4 17556.5 17995.3 18049.0 18107.1 13997.4 14058.3 14482.4 14615.7 14632.7 13929.4 14041.5 14071.9 14351.8 14710.2 11782.8 14689.7 14911.0 15233.8 15311.3 7517.2 7597.5 7836.2 7870.0 9076.0 14398.8 14633.8 14643.2 14876.3 14924.6 05:29:28 INFO - 2015-11-03 05:29:28,120 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,120 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5360.95 Median:6496.00 stddev:2707.59 (41.7%) stddev-sans-first:2698.73 05:29:28 INFO - 2015-11-03 05:29:28,122 DEBUG : BROWSER_OUTPUT: Values: 1389.9 1729.6 1828.6 1829.1 1846.8 7085.9 7152.6 7387.7 7791.6 7817.5 7321.2 7341.9 7477.5 7507.9 7564.1 2175.1 2217.4 2217.8 2224.2 2228.8 2040.5 2085.4 2182.0 2229.7 2230.0 2167.0 2180.8 2181.8 2189.6 2193.8 1979.1 2211.5 2217.5 2224.2 2230.0 1972.3 2142.1 2201.1 2209.0 2221.2 7514.5 7582.3 7583.1 7596.1 7702.1 4667.1 4724.2 4745.4 4745.7 4787.2 2905.9 2930.2 2942.5 2967.7 2998.5 908.2 962.4 985.8 1562.4 1566.3 9875.3 9978.9 9981.3 9988.3 10002.9 4102.8 4119.6 4192.8 4204.6 4247.8 8334.4 8344.8 8346.2 8358.4 8358.9 4766.5 4778.0 4778.0 4783.5 4846.4 4432.5 4441.5 4442.2 4467.5 4488.4 3436.9 3448.8 3458.4 3481.6 3491.5 1026.8 1039.9 1041.9 1046.9 1055.3 1318.3 1330.0 1331.3 1333.9 1370.6 7341.3 7362.2 7617.2 7622.5 7625.8 1137.7 1151.2 1153.9 1160.8 1171.2 5591.2 5682.9 5909.3 5957.5 6021.8 8853.2 9018.1 9038.4 9065.3 9096.4 8846.3 9013.5 9077.6 9091.4 9119.4 7299.6 7309.5 7341.7 7363.9 7417.5 7101.6 7197.2 7273.5 7280.4 7286.3 7937.2 8179.1 8220.8 8248.1 8257.5 8161.0 8353.4 8409.6 8470.1 8577.8 6462.2 6545.1 6553.9 6577.2 6632.1 7267.1 7431.4 7482.5 7509.0 7519.9 6880.8 6930.6 7002.7 7038.1 7060.1 6775.6 6811.6 6849.7 6930.7 6962.7 7039.3 7041.7 7043.4 7052.2 7058.9 6339.0 6344.5 6419.9 6424.4 6437.1 6434.7 6494.1 6497.9 6499.5 6534.0 05:29:28 INFO - 2015-11-03 05:29:28,122 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,122 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5248.68 Median:5928.39 stddev:1589.64 (26.8%) stddev-sans-first:1549.93 05:29:28 INFO - 2015-11-03 05:29:28,123 DEBUG : BROWSER_OUTPUT: Values: 290.6 300.3 321.6 326.8 330.8 5818.7 5908.2 6025.8 6053.7 6072.2 5876.6 5888.9 5913.7 5974.2 5982.6 4463.8 4620.0 4687.2 4705.6 4742.3 4580.0 4650.2 4674.0 4712.7 4735.1 4646.0 4648.9 4665.3 4676.5 4693.8 4439.9 4481.7 4605.6 4677.2 4696.8 3976.7 4023.1 4040.1 4049.0 4049.5 5730.3 5806.0 5809.7 5819.3 5830.7 5136.3 5145.5 5155.4 5167.9 5198.9 6123.0 6188.4 6251.4 6277.9 6283.7 4223.2 4229.7 4241.6 4252.3 4266.8 6430.5 6447.2 6458.4 6528.7 6543.1 4152.3 4250.4 4299.5 4317.2 4320.1 4334.2 4336.7 4338.8 4378.3 4394.8 5062.6 5063.9 5096.7 5099.0 5101.1 6221.8 6223.1 6275.9 6304.7 6305.5 1522.2 1558.8 1582.2 1583.2 1590.7 1003.4 1008.7 1020.8 1021.4 1023.0 5838.3 5850.3 5915.6 5926.4 5935.2 6411.0 6429.3 6488.0 6488.8 6502.3 5907.0 5914.9 5930.3 5975.8 5986.3 3381.7 3472.5 3540.5 3624.3 3643.3 6531.1 6540.1 6599.0 6631.0 6648.8 6666.9 6684.3 6717.8 6754.5 6785.4 6352.5 6495.8 6563.3 6573.6 6715.5 6562.1 6575.4 6642.1 6650.5 6666.4 6410.4 6440.7 6488.8 6502.9 6508.8 6495.9 6629.4 6632.7 6681.8 6693.9 4355.5 4368.6 4385.6 4388.7 4400.6 6542.8 6584.9 6606.4 6611.2 6621.7 6242.5 6307.4 6335.5 6342.2 6416.2 6299.7 6318.4 6350.7 6368.5 6394.1 6219.9 6229.2 6230.5 6246.1 6270.2 6062.7 6226.3 6251.5 6341.8 6428.4 6026.1 6109.8 6145.2 6168.0 6199.2 05:29:28 INFO - 2015-11-03 05:29:28,123 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,123 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13433.47 Median:24476.83 stddev:16372.00 (66.9%) stddev-sans-first:16389.85 05:29:28 INFO - 2015-11-03 05:29:28,124 DEBUG : BROWSER_OUTPUT: Values: 665.3 687.3 713.0 762.9 769.3 13222.5 13500.7 13551.6 13719.0 14317.7 12532.4 12596.7 12639.1 12692.6 12767.0 691.8 710.1 859.1 876.2 897.7 877.3 882.0 890.1 892.0 892.5 744.8 928.0 931.5 932.2 932.7 750.2 897.1 913.6 914.0 914.3 681.8 682.8 683.2 683.8 684.5 13520.1 13679.7 13723.6 13834.9 13879.9 11379.8 11419.7 11583.5 11749.1 11874.9 9362.8 9450.3 9469.6 9502.3 10062.3 3257.2 3290.2 3318.8 3342.3 3484.3 47105.5 47517.8 47607.0 47783.5 47982.5 8761.4 8876.6 8952.7 9034.2 9042.9 11884.1 19357.1 19370.2 19375.0 19408.0 6223.2 6370.0 6435.4 6490.7 6511.8 3709.7 3728.4 3748.9 3793.7 3842.8 2848.5 2882.0 2882.9 2888.1 2899.5 423.2 427.8 428.3 431.4 482.2 416.1 458.6 502.2 537.3 595.6 7028.2 7653.5 7680.1 7703.7 7757.7 566.6 576.3 596.2 598.4 609.3 3528.5 3572.1 3588.3 3617.4 3674.9 60024.7 60082.1 60315.4 60531.7 60584.7 48535.5 49204.5 49364.8 49597.8 49704.8 47314.8 47331.3 47391.8 47926.3 48147.0 7787.3 7847.0 7919.8 8014.7 8168.9 34949.5 34994.8 35549.6 35698.6 35914.6 43854.6 45347.8 48080.8 48471.5 49065.3 7006.5 7109.4 7155.7 7158.2 7167.4 10552.5 10808.4 10854.7 11599.5 11860.8 10390.0 10525.6 10529.9 10543.6 10601.9 10035.7 10245.9 10370.4 10507.2 10722.6 10143.5 10155.3 10164.9 10668.1 11087.7 8043.3 8250.4 8300.7 8420.4 8739.5 8182.0 8461.3 8570.8 8639.8 8894.7 05:29:28 INFO - 2015-11-03 05:29:28,124 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:28 INFO - 2015-11-03 05:29:28,124 DEBUG : BROWSER_OUTPUT: 05:29:28 INFO - 2015-11-03 05:29:28,800 INFO : Browser exited with error code: 0 05:29:28 INFO - 2015-11-03 05:29:28,827 INFO : Completed test dromaeo_css (00:18:33) 05:29:28 INFO - 2015-11-03 05:29:28,827 INFO : Starting test kraken 05:29:28 INFO - 2015-11-03 05:29:28,827 DEBUG : operating with platform_type : mac_ 05:29:28 INFO - 2015-11-03 05:29:28,828 INFO : Initialising browser for kraken test... 05:29:28 INFO - 2015-11-03 05:29:28,843 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpkRS8gd/profile http://localhost:49494/getInfo.html 05:29:30 INFO - 2015-11-03 05:29:30,991 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:30 INFO - 2015-11-03 05:29:30,991 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:30 INFO - 2015-11-03 05:29:30,991 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:29:30 INFO - 2015-11-03 05:29:30,991 DEBUG : BROWSER_OUTPUT: __metrics 05:29:31 INFO - 2015-11-03 05:29:31,007 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:31 INFO - 2015-11-03 05:29:31,640 INFO : Browser initialized. 05:29:31 INFO - 2015-11-03 05:29:31,640 INFO : Running cycle 1/1 for kraken test... 05:29:31 INFO - 2015-11-03 05:29:31,640 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpkRS8gd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:43 INFO - 2015-11-03 05:29:43,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 221966336 05:29:43 INFO - 2015-11-03 05:29:43,497 DEBUG : BROWSER_OUTPUT: 05:29:46 INFO - 2015-11-03 05:29:46,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:46 INFO - 2015-11-03 05:29:46,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 277704704 05:29:46 INFO - 2015-11-03 05:29:46,647 DEBUG : BROWSER_OUTPUT: 05:29:49 INFO - 2015-11-03 05:29:49,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-dft) 05:29:49 INFO - 2015-11-03 05:29:49,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 291184640 05:29:49 INFO - 2015-11-03 05:29:49,870 DEBUG : BROWSER_OUTPUT: 05:29:52 INFO - 2015-11-03 05:29:52,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-fft) 05:29:53 INFO - 2015-11-03 05:29:53,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 274481152 05:29:53 INFO - 2015-11-03 05:29:53,430 DEBUG : BROWSER_OUTPUT: 05:29:55 INFO - 2015-11-03 05:29:55,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-oscillator) 05:29:56 INFO - 2015-11-03 05:29:56,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 276692992 05:29:56 INFO - 2015-11-03 05:29:56,057 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-03 05:29:58,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:58 INFO - 2015-11-03 05:29:58,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 276553728 05:29:58 INFO - 2015-11-03 05:29:58,829 DEBUG : BROWSER_OUTPUT: 05:30:01 INFO - 2015-11-03 05:30:01,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49494/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:02 INFO - 2015-11-03 05:30:02,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 278364160 05:30:02 INFO - 2015-11-03 05:30:02,441 DEBUG : BROWSER_OUTPUT: 05:30:05 INFO - 2015-11-03 05:30:05,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49494/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:06 INFO - 2015-11-03 05:30:06,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 278237184 05:30:06 INFO - 2015-11-03 05:30:06,139 DEBUG : BROWSER_OUTPUT: 05:30:08 INFO - 2015-11-03 05:30:08,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49494/tests/kraken/driver.html?testName=json-parse-financial) 05:30:09 INFO - 2015-11-03 05:30:09,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 279384064 05:30:09 INFO - 2015-11-03 05:30:09,579 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-03 05:30:11,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:11 INFO - 2015-11-03 05:30:11,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 312705024 05:30:11 INFO - 2015-11-03 05:30:11,710 DEBUG : BROWSER_OUTPUT: 05:30:13 INFO - 2015-11-03 05:30:13,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:14 INFO - 2015-11-03 05:30:14,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 313634816 05:30:14 INFO - 2015-11-03 05:30:14,148 DEBUG : BROWSER_OUTPUT: 05:30:16 INFO - 2015-11-03 05:30:16,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:16 INFO - 2015-11-03 05:30:16,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 321114112 05:30:16 INFO - 2015-11-03 05:30:16,813 DEBUG : BROWSER_OUTPUT: 05:30:19 INFO - 2015-11-03 05:30:19,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:19 INFO - 2015-11-03 05:30:19,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 321175552 05:30:19 INFO - 2015-11-03 05:30:19,933 DEBUG : BROWSER_OUTPUT: 05:30:22 INFO - 2015-11-03 05:30:22,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:23 INFO - 2015-11-03 05:30:23,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 321286144 05:30:23 INFO - 2015-11-03 05:30:23,141 DEBUG : BROWSER_OUTPUT: 05:30:24 INFO - 2015-11-03 05:30:24,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49494/tests/kraken/driver.html?testName=ai-astar) 05:30:25 INFO - 2015-11-03 05:30:25,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 380989440 05:30:25 INFO - 2015-11-03 05:30:25,116 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,116 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:25 INFO - 2015-11-03 05:30:25,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:25 INFO - 2015-11-03 05:30:25,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:25 INFO - 2015-11-03 05:30:25,116 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:25 INFO - 2015-11-03 05:30:25,116 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;107;104;109;109;107;97;108;105;107 05:30:25 INFO - 2015-11-03 05:30:25,117 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;150;162;128;149;148;126;165;126 05:30:25 INFO - 2015-11-03 05:30:25,117 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;162;163;163;163;162;163;160 05:30:25 INFO - 2015-11-03 05:30:25,117 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;82;88;85;69;70;72;79;81;71 05:30:25 INFO - 2015-11-03 05:30:25,117 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;98;138;89;90;90;130;89;88;135 05:30:25 INFO - 2015-11-03 05:30:25,117 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;115;114;120;114;120;120;115;120;115 05:30:25 INFO - 2015-11-03 05:30:25,118 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;125;124;124;125;125;125;124;125;126 05:30:25 INFO - 2015-11-03 05:30:25,118 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;99;100;101;100;100;101;101;100;98 05:30:25 INFO - 2015-11-03 05:30:25,118 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;58;57;58;58;58;65;56;56 05:30:25 INFO - 2015-11-03 05:30:25,118 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;66;69;67;67;67;68;67;68 05:30:25 INFO - 2015-11-03 05:30:25,118 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;85;87;86;85;86;87;88;88 05:30:25 INFO - 2015-11-03 05:30:25,119 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;120;122;129;130;123;123;124;124;121 05:30:25 INFO - 2015-11-03 05:30:25,119 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;157;151;149;151;154;151;151;151;149;149 05:30:25 INFO - 2015-11-03 05:30:25,119 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;72;70;71;69;69;70;69;70 05:30:25 INFO - 2015-11-03 05:30:25,119 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:25 INFO - 2015-11-03 05:30:25,119 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: __startTimestamp1446557425111__endTimestamp 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,120 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.10 Median:108.00 stddev:3.57 (3.3%) stddev-sans-first:3.72 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: Values: 108.0 107.0 104.0 109.0 109.0 107.0 97.0 108.0 105.0 107.0 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:149.50 stddev:15.22 (10.2%) stddev-sans-first:15.52 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 150.0 162.0 128.0 149.0 148.0 126.0 165.0 126.0 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.12 05:30:25 INFO - 2015-11-03 05:30:25,121 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 162.0 163.0 163.0 163.0 162.0 163.0 160.0 05:30:25 INFO - 2015-11-03 05:30:25,122 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,122 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.30 Median:81.50 stddev:7.21 (8.8%) stddev-sans-first:7.09 05:30:25 INFO - 2015-11-03 05:30:25,122 DEBUG : BROWSER_OUTPUT: Values: 86.0 82.0 88.0 85.0 69.0 70.0 72.0 79.0 81.0 71.0 05:30:25 INFO - 2015-11-03 05:30:25,122 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,122 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:89.00 stddev:20.92 (23.5%) stddev-sans-first:22.12 05:30:25 INFO - 2015-11-03 05:30:25,122 DEBUG : BROWSER_OUTPUT: Values: 100.0 98.0 138.0 89.0 90.0 90.0 130.0 89.0 88.0 135.0 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:120.00 stddev:2.99 (2.5%) stddev-sans-first:2.87 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: Values: 121.0 115.0 114.0 120.0 114.0 120.0 120.0 115.0 120.0 115.0 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.70 Median:125.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: Values: 124.0 125.0 124.0 124.0 125.0 125.0 125.0 124.0 125.0 126.0 05:30:25 INFO - 2015-11-03 05:30:25,123 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,125 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.00 Median:101.00 stddev:0.94 (0.9%) stddev-sans-first:1.00 05:30:25 INFO - 2015-11-03 05:30:25,125 DEBUG : BROWSER_OUTPUT: Values: 100.0 99.0 100.0 101.0 100.0 100.0 101.0 101.0 100.0 98.0 05:30:25 INFO - 2015-11-03 05:30:25,125 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,125 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.56 (4.4%) stddev-sans-first:2.71 05:30:25 INFO - 2015-11-03 05:30:25,125 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 58.0 57.0 58.0 58.0 58.0 65.0 56.0 56.0 05:30:25 INFO - 2015-11-03 05:30:25,125 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 69.0 67.0 67.0 67.0 68.0 67.0 68.0 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.08 (1.2%) stddev-sans-first:1.13 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 85.0 87.0 86.0 85.0 86.0 87.0 88.0 88.0 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,126 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:3.21 (2.6%) stddev-sans-first:3.39 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: Values: 125.0 120.0 122.0 129.0 130.0 123.0 123.0 124.0 124.0 121.0 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:151.00 stddev:2.50 (1.7%) stddev-sans-first:1.58 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: Values: 157.0 151.0 149.0 151.0 154.0 151.0 151.0 151.0 149.0 149.0 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 72.0 70.0 71.0 69.0 69.0 70.0 69.0 70.0 05:30:25 INFO - 2015-11-03 05:30:25,127 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:25 INFO - 2015-11-03 05:30:25,128 DEBUG : BROWSER_OUTPUT: 05:30:25 INFO - 2015-11-03 05:30:25,776 INFO : Browser exited with error code: 0 05:30:25 INFO - 2015-11-03 05:30:25,824 INFO : Completed test kraken (00:00:56) 05:30:25 INFO - 2015-11-03 05:30:25,824 INFO : Starting test v8_7 05:30:25 INFO - 2015-11-03 05:30:25,824 DEBUG : operating with platform_type : mac_ 05:30:25 INFO - 2015-11-03 05:30:25,824 INFO : Initialising browser for v8_7 test... 05:30:25 INFO - 2015-11-03 05:30:25,840 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmp5XyUlW/profile http://localhost:49494/getInfo.html 05:30:27 INFO - 2015-11-03 05:30:27,952 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:27 INFO - 2015-11-03 05:30:27,952 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:27 INFO - 2015-11-03 05:30:27,952 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:30:27 INFO - 2015-11-03 05:30:27,952 DEBUG : BROWSER_OUTPUT: __metrics 05:30:27 INFO - 2015-11-03 05:30:27,971 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:28 INFO - 2015-11-03 05:30:28,620 INFO : Browser initialized. 05:30:28 INFO - 2015-11-03 05:30:28,620 INFO : Running cycle 1/1 for v8_7 test... 05:30:28 INFO - 2015-11-03 05:30:28,620 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmp5XyUlW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:40 INFO - 2015-11-03 05:30:40,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 221138944 05:30:40 INFO - 2015-11-03 05:30:40,424 DEBUG : BROWSER_OUTPUT: 05:31:01 INFO - 2015-11-03 05:31:01,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49494/tests/v8_7/run.html (next: http://localhost:49494/tests/v8_7/run.html) 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 592199680 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:02 INFO - 2015-11-03 05:31:02,209 DEBUG : BROWSER_OUTPUT: |0;Richards;166.61112962345885 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.3143294432753 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.2032520325203 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5764.367816091954 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2055.441478439425 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |5;Earley;909.0909090909091 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |6;Boyer;13621.621621621622 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |7;RegExp;29514.285714285714 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |8;Splay;2044.9897750511248 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5865.497076023392 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1446557462207__endTimestamp 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,210 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: Values: 166.6 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.31 Median:191.31 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: Values: 191.3 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.20 Median:325.20 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: Values: 325.2 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5764.37 Median:5764.37 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,211 DEBUG : BROWSER_OUTPUT: Values: 5764.4 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2055.44 Median:2055.44 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: Values: 2055.4 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:909.09 Median:909.09 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: Values: 909.1 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13621.62 Median:13621.62 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: Values: 13621.6 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,212 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29514.29 Median:29514.29 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: Values: 29514.3 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:2044.99 Median:2044.99 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: Values: 2045.0 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5865.50 Median:5865.50 stddev:0.00 (0.0%) 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: Values: 5865.5 05:31:02 INFO - 2015-11-03 05:31:02,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:02 INFO - 2015-11-03 05:31:02,214 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-03 05:31:02,886 INFO : Browser exited with error code: 0 05:31:02 INFO - 2015-11-03 05:31:02,905 INFO : Completed test v8_7 (00:00:37) 05:31:03 INFO - 2015-11-03 05:31:03,259 INFO : Completed test suite (00:20:08) 05:31:03 INFO - 2015-11-03 05:31:03,259 DEBUG : Working with test: dromaeo_css 05:31:03 INFO - 2015-11-03 05:31:03,259 DEBUG : Generating results file: dromaeo_css 05:31:03 INFO - 2015-11-03 05:31:03,260 DEBUG : Working with test: kraken 05:31:03 INFO - 2015-11-03 05:31:03,260 DEBUG : Generating results file: kraken 05:31:03 INFO - 2015-11-03 05:31:03,260 INFO : javascript benchmark 05:31:03 INFO - 2015-11-03 05:31:03,260 DEBUG : Working with test: v8_7 05:31:03 INFO - 2015-11-03 05:31:03,260 DEBUG : Generating results file: v8_7 05:31:03 INFO - 2015-11-03 05:31:03,261 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:03 INFO - 2015-11-03 05:31:03,319 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 05:31:03 INFO - 2015-11-03 05:31:03,320 DEBUG : process_Request line: dromaeo_css 6889.00 graph.html#tests=[[72,64,55]] 05:31:03 INFO - 2015-11-03 05:31:03,320 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:03 INFO - 2015-11-03 05:31:03,352 DEBUG : process_Request line: kraken 1494.00 graph.html#tests=[[232,64,55]] 05:31:03 INFO - 2015-11-03 05:31:03,352 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:03 INFO - 2015-11-03 05:31:03,389 DEBUG : process_Request line: v8_7 16103.99 graph.html#tests=[[230,64,55]] 05:31:03 INFO - 2015-11-03 05:31:03,390 INFO : javascript benchmark 05:31:03 INFO - 2015-11-03 05:31:03,391 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [333.4797715563721, 338.07634559357257, 339.40942759598306, 344.14480017157365, 349.9728297446993, 13991.580252592414, 14518.927405362985, 17007.31970721171, 17755.911220443897, 19196.808031919678, 14170.0, 15428.845711542881, 17896.463106106807, 17939.820601793977, 18868.90565547174, 5295.576353891689, 5439.673619582818, 5506.0, 5513.2005859150395, 5526.143447765603, 3890.1247219375555, 4017.2969730297227, 4394.0, 5963.105534169866, 5991.2510936132985, 5681.744321505522, 5804.912926306109, 5852.0, 5864.970675146639, 5872.148538461921, 5664.54683625309, 5801.100829371412, 5851.356350801409, 5852.092925596518, 5856.121581762727, 4973.850784476472, 4997.275395067732, 5005.599552035828, 5039.974800126012, 5060.342155519796, 20163.79836201634, 20862.16551337945, 20949.581008379748, 21397.893010534848, 21616.135354585796, 1885.7359969604267, 1950.8439324853978, 2000.3598848368529, 2091.989540052305, 2097.6538871086254, 12477.875221247763, 12636.2418254905, 13093.738125237538, 13313.800292995613, 13518.932405338008, 1587.4920025591816, 1629.8451647093507, 1643.318023020445, 1660.5848537865534, 1676.924538395775, 56499.43500565024, 58287.12569311421, 58578.12132818011, 59340.10989835199, 59386.40613593852, 9515.096065873731, 9581.329306948446, 9584.808303833885, 9712.514374281258, 9771.316007879523, 11790.764184716258, 11794.705132371588, 11815.468303926344, 11820.94089529564, 11944.104192185621, 7537.9623101884135, 7580.924190758022, 7655.655495502716, 7667.118281397599, 7792.259735325135, 7448.553086814808, 7498.775036748906, 7518.812029699301, 7561.546307221474, 7564.659590318449, 5634.070378387521, 5677.659340439587, 5679.886402271932, 5734.569907256889, 5755.0, 1543.9536813895602, 1598.3446786817349, 1603.0782300177445, 1617.5956010997252, 1653.4378311374192, 829.4815740162398, 882.2765332427348, 990.7919336939179, 1018.1803648063232, 1086.4241951765578, 18377.356792512197, 18524.722129168073, 18571.0, 18664.253429862652, 18868.245270189313, 811.7158994351929, 907.4691305586174, 922.2253307221831, 943.9528023598792, 1021.875936469892, 10044.29689921713, 10243.795124097476, 10258.384496930208, 10283.94858025705, 10304.0, 515565.0, 527788.0, 538299.0, 538418.0, 548149.0, 66438.66780666163, 68068.31931680719, 68696.0, 69692.65153674199, 69734.65132674304, 1097.8188598881254, 1106.4965440724452, 1121.4616983847798, 1127.7237076916208, 1140.880207578209, 15936.20318984023, 15974.8402515978, 16013.119278439332, 16027.599310017344, 16233.107179105262, 30504.389912201186, 31022.37955240928, 31106.22234444157, 31202.0, 31538.526922096647, 44218.557814421445, 44522.3321650169, 44704.32943505785, 44881.55118448774, 45063.32405013993, 8886.555672216493, 8934.687285944961, 9000.459972401677, 9002.414843035182, 9006.36955413141, 17504.387346442814, 17556.473305800337, 17995.2801887923, 18049.0, 18107.09464526795, 13997.440102396198, 14058.297085145907, 14482.420703171754, 14615.707685846437, 14632.70734585281, 13929.442822286996, 14041.5085472008, 14071.859281407054, 14351.784723228951, 14710.19093949843, 11782.764344713229, 14689.70620587561, 14911.0, 15233.847661523687, 15311.310991005208, 7517.210692877388, 7597.467177762146, 7836.216378362346, 7869.960650196941, 9076.0, 14398.784018239525, 14633.780493292395, 14643.194624295766, 14876.330565124812, 14924.552263432115], "dojo.html": [3228.209088773251, 3256.6906143916335, 3267.5262086997395, 3301.570795796546, 3313.072339744871, 5162.354705661793, 5285.6300058995885, 5463.071277882759, 5479.890402191959, 5493.011257973563, 5329.600279979008, 5338.62629615927, 5358.410574836765, 5378.784848606051, 5464.644798088121, 4941.431735350445, 4966.379202599675, 4981.576565991895, 4999.650024498286, 5028.207380062815, 5024.974875125619, 5096.337476128117, 5104.489551044903, 5105.106606343894, 5187.844364669066, 4858.854234372974, 4891.755412229374, 4984.750762461862, 5000.249962505617, 5083.364579427572, 5030.597552195815, 5045.596352291845, 5055.51972562606, 5061.519155680205, 5097.515736005073, 4995.250712393134, 5005.57452616528, 5015.774290156915, 5026.874328141789, 5030.396352437694, 5174.715390653512, 5176.818811341623, 5284.81503147388, 5310.840674779763, 5342.652727572734, 5686.886262274773, 5687.971560142173, 5690.0, 5698.8290351289115, 5766.682832444214, 5758.481736643722, 5771.422857714237, 5775.711214439261, 5777.393373695743, 5793.971030144864, 5245.816396426107, 5278.947210527922, 5353.9732301338245, 5374.27447294618, 5439.265699130607, 5874.118882167623, 5887.528997680175, 5888.087346461305, 5910.734016969247, 5911.379305172981, 5624.268845050199, 5630.380658127603, 5638.689872057076, 5655.575831812631, 5671.773129074873, 5533.0, 5639.971800141055, 5645.802396916089, 5679.488846003879, 5765.1640512125505, 5690.2033715279895, 5691.601587888891, 5704.3154821421695, 5710.514606258432, 5756.42435756421, 5674.546036317085, 5686.687232202268, 5687.175359572839, 5691.658500489983, 5691.9146212806845, 4316.503602085801, 4430.822767089345, 4446.488653804854, 4449.310356894686, 4480.484744254387, 4086.7139300248696, 4110.05468742191, 4120.196561670446, 4126.319157339006, 4126.896827579335, 5226.372835259793, 5269.420363759983, 5277.9472205278225, 5303.840884773463, 5312.335958005249, 5563.860903477445, 5581.581381396411, 5586.35756887955, 5589.413111623221, 5893.2928048633585, 5166.483351664879, 5169.302144210484, 5191.2472691459525, 5215.452377500384, 5244.475552444801, 4938.456769755324, 4984.27727979441, 5021.673591216632, 5040.092783299041, 5048.62135339851, 5773.6824474654295, 5782.508486778671, 5790.247267855152, 5795.362510123883, 5842.824715258549, 5705.400932902152, 5735.655860648374, 5746.0, 5759.65442073477, 5768.105943578752, 5578.804741834017, 5687.488126068673, 5702.372738998624, 5709.857253568694, 5742.626729262584, 5706.087026075808, 5711.600187986801, 5719.170720245625, 5723.971380143073, 5725.312962444534, 5823.970880145572, 5826.213461182856, 5837.0, 5837.708114594168, 5839.883202336015, 5245.763940622604, 5355.571554275726, 5374.140137577969, 5515.117581186991, 5629.408912064175, 5586.301712285965, 5591.384947655673, 5602.047651899268, 5607.691576963306, 5683.658980461186, 5485.4788795064405, 5498.835034948958, 5515.751791169327, 5517.558595312285, 5521.723913804374, 5459.2629994950175, 5462.91805622908, 5568.470995255444, 5611.971940140274, 5633.324001119892, 5494.670319780666, 5500.752466138953, 5528.004959107399, 5542.140968149944, 5595.832125036255], "mootools.html": [1389.944402223911, 1729.6021914959558, 1828.5680342151118, 1829.1316108014405, 1846.806085361037, 7085.929140708591, 7152.570845749258, 7387.667554960026, 7791.610419479025, 7817.452778305514, 7321.231270716578, 7341.926580734191, 7477.476576639638, 7507.887381689279, 7564.092308922924, 2175.0973346061405, 2217.4013016485537, 2217.789310015546, 2224.232639739287, 2228.8439809213282, 2040.459278291254, 2085.405659387075, 2181.9563608727817, 2229.6766968789516, 2230.0, 2167.035669127239, 2180.8364372672036, 2181.803637672609, 2189.6168170570168, 2193.7915897989665, 1979.1094007696595, 2211.535577528713, 2217.4899773052125, 2224.1992882562345, 2230.029936977412, 1972.3491247888162, 2142.1003178664996, 2201.1085510368325, 2208.977910220893, 2221.2225720997685, 7514.54912705234, 7582.317591416744, 7583.090029196476, 7596.08846938371, 7702.114256860421, 4667.13657973276, 4724.196886529264, 4745.3593764842, 4745.715257084586, 4787.234042553175, 2905.8547072646284, 2930.238138084092, 2942.4703553360387, 2967.6883927187764, 2998.5202367621296, 908.2416182487631, 962.4321650226331, 985.7781999050228, 1562.3828587707792, 1566.3343079191297, 9875.308728389016, 9978.850317245247, 9981.25140614464, 9988.250881183867, 10002.949985250027, 4102.774347410921, 4119.649829764444, 4192.832286708497, 4204.600562946515, 4247.830086796494, 8334.374921880883, 8344.83310333802, 8346.165383461605, 8358.414910956175, 8358.916410835815, 4766.451858036301, 4777.95222047775, 4778.0, 4783.521647835189, 4846.36997190363, 4432.49026361966, 4441.511433742286, 4442.222611043055, 4467.463904331501, 4488.4165058542185, 3436.9484457733156, 3448.8448019839166, 3458.429359155711, 3481.56480439945, 3491.4762785582366, 1026.8049070676548, 1039.9376037437778, 1041.8541404203418, 1046.863907691995, 1055.3140458701905, 1318.3408295852073, 1330.042369493982, 1331.3010669398643, 1333.926634035118, 1370.6093763277418, 7341.3392794648735, 7362.226966168582, 7617.238276172338, 7622.5045372051745, 7625.771226863203, 1137.7496950670838, 1151.1826603111717, 1153.9076873850072, 1160.8316794064813, 1171.2035815645443, 5591.245181900473, 5682.914756278659, 5909.261342332208, 5957.523398128139, 6021.849453763603, 8853.15894989975, 9018.09819018093, 9038.412503187403, 9065.274778017743, 9096.408733432305, 8846.292296616255, 9013.504257265782, 9077.591508382138, 9091.36360454775, 9119.361644684808, 7299.59852208123, 7309.488335816548, 7341.669624866894, 7363.926360736431, 7417.480776345604, 7101.644917753988, 7197.244289349543, 7273.454490913308, 7280.381167600814, 7286.344229019413, 7937.206279372017, 8179.141190174946, 8220.83558328842, 8248.13394593583, 8257.463264887763, 8161.0, 8353.373496987871, 8409.62156702962, 8470.068292487698, 8577.82844343122, 6462.192225971754, 6545.14913061318, 6553.901691474727, 6577.210734711865, 6632.071509988702, 7267.0552828132, 7431.4054875608745, 7482.476226664299, 7509.023826902686, 7519.887201692089, 6880.759173428906, 6930.61881596517, 7002.719891204295, 7038.085048943809, 7060.117485314336, 6775.627340496123, 6811.557248778813, 6849.691763870737, 6930.7227710891, 6962.651867406508, 7039.260877607982, 7041.718331266692, 7043.401310888426, 7052.18899826506, 7058.929410706032, 6339.049142628643, 6344.460720838596, 6419.871602568016, 6424.421802037652, 6437.066625339393, 6434.742610295536, 6494.1232933553365, 6497.870042599027, 6499.545031847914, 6534.0], "ext.html": [500.6020213929925, 528.281537109531, 540.0225591679061, 544.5725105791954, 558.1599692462847, 31700.52449213261, 32510.187245318877, 32525.349493010184, 32728.836355818217, 39503.209935801264, 43494.34758478625, 44070.77964610173, 44122.7793861031, 44238.11523769522, 44558.10883782322, 9107.316951228668, 9288.349815512884, 9291.48896810675, 9311.255099592016, 9418.952905235465, 8438.493690378566, 8633.69782057628, 9104.271658267357, 11259.493322800452, 11315.717107072307, 11117.055050320732, 11121.610743623974, 11146.777064458705, 11171.553137874474, 11293.0, 8381.245687888058, 11092.33445993243, 11152.721181970435, 11186.552537898515, 11248.325100493996, 8283.08886022537, 10994.450277486174, 11207.887921120848, 11238.438078096062, 11382.658520244406, 39903.60096399057, 39910.20179596392, 39969.0, 39984.80007599943, 40475.0, 2919.44530539199, 3000.3999200160056, 3052.0494112835963, 3422.19578399076, 3569.1790888095625, 27345.86327068372, 27355.589666155025, 27982.580261296098, 28171.29571760702, 28175.295617609725, 2374.169040835711, 2424.260600516859, 2430.1615942499984, 2475.4306509502917, 2553.8340007899615, 283936.0, 284147.0, 284809.0, 285519.0, 286472.0, 54965.450345496836, 56171.71914140403, 60296.39703602908, 60547.0, 60873.695631522445, 60436.0, 61451.0, 61534.38465615376, 61613.0, 62244.37755622476, 16368.0, 16625.168741562873, 16630.0, 16657.750133748003, 16663.16684165787, 12644.114911956258, 12713.046521510923, 12721.173123746927, 12733.045021623415, 12735.108542401942, 19129.426117216506, 19167.0, 19192.13635386411, 19200.231990720495, 19245.615087698166, 8137.8372432552205, 8351.123132071167, 8379.62291696875, 8397.328213742885, 8398.958005209935, 938.7090002099371, 997.6957028106352, 1007.9143272821892, 1031.6801791444677, 1115.3976852499559, 28086.578701319497, 28136.71863281382, 28150.71849281522, 28182.43635127286, 28420.43159136847, 1050.9159267258601, 1052.5000624703357, 1082.3181395720803, 1102.9687242428195, 1154.924929879555, 14438.783418248735, 14468.157367682372, 14575.271236438348, 14731.926340368229, 14732.484363047242, 322317.0, 330158.0, 330272.0, 330353.0, 330754.0, 54055.72972135193, 54088.0, 54130.18804717933, 54405.72797135989, 54746.43042834885, 1377.937992790327, 1387.0775934003975, 1406.8382136054486, 1410.168000879486, 1412.7386433509835, 27308.453830923667, 28131.296717582223, 28132.85933570319, 28344.574831377133, 29033.274168145967, 45688.771556142005, 47195.764021179675, 47242.76378618085, 47395.76302118467, 47878.5212147888, 239480.0, 296875.0, 302857.0, 303395.0, 304185.0, 28504.857475712488, 29070.27324316909, 29082.27294317659, 29414.852925735235, 29441.85279073591, 39795.40306895457, 40278.0, 40338.0, 40338.798306009456, 41292.587074128875, 34172.48741268933, 34599.13502162466, 34991.475127872596, 35104.47343289904, 35285.64714352926, 33170.5024424629, 33471.330573388885, 33538.0, 33773.15567110842, 34917.650823492455, 33094.5035824458, 33148.86192640145, 33501.0, 33539.83230083931, 33856.322873541896, 27713.722862771116, 29910.102696919126, 29931.102066938027, 30008.3998320028, 30067.0, 22445.32664020082, 22770.886145569828, 22970.425739355982, 22989.770102298764, 23787.881060594587], "prototype.html": [290.5844642161709, 300.25686426095416, 321.6494021516548, 326.78268951147476, 330.83788943417704, 5818.709064546777, 5908.172855800191, 6025.849353766158, 6053.727582258798, 6072.180255665484, 5876.618019828708, 5888.852778680524, 5913.73388197531, 5974.223350964368, 5982.61113027654, 4463.754493502856, 4620.0, 4687.203175460163, 4705.552972467619, 4742.33607294979, 4580.038191979688, 4650.209464391061, 4673.976630116845, 4712.656892785557, 4735.124002059612, 4645.953540464603, 4648.930266046012, 4665.253559430492, 4676.532346765331, 4693.765311734417, 4439.933400998988, 4481.708688935209, 4605.585497305258, 4677.228257337535, 4696.835610753641, 3976.7415118017525, 4023.054582173187, 4040.0505881117915, 4048.9797551012352, 4049.493813273341, 5730.312362516483, 5806.0, 5809.738561764731, 5819.330776960662, 5830.708464576796, 5136.332276804029, 5145.511176438233, 5155.381354237478, 5167.948320516784, 5198.870028249286, 6122.96938515309, 6188.381161883821, 6251.4061164189325, 6277.87444251117, 6283.654399008053, 4223.176480586287, 4229.70392072555, 4241.618254357123, 4252.277112890816, 4266.786660666985, 6430.453411460032, 6447.161868957052, 6458.354164583504, 6528.738850445977, 6543.149390579242, 4152.2525945330135, 4250.3836943643, 4299.462567179103, 4317.244482215599, 4320.135972805451, 4334.241507736134, 4336.739795612273, 4338.848140315074, 4378.343248512749, 4394.802233899482, 5062.620303477254, 5063.898722025612, 5096.719680417538, 5098.974505127525, 5101.132807422747, 6221.751129954841, 6223.066540018943, 6275.937240627535, 6304.684765761694, 6305.527085468517, 1522.1856306875989, 1558.75059990401, 1582.2168026826794, 1583.200483755696, 1590.721623715845, 1003.4481035430484, 1008.6873069348526, 1020.7601213714771, 1021.402479549457, 1022.9590816367262, 5838.299404071538, 5850.268716410449, 5915.645061296336, 5926.4369884861735, 5935.228420305332, 6411.0, 6429.260635027032, 6488.0, 6488.772892948724, 6502.252240992347, 5907.025340818716, 5914.8817023659285, 5930.347661757203, 5975.7609695612555, 5986.311574168939, 3381.7125544328514, 3472.5138480612736, 3540.539729835105, 3624.3294990426857, 3643.3259846928404, 6531.11829902957, 6540.149780528501, 6599.0, 6630.9668451657435, 6648.833779155463, 6666.899996500057, 6684.2981486944145, 6717.832054198684, 6754.493412994045, 6785.42323902464, 6352.4918006559365, 6495.837604059841, 6563.343665633494, 6573.638449885207, 6715.4963377747845, 6562.146920900253, 6575.4410875076155, 6642.136522252076, 6650.501212409185, 6666.433353165035, 6410.391012853772, 6440.710168042356, 6488.837779055561, 6502.869942601216, 6508.837279068061, 6495.935040649722, 6629.403353698191, 6632.668366581748, 6681.76613818514, 6693.933060669331, 4355.477342718767, 4368.563143685733, 4385.605295523418, 4388.670849686222, 4400.62594679443, 6542.83642908912, 6584.868302634016, 6606.372394622503, 6611.239707433514, 6621.668916554249, 6242.53181011435, 6307.36926307384, 6335.524835637438, 6342.23893132827, 6416.197975253093, 6299.685015749286, 6318.431341179132, 6350.7142178603, 6368.522360822864, 6394.072859435449, 6219.906701399573, 6229.190205273286, 6230.470410015199, 6246.063090536456, 6270.216222972129, 6062.696865156637, 6226.346233645402, 6251.46862516673, 6341.778037768656, 6428.4214420702365, 6026.126211699191, 6109.75560977556, 6145.170401995673, 6168.0, 6199.16311297969], "yui.html": [665.2848188197687, 687.3298533929417, 713.0373995106603, 762.8779395296754, 769.3345256353255, 13222.53721119761, 13500.662483437918, 13551.593452196425, 13719.039667223298, 14317.713645727079, 12532.436040378183, 12596.748065038693, 12639.052071094658, 12692.619221423372, 12767.042471814628, 691.761342336893, 710.0981753173467, 859.1151114352211, 876.1632640827994, 897.6947837735169, 877.3069275272559, 881.9603117859712, 890.0698769785557, 891.9509426981514, 892.4823602310677, 744.8435828476026, 928.0255731481917, 931.4644079654192, 932.2495391210073, 932.6875496708611, 750.1673142811475, 897.0760117079419, 913.5706218077493, 914.0448231597996, 914.3005600715425, 681.8125015620744, 682.7985744205422, 683.1631251716657, 683.770936736194, 684.5447777228137, 13520.12119212248, 13679.658008549766, 13723.588292351245, 13834.861651383559, 13879.930600346934, 11379.772404551863, 11419.657410277705, 11583.478743456564, 11749.060075193964, 11874.881251187464, 9362.765930851716, 9450.33847630666, 9469.573869175834, 9502.334836561444, 10062.345947513388, 3257.1857035741064, 3290.243244053881, 3318.8340582970754, 3342.3148254607745, 3484.3205574912904, 47105.52894471046, 47517.81205469857, 47607.0, 47783.52216477825, 47982.520174798155, 8761.430507017023, 8876.644934202559, 8952.731418057469, 9034.23209027227, 9042.86435703465, 11884.108691848145, 19357.12892919822, 19370.225190992485, 19375.0, 19408.0, 6223.159873417121, 6370.044493325945, 6435.388638079375, 6490.740370385226, 6511.772087976993, 3709.7217708671956, 3728.422094575345, 3748.887533374003, 3793.6585707285926, 3842.7886466244067, 2848.4730324889547, 2882.0489238551227, 2882.8702708378173, 2888.1479963410843, 2899.4635992341487, 423.21916064860284, 427.83742177972795, 428.34035585198444, 431.42189466115553, 482.1538200458173, 416.11783019997796, 458.5574920202021, 502.2466300549176, 537.2961420539107, 595.624756403463, 7028.1917579477995, 7653.540787552764, 7680.116786569504, 7703.653335599912, 7757.68969241224, 566.6005466146357, 576.2681394628798, 596.1981135372916, 598.3687209993499, 609.2780055634088, 3528.523649307362, 3572.1248294168095, 3588.2644057968055, 3617.366960781905, 3674.9448758268645, 60024.69987650121, 60082.09876851851, 60315.39684603186, 60531.69734151301, 60584.697076515215, 48535.51464485381, 49204.50795492071, 49364.75317623389, 49597.75201123971, 49704.75147624239, 47314.76342618334, 47331.290030649565, 47391.763041185266, 47926.28110578344, 48147.0, 7787.332922881229, 7847.0, 7919.802004949923, 8014.675744034164, 8168.877466838121, 34949.47575786416, 34994.82502587471, 35549.644503554635, 35698.643013569534, 35914.64085359113, 43854.561454385046, 45347.773261134804, 48080.759596201795, 48471.51528484811, 49065.26402104043, 7006.5095443320515, 7109.431245500451, 7155.677874835492, 7158.1768096667465, 7167.390771784457, 10552.472376381304, 10808.351498910091, 10854.67435976922, 11599.536018559163, 11860.76278474443, 10390.0, 10525.631602893862, 10529.894701053197, 10543.578256869947, 10601.946990265, 10035.749106272402, 10245.948770256102, 10370.377777333384, 10507.211959103252, 10722.624708135178, 10143.492825358555, 10155.289129761142, 10164.949175254076, 10668.146548275965, 11087.72280692989, 8043.316318113026, 8250.422470427253, 8300.70947516834, 8420.368472364475, 8739.475631462132, 8182.0, 8461.280791132576, 8570.78573035679, 8639.784005399915, 8894.73315800527]}, "summary": {"suite": 6889.00474356586, "subtests": {"jquery.html": {"filtered": 8830.445513032437, "value": 8830.445513032437}, "dojo.html": {"filtered": 5297.516240105597, "value": 5297.516240105597}, "mootools.html": {"filtered": 4448.5106279927795, "value": 4448.5106279927795}, "ext.html": {"filtered": 18450.805253133163, "value": 18450.805253133163}, "prototype.html": {"filtered": 4720.732237530539, "value": 4720.732237530539}, "yui.html": {"filtered": 5896.644573067176, "value": 5896.644573067176}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1446556254, "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": "45.0a1", "id": "20151103031432", "branch": "Fx-Team", "revision": "c10c657afbe1fb64a9ed2e62a399c52c4038c186"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 163.0, 160.0], "ai-astar": [108.0, 107.0, 104.0, 109.0, 109.0, 107.0, 97.0, 108.0, 105.0, 107.0], "imaging-gaussian-blur": [121.0, 115.0, 114.0, 120.0, 114.0, 120.0, 120.0, 115.0, 120.0, 115.0], "audio-beat-detection": [156.0, 130.0, 150.0, 162.0, 128.0, 149.0, 148.0, 126.0, 165.0, 126.0], "json-stringify-tinderbox": [66.0, 65.0, 66.0, 69.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [157.0, 151.0, 149.0, 151.0, 154.0, 151.0, 151.0, 151.0, 149.0, 149.0], "json-parse-financial": [58.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 65.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 72.0, 70.0, 71.0, 69.0, 69.0, 70.0, 69.0, 70.0], "audio-fft": [86.0, 82.0, 88.0, 85.0, 69.0, 70.0, 72.0, 79.0, 81.0, 71.0], "imaging-darkroom": [124.0, 125.0, 124.0, 124.0, 125.0, 125.0, 125.0, 124.0, 125.0, 126.0], "stanford-crypto-ccm": [125.0, 120.0, 122.0, 129.0, 130.0, 123.0, 123.0, 124.0, 124.0, 121.0], "audio-oscillator": [100.0, 98.0, 138.0, 89.0, 90.0, 90.0, 130.0, 89.0, 88.0, 135.0], "stanford-crypto-aes": [86.0, 87.0, 85.0, 87.0, 86.0, 85.0, 86.0, 87.0, 88.0, 88.0], "imaging-desaturate": [100.0, 99.0, 100.0, 101.0, 100.0, 100.0, 101.0, 101.0, 100.0, 98.0]}, "summary": {"suite": 1494.0, "subtests": {"audio-fft": {"filtered": 78.3, "value": 78.3}, "stanford-crypto-pbkdf2": {"filtered": 151.3, "value": 151.3}, "audio-beat-detection": {"filtered": 144.0, "value": 144.0}, "stanford-crypto-ccm": {"filtered": 124.1, "value": 124.1}, "imaging-darkroom": {"filtered": 124.7, "value": 124.7}, "json-parse-financial": {"filtered": 58.1, "value": 58.1}, "audio-oscillator": {"filtered": 104.7, "value": 104.7}, "ai-astar": {"filtered": 106.1, "value": 106.1}, "audio-dft": {"filtered": 162.0, "value": 162.0}, "stanford-crypto-sha256-iterative": {"filtered": 69.8, "value": 69.8}, "json-stringify-tinderbox": {"filtered": 67.0, "value": 67.0}, "imaging-gaussian-blur": {"filtered": 117.4, "value": 117.4}, "stanford-crypto-aes": {"filtered": 86.5, "value": 86.5}, "imaging-desaturate": {"filtered": 100.0, "value": 100.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1446556254, "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": "45.0a1", "id": "20151103031432", "branch": "Fx-Team", "revision": "c10c657afbe1fb64a9ed2e62a399c52c4038c186"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.3143294432753], "Encrypt": [325.2032520325203], "NavierStokes": [5865.497076023392], "Decrypt": [5764.367816091954], "Splay": [2044.9897750511248], "Richards": [166.61112962345885], "RegExp": [29514.285714285714], "Earley": [909.0909090909091], "Boyer": [13621.621621621622], "RayTrace": [2055.441478439425]}, "summary": {"suite": 16103.99206026423, "subtests": {"DeltaBlue": {"filtered": 345.5987859999999, "value": 345.5987859999999}, "Encrypt": {"filtered": 818.506575, "value": 818.506575}, "NavierStokes": {"filtered": 253.0049850448654, "value": 253.0049850448654}, "Decrypt": {"filtered": 46.176963110668, "value": 46.176963110668}, "Splay": {"filtered": 39.849098999999995, "value": 39.849098999999995}, "RegExp": {"filtered": 30.865900290416292, "value": 30.865900290416292}, "Richards": {"filtered": 211.88260400000004, "value": 211.88260400000004}, "Earley": {"filtered": 733.1093, "value": 733.1093}, "Boyer": {"filtered": 48.92684722222226, "value": 48.92684722222226}, "RayTrace": {"filtered": 360.01462837162825, "value": 360.01462837162825}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1446556254, "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": "45.0a1", "id": "20151103031432", "branch": "Fx-Team", "revision": "c10c657afbe1fb64a9ed2e62a399c52c4038c186"}}] 05:31:03 INFO - RETURN: dromaeo_css: 6889.00 05:31:03 INFO - RETURN: kraken: 1494.00 05:31:03 INFO - RETURN: v8_7: 16103.99 05:31:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16103.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1494.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6889.00"}}} 05:31:03 INFO - Return code: 0 05:31:03 INFO - # TBPL SUCCESS # 05:31:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:03 INFO - 2015-11-03 05:31:03.488 screenresolution[1984:16290] starting screenresolution argv=screenresolution get 05:31:03 INFO - 2015-11-03 05:31:03.491 screenresolution[1984:16290] Display 0: 1600x1200x32@60 05:31:03 INFO - 2015-11-03 05:31:03.497 screenresolution[1985:16293] starting screenresolution argv=screenresolution list 05:31:03 INFO - Available Modes on Display 0 05:31:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:03 INFO - Intel HD Graphics 3000: 05:31:03 INFO - Chipset Model: Intel HD Graphics 3000 05:31:03 INFO - Type: GPU 05:31:03 INFO - Bus: Built-In 05:31:03 INFO - VRAM (Total): 512 MB 05:31:03 INFO - VRAM (Dynamic, Max): 10 05:31:03 INFO - Vendor: Intel (0x8086) 05:31:03 INFO - Device ID: 0x0116 05:31:03 INFO - Revision ID: 0x0009 05:31:03 INFO - Displays: 05:31:03 INFO - Display: 05:31:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:03 INFO - Display Serial Number: 1600x1200 60 05:31:03 INFO - Main Display: Yes 05:31:03 INFO - Mirror: Off 05:31:03 INFO - Online: Yes 05:31:03 INFO - Rotation: Supported 05:31:03 INFO - Return code: 0 05:31:03 INFO - Running post-action listener: _resource_record_post_action 05:31:03 INFO - Running post-run listener: _resource_record_post_run 05:31:04 INFO - Total resource usage - Wall time: 1245s; CPU: 30.0%; Read bytes: 937984; Write bytes: 684560384; Read time: 361; Write time: 54869 05:31:04 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 334367232; Write bytes: 334755840; Read time: 30495; Write time: 6730 05:31:04 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 937984; Write bytes: 339437568; Read time: 361; Write time: 47032 05:31:04 INFO - Running post-run listener: _upload_blobber_files 05:31:04 INFO - Blob upload gear active. 05:31:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:31:04 INFO - Copying logs to upload dir... 05:31:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1293.764988 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-03 05:31:04.896403) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-03 05:31:04.900056) ========= 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.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009882 build_url: 'https://queue.taskcluster.net/v1/task/mF9VU8QtSIiDY7SPGmar8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-03 05:31:04.925656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:31:04.926008) ========= 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.REIbY4dmDl/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.ydhW9dmyky/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.005138 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 05:31:04.978389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 05:31:04.981771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 05:31:04.982230) ========= ========= Total master_lag: 0.23 =========