builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0022 starttime: 1449046334.13 results: success (0) buildid: 20151201235259 builduid: 78ccaf3f4985425085ec282acad0b7f6 revision: b4e23b2390f5f1049b130fd0866d44df30698c0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.126966) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.127396) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.127720) ========= 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.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.005484 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.180093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.180412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.203194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.203555) ========= 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.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.032643 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.253680) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.254019) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.254567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.254998) ========= 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.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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-12-02 00:52:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.21M=0.001s 2015-12-02 00:52:14 (9.21 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.259603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.529551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.530362) ========= 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.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.104799 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:14.648102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 00:52:14.648718) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4e23b2390f5f1049b130fd0866d44df30698c0d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4e23b2390f5f1049b130fd0866d44df30698c0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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-12-02 00:52:14,738 truncating revision to first 12 chars 2015-12-02 00:52:14,738 Setting DEBUG logging. 2015-12-02 00:52:14,738 attempt 1/10 2015-12-02 00:52:14,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b4e23b2390f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 00:52:15,818 unpacking tar archive at: mozilla-aurora-b4e23b2390f5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.653988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 00:52:16.318310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:16.318685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:16.327752) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:16.328222) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 00:52:16.328876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-02 00:52:16.329560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:52:16 INFO - MultiFileLogger online at 20151202 00:52:16 in /builds/slave/test 00:52:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:52:16 INFO - {'append_to_log': False, 00:52:16 INFO - 'base_work_dir': '/builds/slave/test', 00:52:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:52:16 INFO - 'branch': 'Mozilla-Aurora', 00:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 00:52:16 INFO - 'config_files': ('talos/mac_config.py',), 00:52:16 INFO - 'default_actions': ('clobber', 00:52:16 INFO - 'read-buildbot-config', 00:52:16 INFO - 'download-and-extract', 00:52:16 INFO - 'populate-webroot', 00:52:16 INFO - 'create-virtualenv', 00:52:16 INFO - 'install', 00:52:16 INFO - 'run-tests'), 00:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:52:16 INFO - 'download_minidump_stackwalk': True, 00:52:16 INFO - 'download_symbols': 'ondemand', 00:52:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:52:16 INFO - 'tooltool.py': '/tools/tooltool.py', 00:52:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:52:16 INFO - '/tools/misc-python/virtualenv.py')}, 00:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:52:16 INFO - 'installer_path': 'installer.exe', 00:52:16 INFO - 'log_level': 'info', 00:52:16 INFO - 'log_name': 'talos', 00:52:16 INFO - 'log_to_console': True, 00:52:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:52:16 INFO - 'opt_config_files': (), 00:52:16 INFO - 'pip_index': False, 00:52:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:52:16 INFO - 'cmd': ('bash', 00:52:16 INFO - '-c', 00:52:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:52:16 INFO - 'enabled': True, 00:52:16 INFO - 'halt_on_failure': False, 00:52:16 INFO - 'name': 'check_screen_resolution'},), 00:52:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:52:16 INFO - 'cmd': ('bash', 00:52:16 INFO - '-c', 00:52:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:52:16 INFO - 'enabled': True, 00:52:16 INFO - 'halt_on_failure': False, 00:52:16 INFO - 'name': 'check_screen_resolution'},), 00:52:16 INFO - 'run_cmd_checks_enabled': True, 00:52:16 INFO - 'sps_profile': False, 00:52:16 INFO - 'sps_profile_interval': 0, 00:52:16 INFO - 'suite': 'dromaeojs', 00:52:16 INFO - 'system_bits': '64', 00:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:52:16 INFO - 'title': 't-yosemite-r5-0022', 00:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:52:16 INFO - 'use_talos_json': True, 00:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:52:16 INFO - 'work_dir': 'build'} 00:52:16 INFO - ##### 00:52:16 INFO - ##### Running clobber step. 00:52:16 INFO - ##### 00:52:16 INFO - Running pre-action listener: _resource_record_pre_action 00:52:16 INFO - Running main action method: clobber 00:52:16 INFO - rmtree: /builds/slave/test/build 00:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:52:20 INFO - Running post-action listener: _resource_record_post_action 00:52:20 INFO - ##### 00:52:20 INFO - ##### Running read-buildbot-config step. 00:52:20 INFO - ##### 00:52:20 INFO - Running pre-action listener: _resource_record_pre_action 00:52:20 INFO - Running main action method: read_buildbot_config 00:52:20 INFO - Using buildbot properties: 00:52:20 INFO - { 00:52:20 INFO - "properties": { 00:52:20 INFO - "buildnumber": 444, 00:52:20 INFO - "product": "firefox", 00:52:20 INFO - "script_repo_revision": "production", 00:52:20 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 00:52:20 INFO - "repository": "", 00:52:20 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 00:52:20 INFO - "buildid": "20151201235259", 00:52:20 INFO - "slavename": "t-yosemite-r5-0022", 00:52:20 INFO - "pgo_build": "False", 00:52:20 INFO - "basedir": "/builds/slave/test", 00:52:20 INFO - "project": "", 00:52:20 INFO - "platform": "yosemite", 00:52:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:52:20 INFO - "slavebuilddir": "test", 00:52:20 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 00:52:20 INFO - "branch": "mozilla-aurora", 00:52:20 INFO - "repo_path": "releases/mozilla-aurora", 00:52:20 INFO - "stage_platform": "macosx64", 00:52:20 INFO - "builduid": "78ccaf3f4985425085ec282acad0b7f6", 00:52:20 INFO - "revision": "b4e23b2390f5f1049b130fd0866d44df30698c0d" 00:52:20 INFO - }, 00:52:20 INFO - "sourcestamp": { 00:52:20 INFO - "repository": "", 00:52:20 INFO - "hasPatch": false, 00:52:20 INFO - "project": "", 00:52:20 INFO - "branch": "mozilla-aurora-macosx64-talos", 00:52:20 INFO - "changes": [ 00:52:20 INFO - { 00:52:20 INFO - "category": null, 00:52:20 INFO - "files": [ 00:52:20 INFO - { 00:52:20 INFO - "url": null, 00:52:20 INFO - "name": "https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 00:52:20 INFO - } 00:52:20 INFO - ], 00:52:20 INFO - "repository": "", 00:52:20 INFO - "rev": "b4e23b2390f5f1049b130fd0866d44df30698c0d", 00:52:20 INFO - "who": "smontagu@smontagu.org", 00:52:20 INFO - "when": 1449045902, 00:52:20 INFO - "number": 6731818, 00:52:20 INFO - "comments": "Bug 1216096: restore previous RTL caret behaviour by backout of bug 1164963, bug 1177505, and bug 1180417. r=jfkthame, a=rkothari", 00:52:20 INFO - "project": "", 00:52:20 INFO - "at": "Wed 02 Dec 2015 00:45:02", 00:52:20 INFO - "branch": "mozilla-aurora-macosx64-talos", 00:52:20 INFO - "revlink": "", 00:52:20 INFO - "properties": [ 00:52:20 INFO - [ 00:52:20 INFO - "buildid", 00:52:20 INFO - "20151201235259", 00:52:20 INFO - "Change" 00:52:20 INFO - ], 00:52:20 INFO - [ 00:52:20 INFO - "builduid", 00:52:20 INFO - "78ccaf3f4985425085ec282acad0b7f6", 00:52:20 INFO - "Change" 00:52:20 INFO - ], 00:52:20 INFO - [ 00:52:20 INFO - "pgo_build", 00:52:20 INFO - "False", 00:52:20 INFO - "Change" 00:52:20 INFO - ] 00:52:20 INFO - ], 00:52:20 INFO - "revision": "b4e23b2390f5f1049b130fd0866d44df30698c0d" 00:52:20 INFO - } 00:52:20 INFO - ], 00:52:20 INFO - "revision": "b4e23b2390f5f1049b130fd0866d44df30698c0d" 00:52:20 INFO - } 00:52:20 INFO - } 00:52:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 00:52:20 INFO - Running post-action listener: _resource_record_post_action 00:52:20 INFO - ##### 00:52:20 INFO - ##### Running download-and-extract step. 00:52:20 INFO - ##### 00:52:20 INFO - Running pre-action listener: _resource_record_pre_action 00:52:20 INFO - Running main action method: download_and_extract 00:52:20 INFO - mkdir: /builds/slave/test/build/tests 00:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:20 INFO - https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/test_packages.json 00:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/test_packages.json 00:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:52:21 INFO - Downloaded 1149 bytes. 00:52:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:52:21 INFO - Using the following test package requirements: 00:52:21 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 00:52:21 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 00:52:21 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'jsshell-mac.zip'], 00:52:21 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 00:52:21 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 00:52:21 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 00:52:21 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 00:52:21 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 00:52:21 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 00:52:21 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 00:52:21 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 00:52:21 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 00:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:21 INFO - https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:52:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 00:52:22 INFO - Downloaded 17490110 bytes. 00:52:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 00:52:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 00:52:27 INFO - Return code: 0 00:52:27 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 00:52:27 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')]} 00:52:27 INFO - https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 00:52:28 INFO - Downloaded 17490110 bytes. 00:52:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 00:52:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 00:52:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 00:52:34 INFO - Return code: 0 00:52: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')]} 00:52:34 INFO - https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:52:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 00:52:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 00:52:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 00:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 00:52:35 INFO - Downloaded 11131307 bytes. 00:52:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 00:52:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 00:52:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 00:52:35 INFO - Return code: 0 00:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:35 INFO - https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 00:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 00:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 00:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 00:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 00:52:39 INFO - Downloaded 108651926 bytes. 00:52:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 00:52:39 INFO - mkdir: /builds/slave/test/properties 00:52:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:52:39 INFO - Writing to file /builds/slave/test/properties/build_url 00:52:39 INFO - Contents: 00:52:39 INFO - build_url:https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 00:52:39 INFO - Running post-action listener: _resource_record_post_action 00:52:39 INFO - Running post-action listener: set_extra_try_arguments 00:52:39 INFO - ##### 00:52:39 INFO - ##### Running populate-webroot step. 00:52:39 INFO - ##### 00:52:39 INFO - Running pre-action listener: _resource_record_pre_action 00:52:39 INFO - Running main action method: populate_webroot 00:52:39 INFO - Guessing talos json url... 00:52: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')]} 00:52:39 INFO - https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 00:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 00:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 00:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 00:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 00:52:40 INFO - Downloaded 107 bytes. 00:52:40 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 00:52:40 INFO - Contents: 00:52:40 INFO - 20151201235259 00:52:40 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/b4e23b2390f5f1049b130fd0866d44df30698c0d 00:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:40 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b4e23b2390/testing/talos/talos.json 00:52:40 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b4e23b2390/testing/talos/talos.json to /builds/slave/test/build/talos.json 00:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b4e23b2390/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 00:52:40 INFO - Downloaded 4264 bytes. 00:52:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:52:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:52:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:52:40 INFO - '../fennec_ids.txt'], 00:52:40 INFO - 'tests': ['tcheck2']}, 00:52:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:52:40 INFO - '--tppagecycles', 00:52:40 INFO - '7'], 00:52:40 INFO - 'tests': ['tsvgm']}}, 00:52:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:52:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:52:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'tests': ['damp', 'tps']}, 00:52:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['damp', 'tps']}, 00:52:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:52:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:52:40 INFO - 'other': {'tests': ['a11yr', 00:52:40 INFO - 'ts_paint', 00:52:40 INFO - 'tpaint', 00:52:40 INFO - 'sessionrestore', 00:52:40 INFO - 'sessionrestore_no_auto_restore']}, 00:52:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['a11yr', 00:52:40 INFO - 'ts_paint', 00:52:40 INFO - 'tpaint', 00:52:40 INFO - 'sessionrestore', 00:52:40 INFO - 'sessionrestore_no_auto_restore']}, 00:52:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['a11yr', 00:52:40 INFO - 'ts_paint', 00:52:40 INFO - 'tpaint', 00:52:40 INFO - 'sessionrestore', 00:52:40 INFO - 'sessionrestore_no_auto_restore']}, 00:52:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['a11yr', 00:52:40 INFO - 'ts_paint', 00:52:40 INFO - 'tpaint', 00:52:40 INFO - 'sessionrestore', 00:52:40 INFO - 'sessionrestore_no_auto_restore']}, 00:52:40 INFO - 'other_l64': {'tests': ['a11yr', 00:52:40 INFO - 'ts_paint', 00:52:40 INFO - 'tpaint', 00:52:40 INFO - 'sessionrestore', 00:52:40 INFO - 'sessionrestore_no_auto_restore']}, 00:52:40 INFO - 'other_nol64': {'tests': ['a11yr', 00:52:40 INFO - 'ts_paint', 00:52:40 INFO - 'tpaint', 00:52:40 INFO - 'sessionrestore', 00:52:40 INFO - 'sessionrestore_no_auto_restore']}, 00:52:40 INFO - 'svgr': {'tests': ['tsvgx', 00:52:40 INFO - 'tsvgr_opacity', 00:52:40 INFO - 'tart', 00:52:40 INFO - 'tscrollx', 00:52:40 INFO - 'cart']}, 00:52:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['tsvgx', 00:52:40 INFO - 'tsvgr_opacity', 00:52:40 INFO - 'tart', 00:52:40 INFO - 'tscrollx', 00:52:40 INFO - 'cart']}, 00:52:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'tests': ['tp5o']}, 00:52:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'talos_options': ['--e10s'], 00:52:40 INFO - 'tests': ['tp5o']}, 00:52:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'talos_options': ['--xperf_path', 00:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:40 INFO - 'tests': ['tp5n']}, 00:52:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:40 INFO - 'talos_options': ['--e10s', 00:52:40 INFO - '--xperf_path', 00:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 00:52:40 INFO - 'C:/slave/talos-data/talos/xperf.config'], 00:52:40 INFO - 'tests': ['tp5n']}}, 00:52:40 INFO - 'talos.zip': {'path': '', 00:52:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:52:40 INFO - Running post-action listener: _resource_record_post_action 00:52:40 INFO - ##### 00:52:40 INFO - ##### Running create-virtualenv step. 00:52:40 INFO - ##### 00:52:40 INFO - Running pre-action listener: _resource_record_pre_action 00:52:40 INFO - Running main action method: create_virtualenv 00:52:40 INFO - Creating virtualenv /builds/slave/test/build/venv 00:52:40 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 00:52:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:52:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:52:40 INFO - Using real prefix '/tools/python27' 00:52:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:52:41 INFO - Installing distribute.............................................................................................................................................................................................done. 00:52:45 INFO - Installing pip.................done. 00:52:45 INFO - Return code: 0 00:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:46 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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:52:46 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 00:52:46 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 00:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:46 INFO - 'HOME': '/Users/cltbld', 00:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:46 INFO - 'LOGNAME': 'cltbld', 00:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:46 INFO - 'MOZ_NO_REMOTE': '1', 00:52:46 INFO - 'NO_EM_RESTART': '1', 00:52:46 INFO - 'PAGER': '/bin/cat', 00:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:46 INFO - 'PWD': '/builds/slave/test', 00:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:46 INFO - 'SHELL': '/bin/bash', 00:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:52:46 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:46 INFO - 'USER': 'cltbld', 00:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:46 INFO - 'XPC_FLAGS': '0x0', 00:52:46 INFO - 'XPC_SERVICE_NAME': '0', 00:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:47 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 00:52:47 INFO - Cleaning up... 00:52:47 INFO - Return code: 0 00:52:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:52: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')]} 00:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:47 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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:52:47 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 00:52:47 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 00:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:47 INFO - 'HOME': '/Users/cltbld', 00:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:47 INFO - 'LOGNAME': 'cltbld', 00:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:47 INFO - 'MOZ_NO_REMOTE': '1', 00:52:47 INFO - 'NO_EM_RESTART': '1', 00:52:47 INFO - 'PAGER': '/bin/cat', 00:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:47 INFO - 'PWD': '/builds/slave/test', 00:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:47 INFO - 'SHELL': '/bin/bash', 00:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:52:47 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:47 INFO - 'USER': 'cltbld', 00:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:47 INFO - 'XPC_FLAGS': '0x0', 00:52:47 INFO - 'XPC_SERVICE_NAME': '0', 00:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:47 INFO - Downloading/unpacking psutil>=0.7.1 00:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:52:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:50 INFO - Installing collected packages: psutil 00:52:50 INFO - Running setup.py install for psutil 00:52:50 INFO - building 'psutil._psutil_osx' extension 00:52:50 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 00:52:52 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 00:52:52 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 00:52:52 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 00:52:52 INFO - building 'psutil._psutil_posix' extension 00:52:52 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 00:52:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:52:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:52:52 INFO - ^ 00:52:52 INFO - 1 warning generated. 00:52:52 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 00:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:53 INFO - Successfully installed psutil 00:52:53 INFO - Cleaning up... 00:52:53 INFO - Return code: 0 00:52:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:52:53 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')]} 00:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:53 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')]} 00:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:53 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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:52:53 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 00:52:53 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 00:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:53 INFO - 'HOME': '/Users/cltbld', 00:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:53 INFO - 'LOGNAME': 'cltbld', 00:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:53 INFO - 'MOZ_NO_REMOTE': '1', 00:52:53 INFO - 'NO_EM_RESTART': '1', 00:52:53 INFO - 'PAGER': '/bin/cat', 00:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:53 INFO - 'PWD': '/builds/slave/test', 00:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:53 INFO - 'SHELL': '/bin/bash', 00:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:52:53 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:53 INFO - 'USER': 'cltbld', 00:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:53 INFO - 'XPC_FLAGS': '0x0', 00:52:53 INFO - 'XPC_SERVICE_NAME': '0', 00:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:52:53 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 00:52:53 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 00:52:53 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 00:52:53 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 00:52:53 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 00:52:53 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 00:52:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:52:56 INFO - Installing collected packages: mozsystemmonitor 00:52:56 INFO - Running setup.py install for mozsystemmonitor 00:52:56 INFO - Successfully installed mozsystemmonitor 00:52:56 INFO - Cleaning up... 00:52:56 INFO - Return code: 0 00:52:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:52: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')]} 00:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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', '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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:52: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 blobuploader==1.2.4 00:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:56 INFO - 'HOME': '/Users/cltbld', 00:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:56 INFO - 'LOGNAME': 'cltbld', 00:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:56 INFO - 'MOZ_NO_REMOTE': '1', 00:52:56 INFO - 'NO_EM_RESTART': '1', 00:52:56 INFO - 'PAGER': '/bin/cat', 00:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:56 INFO - 'PWD': '/builds/slave/test', 00:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:56 INFO - 'SHELL': '/bin/bash', 00:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:52:56 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:56 INFO - 'USER': 'cltbld', 00:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:56 INFO - 'XPC_FLAGS': '0x0', 00:52:56 INFO - 'XPC_SERVICE_NAME': '0', 00:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:56 INFO - Downloading/unpacking blobuploader==1.2.4 00:52: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 00:52: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 00:52: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 00:52: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 00:52: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 00:52: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 00:52:59 INFO - Downloading blobuploader-1.2.4.tar.gz 00:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:52:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:52:59 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 00:52:59 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 00:52:59 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 00:52:59 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 00:52:59 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 00:52:59 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 00:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:53:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:00 INFO - Downloading docopt-0.6.1.tar.gz 00:53:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:53:00 INFO - Installing collected packages: blobuploader, requests, docopt 00:53:00 INFO - Running setup.py install for blobuploader 00:53:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:53:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:53:00 INFO - Running setup.py install for requests 00:53:01 INFO - Running setup.py install for docopt 00:53:01 INFO - Successfully installed blobuploader requests docopt 00:53:01 INFO - Cleaning up... 00:53:01 INFO - Return code: 0 00:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53:01 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')]} 00:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:01 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')]} 00:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:01 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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:53:01 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 00:53:01 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 00:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:53:01 INFO - 'HOME': '/Users/cltbld', 00:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:53:01 INFO - 'LOGNAME': 'cltbld', 00:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:01 INFO - 'MOZ_NO_REMOTE': '1', 00:53:01 INFO - 'NO_EM_RESTART': '1', 00:53:01 INFO - 'PAGER': '/bin/cat', 00:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:01 INFO - 'PWD': '/builds/slave/test', 00:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:53:01 INFO - 'SHELL': '/bin/bash', 00:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:53:01 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:53:01 INFO - 'USER': 'cltbld', 00:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:01 INFO - 'XPC_FLAGS': '0x0', 00:53:01 INFO - 'XPC_SERVICE_NAME': '0', 00:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-ewBak2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-B6HLoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-HgVW6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-zQ31BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-SskWk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-t5oG1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:53:02 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-1zsoji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-lnNhbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-GX11Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-uykkqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-_2SVmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-J7ETKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-UnGjXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-lVB8py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:03 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-UI5CUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:53:04 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Rmme4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:53:04 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-B3g1fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:53:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:53:04 INFO - Running setup.py install for manifestparser 00:53:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:53:04 INFO - Running setup.py install for mozcrash 00:53:04 INFO - Running setup.py install for mozdebug 00:53:04 INFO - Running setup.py install for mozdevice 00:53:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Running setup.py install for mozfile 00:53:05 INFO - Running setup.py install for mozhttpd 00:53:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Running setup.py install for mozinfo 00:53:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Running setup.py install for mozInstall 00:53:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:53:05 INFO - Running setup.py install for mozleak 00:53:05 INFO - Running setup.py install for mozlog 00:53:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:53:06 INFO - Running setup.py install for moznetwork 00:53:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:53:06 INFO - Running setup.py install for mozprocess 00:53:06 INFO - Running setup.py install for mozprofile 00:53:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:53:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:53:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:53:06 INFO - Running setup.py install for mozrunner 00:53:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:53:06 INFO - Running setup.py install for mozscreenshot 00:53:07 INFO - Running setup.py install for moztest 00:53:07 INFO - Running setup.py install for mozversion 00:53:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:53:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:53:07 INFO - Cleaning up... 00:53:07 INFO - Return code: 0 00:53:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53: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')]} 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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')]} 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:07 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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:53:07 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 00:53:07 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 00:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:53:07 INFO - 'HOME': '/Users/cltbld', 00:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:53:07 INFO - 'LOGNAME': 'cltbld', 00:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:07 INFO - 'MOZ_NO_REMOTE': '1', 00:53:07 INFO - 'NO_EM_RESTART': '1', 00:53:07 INFO - 'PAGER': '/bin/cat', 00:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:07 INFO - 'PWD': '/builds/slave/test', 00:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:53:07 INFO - 'SHELL': '/bin/bash', 00:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:53:07 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:53:07 INFO - 'USER': 'cltbld', 00:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:07 INFO - 'XPC_FLAGS': '0x0', 00:53:07 INFO - 'XPC_SERVICE_NAME': '0', 00:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:53:07 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-EtzfB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:53:07 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)) 00:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:53:07 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Ch8Oqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:53:08 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)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-mL1iNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:53:08 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)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-0fevTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-KtP1fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:53:08 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)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-WzhIbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:53:08 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)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-4hrFMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-JtacQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:53:08 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)) 00:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:53:08 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-QwxBy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-83NJcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-5N6haD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-5bE6sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-2Thb9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-HX4cVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-mWbict-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-oork4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:53:09 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Gv5v5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:53:10 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)) 00:53:10 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)) 00:53:10 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)) 00:53:10 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)) 00:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:10 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 00:53:10 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 00:53:10 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 00:53:10 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 00:53:10 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 00:53:10 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 00:53:12 INFO - Downloading blessings-1.5.1.tar.gz 00:53:12 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 00:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:12 INFO - Installing collected packages: blessings 00:53:12 INFO - Running setup.py install for blessings 00:53:13 INFO - Successfully installed blessings 00:53:13 INFO - Cleaning up... 00:53:13 INFO - Return code: 0 00:53:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:53:13 INFO - Reading from file tmpfile_stdout 00:53:13 INFO - Current package versions: 00:53:13 INFO - blessings == 1.5.1 00:53:13 INFO - blobuploader == 1.2.4 00:53:13 INFO - docopt == 0.6.1 00:53:13 INFO - manifestparser == 1.1 00:53:13 INFO - mozInstall == 1.12 00:53:13 INFO - mozcrash == 0.16 00:53:13 INFO - mozdebug == 0.1 00:53:13 INFO - mozdevice == 0.46 00:53:13 INFO - mozfile == 1.2 00:53:13 INFO - mozhttpd == 0.7 00:53:13 INFO - mozinfo == 0.8 00:53:13 INFO - mozleak == 0.1 00:53:13 INFO - mozlog == 3.0 00:53:13 INFO - moznetwork == 0.27 00:53:13 INFO - mozprocess == 0.22 00:53:13 INFO - mozprofile == 0.27 00:53:13 INFO - mozrunner == 6.11 00:53:13 INFO - mozscreenshot == 0.1 00:53:13 INFO - mozsystemmonitor == 0.0 00:53:13 INFO - moztest == 0.7 00:53:13 INFO - mozversion == 1.4 00:53:13 INFO - psutil == 3.1.1 00:53:13 INFO - requests == 1.2.3 00:53:13 INFO - wsgiref == 0.1.2 00:53:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1076f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107764228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc3503450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, '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.XtXRqKWCKT/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.ME33dfS6xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 00:53:13 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 00:53:13 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 00:53:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:53:13 INFO - 'HOME': '/Users/cltbld', 00:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:53:13 INFO - 'LOGNAME': 'cltbld', 00:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:13 INFO - 'MOZ_NO_REMOTE': '1', 00:53:13 INFO - 'NO_EM_RESTART': '1', 00:53:13 INFO - 'PAGER': '/bin/cat', 00:53:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:13 INFO - 'PWD': '/builds/slave/test', 00:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:53:13 INFO - 'SHELL': '/bin/bash', 00:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:53:13 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:53:13 INFO - 'USER': 'cltbld', 00:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:13 INFO - 'XPC_FLAGS': '0x0', 00:53:13 INFO - 'XPC_SERVICE_NAME': '0', 00:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 INFO - Cleaning up... 00:53:13 INFO - Return code: 0 00:53:13 INFO - Running post-action listener: _resource_record_post_action 00:53:13 INFO - Running post-action listener: _start_resource_monitoring 00:53:13 INFO - Starting resource monitoring. 00:53:13 INFO - ##### 00:53:13 INFO - ##### Running install step. 00:53:13 INFO - ##### 00:53:13 INFO - Running pre-action listener: _resource_record_pre_action 00:53:13 INFO - Running main action method: install 00:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:53:14 INFO - Reading from file tmpfile_stdout 00:53:14 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:53:14 INFO - Reading from file tmpfile_stdout 00:53:14 INFO - Output received: 00:53:14 INFO - Usage: mozinstall [options] installer 00:53:14 INFO - Options: 00:53:14 INFO - -h, --help show this help message and exit 00:53:14 INFO - -d DEST, --destination=DEST 00:53:14 INFO - Directory to install application into. [default: 00:53:14 INFO - "/builds/slave/test"] 00:53:14 INFO - --app=APP Application being installed. [default: firefox] 00:53:14 INFO - mkdir: /builds/slave/test/build/application 00:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 00:53:53 INFO - Reading from file tmpfile_stdout 00:53:53 INFO - Output received: 00:53:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 00:53:53 INFO - Running post-action listener: _resource_record_post_action 00:53:53 INFO - ##### 00:53:53 INFO - ##### Running run-tests step. 00:53:53 INFO - ##### 00:53:53 INFO - Running pre-action listener: _resource_record_pre_action 00:53:53 INFO - Running main action method: run_tests 00:53:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:53:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:53:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:53:53 INFO - 2015-12-02 00:53:53.882 screenresolution[1637:7569] starting screenresolution argv=screenresolution get 00:53:53 INFO - 2015-12-02 00:53:53.886 screenresolution[1637:7569] Display 0: 1600x1200x32@60 00:53:53 INFO - 2015-12-02 00:53:53.893 screenresolution[1638:7571] starting screenresolution argv=screenresolution list 00:53:53 INFO - Available Modes on Display 0 00:53:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:53:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:53:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:53:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:53:54 INFO - Intel HD Graphics 3000: 00:53:54 INFO - Chipset Model: Intel HD Graphics 3000 00:53:54 INFO - Type: GPU 00:53:54 INFO - Bus: Built-In 00:53:54 INFO - VRAM (Total): 512 MB 00:53:54 INFO - VRAM (Dynamic, Max): 10 00:53:54 INFO - Vendor: Intel (0x8086) 00:53:54 INFO - Device ID: 0x0116 00:53:54 INFO - Revision ID: 0x0009 00:53:54 INFO - Displays: 00:53:54 INFO - Display: 00:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:53:54 INFO - Display Serial Number: 1600x1200 60 00:53:54 INFO - Main Display: Yes 00:53:54 INFO - Mirror: Off 00:53:54 INFO - Online: Yes 00:53:54 INFO - Rotation: Supported 00:53:54 INFO - Return code: 0 00:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:53:54 INFO - Python 2.7.3 00:53:54 INFO - Return code: 0 00:53:54 INFO - grabbing minidump binary from tooltool 00:53: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')]} 00:53: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 0x1076ac9f0>, '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 0x10740bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107676990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:53: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 00:53: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 00:53:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:54 INFO - Return code: 0 00:53:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:53:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:53:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:53:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:53:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0022', '--webServer', 'localhost'] in /builds/slave/test/build 00:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0022 --webServer localhost 00:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XtXRqKWCKT/Render', 00:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:53:54 INFO - 'HOME': '/Users/cltbld', 00:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:53:54 INFO - 'LOGNAME': 'cltbld', 00:53:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:53:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:54 INFO - 'MOZ_NO_REMOTE': '1', 00:53:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:53:54 INFO - 'NO_EM_RESTART': '1', 00:53:54 INFO - 'PAGER': '/bin/cat', 00:53:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:54 INFO - 'PWD': '/builds/slave/test', 00:53:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:53:54 INFO - 'SHELL': '/bin/bash', 00:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ME33dfS6xa/Listeners', 00:53:54 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 00:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:53:54 INFO - 'USER': 'cltbld', 00:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:54 INFO - 'XPC_FLAGS': '0x0', 00:53:54 INFO - 'XPC_SERVICE_NAME': '0', 00:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:53:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0022', '--webServer', 'localhost'] with output_timeout 3600 00:53:54 INFO - mozversion INFO | application_buildid: 20151201235259 00:53:54 INFO - mozversion INFO | application_changeset: b4e23b2390f5f1049b130fd0866d44df30698c0d 00:53:54 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 00:53:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:54 INFO - mozversion INFO | application_name: Firefox 00:53:54 INFO - mozversion INFO | application_remotingname: firefox-dev 00:53:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:53:54 INFO - mozversion INFO | application_vendor: Mozilla 00:53:54 INFO - mozversion INFO | application_version: 44.0a2 00:53:54 INFO - mozversion INFO | platform_buildid: 20151201235259 00:53:54 INFO - mozversion INFO | platform_changeset: b4e23b2390f5f1049b130fd0866d44df30698c0d 00:53:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:53:54 INFO - mozversion INFO | platform_version: 44.0a2 00:53:54 INFO - 2015-12-02 00:53:54,608 DEBUG : using testdate: 1449046434 00:53:54 INFO - 2015-12-02 00:53:54,608 DEBUG : actual date: 1449046434 00:53:54 INFO - 2015-12-02 00:53:54,617 INFO : starting webserver on 'localhost:49269' 00:53:54 INFO - 2015-12-02 00:53:54,619 INFO : Starting test suite t-yosemite-r5-0022 00:53:54 INFO - 2015-12-02 00:53:54,619 INFO : Starting test dromaeo_css 00:53:54 INFO - 2015-12-02 00:53:54,619 DEBUG : operating with platform_type : mac_ 00:53:54 INFO - 2015-12-02 00:53:54,620 INFO : Initialising browser for dromaeo_css test... 00:53:54 INFO - 2015-12-02 00:53:54,645 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpr0nXFZ/profile http://localhost:49269/getInfo.html 00:53:57 INFO - 2015-12-02 00:53:57,575 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:53:57 INFO - 2015-12-02 00:53:57,576 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:53:57 INFO - 2015-12-02 00:53:57,576 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:53:57 INFO - 2015-12-02 00:53:57,576 DEBUG : BROWSER_OUTPUT: __metrics 00:53:57 INFO - 2015-12-02 00:53:57,592 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:53:58 INFO - 2015-12-02 00:53:58,239 INFO : Browser initialized. 00:53:58 INFO - 2015-12-02 00:53:58,240 INFO : Running cycle 1/1 for dromaeo_css test... 00:53:58 INFO - 2015-12-02 00:53:58,240 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpr0nXFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:54:10 INFO - 2015-12-02 00:54:10,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 197951488 00:54:10 INFO - 2015-12-02 00:54:10,163 DEBUG : BROWSER_OUTPUT: 00:55:01 INFO - 2015-12-02 00:55:01,805 DEBUG : BROWSER_OUTPUT: 1449046501803 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] 00:57:11 INFO - 2015-12-02 00:57:11,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 00:57:13 INFO - 2015-12-02 00:57:13,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 338731008 00:57:13 INFO - 2015-12-02 00:57:13,326 DEBUG : BROWSER_OUTPUT: 01:00:16 INFO - 2015-12-02 01:00:16,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 01:00:16 INFO - 2015-12-02 01:00:16,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 344223744 01:00:16 INFO - 2015-12-02 01:00:16,745 DEBUG : BROWSER_OUTPUT: 01:03:18 INFO - 2015-12-02 01:03:18,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 01:03:19 INFO - 2015-12-02 01:03:19,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 306393088 01:03:19 INFO - 2015-12-02 01:03:19,498 DEBUG : BROWSER_OUTPUT: 01:06:21 INFO - 2015-12-02 01:06:21,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 01:06:22 INFO - 2015-12-02 01:06:22,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 300716032 01:06:22 INFO - 2015-12-02 01:06:22,123 DEBUG : BROWSER_OUTPUT: 01:09:25 INFO - 2015-12-02 01:09:25,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 01:09:25 INFO - 2015-12-02 01:09:25,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 299937792 01:09:25 INFO - 2015-12-02 01:09:25,842 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 01:12:28 INFO - 2015-12-02 01:12:28,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 344248320 01:12:28 INFO - 2015-12-02 01:12:28,828 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,829 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:28 INFO - 2015-12-02 01:12:28,829 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:28 INFO - 2015-12-02 01:12:28,829 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:28 INFO - 2015-12-02 01:12:28,829 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:28 INFO - 2015-12-02 01:12:28,833 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2826.208661574759;2901.4342203270357;2905.636795400575;2916.431295897301;2916.9416611667766;4857.829975950838;4867.26990951357;4870.293807397925;4871.585915197213;4885.413750349959;4833.154198015351;4844.636652251078;4878.365812444377;4887.144749668802;4918.36061312029;4391.231534481453;4479.3952816369865;4498.685092043558;4525.547445255481;4551.931721024187;4439.223135951212;4479.238529449985;4547.408836851205;4569.109023740372;4599.540045995407;4540.341650460698;4543.773181241063;4548.840790572331;4553.863384098482;4591.104734576759;4536.523665015159;4571.565701258375;4583.908321833561;4608.147492713859;4628;4227.97886010568;4309.07354918694;4404.163208990281;4466.464024317071;4485.641148708096;4775.403074615673;4836.153673107192;4847.903041939141;4850.369451971256;4858.149823780825;5186.688798672092;5194.92207616886;5214.843554693365;5252.474752524755;5266.8419947401635;5082.2122571001555;5128.589712822965;5202.08963431398;5255.86860328491;5335.466453354672;4941.48114447985;4952.523738130934;4982.501749824988;5010.248462730583;5022.347094877716;5455.045367060828;5463.754131064032;5472.288602481652;5485.0949593317455;5498.670079795145;4882.12121818069;4895.388076490439;4942.481039490802;4989.0770207511005;5091.66904151229;5259.132243179909;5336.893262134736;5358.91961620576;5365.356157261075;5369.543588794996;5205.297284866495;5278.5513231375;5286.524212820865;5300.522952934178;5332.093544097513;4933.506649335038;5046.646734728607;5088.898222035538;5097.949020509822;5136.229565565195;4016.3172260715746;4056.1887622475624;4086.4891888513935;4105.609967053125;4124.237016151961;3679.172186258124;3688;3692.9630703693156;3706.870259540903;3736.925261494755;4742.715437073786;4787.3776409066595;4854.854354369375;4858.489858564871;4889.217725164028;5122.538971492509;5209.583233341324;5210.192420174879;5215.556677682363;5220.295260139833;4888.169011268093;4913.754312284372;4996.575291100297;4999.75001249936;5013.348264725635;4332.415123958225;4435.290353543418;4461.553844615512;4626.352310676508;4727.030958653468;5284.682919024871;5387.353517577916;5439.891202176013;5449.564034877121;5476.945230547723;5368.22160786676;5408.45915408456;5425.891482170414;5440.918386224131;5462.098753705594;5135.460776618551;5275.788968441219;5292.655977361459;5421.457854214547;5474.5894057945015;5125.154349532286;5296.841094767163;5303.867403314794;5305.151175811851;5326.97336513315;5113.64204505681;5314.043472175045;5362.222477740784;5371.060064488777;5371.973140134274;4926.581240594446;5032.295478632921;5037.0681423936685;5198.9740051299505;5240.868978275574;5014.7994080236385;5033.6476446648385;5067.721275329893;5069.771860266371;5085.288059671723;4860.198067318853;4930.359053323045;4955.529224723646;4964.652474326763;5020.071286811805;5153.665011774223;5193.221016847503;5264.078786212474;5266.8419947401635;5277.261183434245;5008.824691135793;5095.694258344512;5146.948530514796;5159.664621799571;5169.06956747789 01:12:28 INFO - 2015-12-02 01:12:28,833 DEBUG : BROWSER_OUTPUT: |1;ext.html;507.0847120946692;512.6027328820167;515.8761897144684;517.6686920370961;539.9217113518538;27429.862850685742;30005;37378.25243495128;37579;37771.62228377716;40365.394519082234;40453.59546404535;40475.79762101185;40571.59428405715;40938;7567.848643027136;8220.630071646776;8446.662133514652;8476.957615211915;8556;7691.538507689528;9878.456684882329;10153.593856245778;10156.593736250541;10194.286399951969;9839.163671087967;9880.40717556949;9915;9955.203583713286;10058.34620749649;7809.609519524001;7985.5208687478935;9880.505974701236;10046.196304295712;10069.345492542961;9746.610135594568;9882.703518894445;9885.654002109963;9911.504424778732;9994.250431217688;36722;37120.628793711985;37175;37203;37205.441918371245;2693.380522479821;2741.2144078229226;2763.6130941668184;3172.397244523533;3274.7052765251005;24712.876435617705;25467.61798573023;25831.74168258331;25852.482950341077;26524.336891577674;2170.8914554272224;2179.2263746370127;2180.509385388275;2192.9342119736434;2216.9556608867892;252410;254337;254536;256979;258265;42101.15797684029;52549.7372513135;52838.73580632072;53301.73349133229;53485;47359;61671.383286166565;63466;63474.365256347766;64240.678796605716;16012.199390030451;16178.919105404397;16375.91812040956;16388.098654574114;16398.180090995404;11557.133215008907;11746.647600571996;11766.176367654181;11883.70290742721;11914.642560723192;18841.246350146113;19007.239710411428;19092.904535477235;19201.42357952694;19307.710384344246;7701.691932322757;7810.648520816577;7873.960630196812;7927.128015918244;7947.4436789425345;783.3928705253475;924.9583768730289;963.942163470194;976.4727047394327;1012.1750773119884;26096.217113486626;26215.282082306625;26273.34316642061;26355.736442635327;26461.206163815117;876.1151237250423;945.0974319524837;950.7100334397936;975.7853272280087;1016.7305663999047;12796.23222606628;13324.133931294435;13487.460501580023;13542.796858047137;13674.31628418595;217867;222982;224529;224587;224782;42954;43583.34624980628;45201;46152.3077153843;50424.74787626112;1307.1307580458888;1317.795741660025;1318.4660212613715;1320.0363734473697;1330.7005923667098;25259.368515787253;25788.871055644602;26758;26945;27956.86021569879;41651.583484164774;42396.57603423926;49527;49918.50081499284;50696;238073;239208;242027;242039;244318;27244.727552725013;27922.022729204382;28741.568876466452;29099;29265.70734292715;38659.976534611225;40114.39828402635;40669.38995915123;41309.79345103376;41310;30755.53866692046;32024;32663.836680816443;32687.836560817996;33063.17342066467;29612.851935740182;29986.550201746555;30016;30260.69739302667;31833.5224971621;31879.362412752078;33171.336573267916;33184.834075829465;33523.83238083794;33722.83138584292;26007.60988585135;29269.26826829261;29294.41411171722;31560.36879262448;31748.68251317457;21495.677564836853;21639.891800540896;21790.237341692966;21841.344759657237;22158.88920555387 01:12:28 INFO - 2015-12-02 01:12:28,837 DEBUG : BROWSER_OUTPUT: |2;jquery.html;308.8532946850245;317.5189587774522;319.6547728453272;319.85606477085315;326.2349789743052;15461;16107.51677449677;16219.83780162198;16660.08369539675;16881.746773798404;16093.678126437464;16873.24070416831;16928.83071169288;17094.658106837855;17098.572535686613;4629.490756016836;4734.195186818232;4751.952480475203;4803.615710743132;4815.614750819944;4726.881827954311;4800.49594792547;4836.081144582536;4844.006978569402;4855.805767769302;3679.1537946272374;3753.0617345663586;3787.20468701573;4814.879628009293;4832.830850920219;5184.896302073957;5311.681299122065;5349.465053494659;5359.785608575652;5377.946220537823;4615.492295847454;4624.745638989854;4650.232711602582;4650.86047418578;4669.902572895367;15543.689126217412;15630.452934147364;18791.53021174468;19298.228070877147;19916.103775330146;1850.4633656239675;1870.149082167624;1881.332127094889;1903.9904800475908;1920.2127127877502;12104.394780260951;12411.627651170389;12423.875761242361;12437.129400941938;12909;1460.6859525202133;1483.6513419346445;1500.7973923520294;1554.6268895465007;1590.4115477273367;56408.43591564073;57113.42886571123;57448.138277925864;57582;58041.41958580445;5974.581779275409;6022.909656355158;6079.817605471843;6090.634561926298;8769.254613357936;7033.191183013917;7111.751088711871;7130.180029296594;7132.821679458055;7145.8928116078305;5076.82231121909;5092.643514953992;5117.820876269313;5168.250603662448;5175.094358487249;5368.194770784414;5418.133098704188;5446.128619420953;5455.972720136453;5471.835844924659;2716.2801857507775;2730.808843380984;2734.3437574981863;2781.763550098264;2791.52544067509;964.7009427077488;973.2408721197477;975.2685485885586;982.921366290695;1046.3460337289193;380.8895420328129;392.37808074202707;394.88548320987167;405.3231104056233;406.05186888614827;10391.740206494898;10431.321964072311;10594.755809618491;11337.376444295478;11367.772644547063;418.2889088549478;425.3407218810831;425.68073944541595;434.4807954494412;435.17099924643605;4800.3279540864305;5253.589803612991;5438.15708565173;5837.416258374214;5990.580659353804;416429;467566;468098;483123;503736;65057.34942650607;68396.6580167106;68441;68738;68798;434.44174236107085;434.79130017591734;435.1883736830788;436.1364498293397;436.74668692158474;9727.34336720277;10191.133753631024;10236.846447303446;10260.589576417158;10381.636642717469;31949.840250798596;32882.67117328796;33566.328673426884;33710.662893370754;34360.312793743484;42433.36349954815;43527;43539.346909797016;44942.77528612467;45163.322550161116;12303;12753.808692869428;13557.932210338886;13583.388747506584;14166.362513686703;16897.83102169012;16983.15084245758;17355.392561260294;17433.128343582517;17613;13591.728165436438;13747.518836840663;13873.58379248624;13905.304734763018;13946.511872084428;13130.212187268795;13143.737125257632;13204.075714700262;13393.732125357243;13659.931700341434;8566.35752318591;8850;8977.506237157018;14293.785593216318;14395.928020359832;12999.675008124872;13439.664008399868;13658.863411365759;14083.436662533384;14180.581941805736;11190.160737944523;11557.768844623228;12284.81572776427;13333.466661333438;13723.245221512912 01:12:28 INFO - 2015-12-02 01:12:28,838 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1166.0787977497778;1562.2969663651356;1636.108320965074;1641.6962861870552;1662.3184494357315;5927.614705044169;6156.846078848031;6346.904796428045;6499;6569.868602627945;6387.90418143727;6413.13422687937;6495.317991610884;6554.344565543443;6577.539572229945;1904.0384605774066;1926.2198809482181;1926.7398901148306;1929.6719557675158;1948.7758907725581;1959.8334141597982;1970.940871773849;1980.4157773456793;1996.7903370146144;2001.6296985057738;1913.5598812273186;1928.1034319041644;1929.411529483507;1930.3147382679158;1951.4145756273133;1885.0292099568733;1920.8655394122418;1921.1450904347432;1924.3553409607798;1927;1949.6783030799902;1965.9901700491405;1976.802319768026;1979.613975274822;1983.0877796213758;5830.47525722687;6403.679816009181;6452.580582262138;6500.089987401768;6500.869982600321;3730.869419570302;3982.8008599569907;4099.3031184698675;4101.52832424272;4147.025449019478;2403.2910291463886;2443.315871555967;2462.5444292805887;2475.5296493666324;2482.888270027853;768.7347864986571;783.0798811396643;783.0916137280727;798.5168972771447;805.0621026504116;8233.876491852627;8235.711750088778;8302.211289927447;8332.708355207538;8361.372897032747;3556.28874225156;3632.2372301816913;3721.1627383838963;3758.605346438639;3767.7362584618813;6916.273791251947;7059.788206353817;7060.858782824417;7126.2873712628325;7145.214026457085;4078.347464405681;4085.5097388313593;4090.1615168890307;4097.323941549671;4127.545969943304;3801.9429708554394;3807.333716599584;3811.4092315691114;3830.3871380578976;3835.884923452301;2884.653841538987;2908.06941778633;2928.2679330167457;2961.0968654560133;2963.525835866251;874.361715947362;891.3760367742606;891.527490430073;893.1871996483299;897.7755561109723;1151.5566506894907;1155.1163360029584;1173.9236949598248;1189.131933688395;1196.8444102266649;6250.562460627803;6263.71813268404;6278.46633036197;6307.4954003679595;6317.084022816666;977.8826540815147;1019.7501612105082;1045.6497073480318;1053.7629033467408;1066.424130969268;5095.388553373619;5099.515546023122;5103.311053007871;5150.948490515122;5150.948490515122;6782.9321706783285;7079.681414336367;7465.4027677786735;7498.850022999619;7589.051368578927;7611.314981651567;7678.731244406419;7706.460547761715;7710.884336734954;7732.342750866127;6142.754289828446;6230.221222347207;6241.687915604201;6278.905816412757;6301.936980630135;6241.438270555672;6304.71628776697;6331.810045698637;6334.904976425265;6384.329645387167;6913.619750913748;7068.045813815069;7096.0420343253;7136.750213742702;7179.066721326194;7005.299470052954;7178.8564228714085;7224.855502889807;7225.313595208447;7248.601326926859;6333;6406.1031455597185;6416.743330266924;6418.4865210783955;6421.261554921244;6363.6499992499;6414.069959855701;6435.903461447989;6441.742330306735;6469.320721324193;5956.225690660186;6049.969750151397;6050.909236361546;6083.117947897618;6116.021436570128;5809.477147056785;5832.125181222681;5845.503132233808;5895.41045895407;5926.259217597801;5752.626079304831;5787.247657804459;5790.884182316246;5793.623414478214;5842.065269557021;5153.639245252796;5253.159494481018;5254.65844720092;5266.262723218676;5315.2292917525965;5339.599530035185;5368.9463105370005;5373.731313434391;5377.354717433933;5433.320834895638 01:12:28 INFO - 2015-12-02 01:12:28,841 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.15998683810363;302.6368357970435;304.8384356291166;307.944569977404;312.97809153359276;5478.917816232754;5522.530584900283;5555.333359996806;5589.496945274925;5598.832035038945;5481.862953426166;5497.367802702691;5504.339479262484;5506.64206826557;5529.419410961851;4052.7568345899194;4248.001719595908;4254.106637606106;4262.744235345874;4284.571542845714;4165.791710414483;4174.70777045607;4213.073123912734;4234.047339348653;4234.491860976687;4123.505179378464;4176.227397931377;4183.414321994908;4184.121334519755;4214.473190851144;4018.839246430139;4125.278076336659;4142.316517774563;4148.751074935499;4160.33434650456;3635.4546817977252;3650.3064417760543;3662.414013757786;3678.6137455567045;3679.8344074516713;5232.502912223333;5235.6073294502685;5247.68513889164;5247.86880327991;5300.125479295912;4728.952710472886;4732.83435079774;4743.407074115736;4751.809927602892;4753.714777113384;5462.91805622912;5617.241672374218;5639.746211420496;5645.2096706461125;5735.2257445245195;4014.277430062617;4020.2763502569524;4026.396040593905;4036.535798383194;4060.4924384451942;6014.12795144706;6015.639061656271;6017.097435384683;6024.939750602525;6095.420935011167;4077.3680079587116;4093.1404405074672;4100.138970816162;4109.97945010273;4112.629863312316;3943.369060950234;3994.800259986989;4133.648639865645;4139.855105071308;4149.875503734893;4664.603508701731;4674.6260299176665;4676.532346765296;4679.578837904605;4692.319613656069;5684.829455116271;5703.429657034263;5708.229389032511;5709.400512946081;5730.828075157752;1414.1515090945556;1435.2034620785564;1440.4526280013529;1456.8980171388114;1457.6865973815682;922.4741897118712;935.4106912645126;945.4658118163353;950.6102497975935;959.4339339789558;5466.180072989004;5467.289252397242;5470.070088085035;5472.425395333512;5487.204355368529;5915.822525324161;5970.432808883149;5978.342382338026;6009.699515024231;6025.78909738157;5413.2692086568595;5457.072297709399;5465.262189604353;5481.890362192734;5496.477834605706;3222.113918672384;3278.7377009839156;3292.604887413526;3301.7028467437567;3310.2220978070136;6028.336882942873;6055.2430946131735;6061.181740464981;6075.027995520695;6094.75620975156;6148.9692551537855;6152.077188421773;6153.661548614779;6163.075538669146;6223.408776166257;5915.053591425265;6049.21360223177;6070.605410648293;6073.089036644538;6087.786927457518;5980.312264089685;5987.43119403656;5992.310884248192;6003.3996600339615;6003.909941350796;5827.125931110198;5845.18167456548;5868.149118377897;5898.997170481114;5930.733117009831;6025.939740602538;6050.757969681164;6062.787802426894;6128.019516877278;6128.417800308964;3975.363941769303;4031.637152656275;4038.333674943601;4062.106336605942;4072.20591984572;5956.851078723066;5960.8807823844145;5980.0431930890845;6004.8799024020145;6018.699065046818;5775.624584402;5786.103154011135;5789;5834.504067154339;5837.591368604157;5639;5749.281339832521;5817.825465236049;5840.357560668408;5850.356460789395;5690.829275121753;5708.400617935057;5739;5758.654480731169;5777.653340799566;5685.147227915846;5689.715514224189;5751.338596061507;5828.708564571839;5834.562407819515;5600.0759874620235;5642.238297829905;5645.858853528694;5724.513416359656;5724.885502289848 01:12:28 INFO - 2015-12-02 01:12:28,841 DEBUG : BROWSER_OUTPUT: |5;yui.html;639.4372951802413;691.7993781803276;705.4180301251467;709.5246185056012;712.7754757251465;11718.414079296033;12057.336846473441;12115.212511186777;12168;12255.264684118947;13103.148295360796;13254.602361929134;13276.933615331935;13301.534446294381;13388.330583470835;646.3923911523177;776.0609662308614;781.7850091224901;782.1318336646318;784.619459562112;652.4943169044005;772.289493665826;798.4171554765026;804.859149648812;808.3654331349892;810.3193317613204;816.5957850863801;817.9468334558264;827.5407149032285;827.7103013945101;661.8312330355728;668.7157957867887;807.9192080791933;814.3241109878786;817.1705718695529;603.1314906534576;603.9426254505815;604.7973928733879;607.729560345642;612.5375341617095;11620.360880151587;11639.94180029103;11651.76696466066;11793.11551633631;11813.527458901719;8155.143709910433;8574.614142363609;8659.696910608161;8660.523671198082;8935;7737.226277372218;7927.563983980879;7953.4432589718745;8125.228103330174;8281.83436331276;2617.358747106971;2674.7726443252345;2714.3892624159603;2738.698743138253;2759.9724002760117;43061;43226.56773432257;43754.78122609366;43910.12179756387;44309.11381772347;6166.630002199882;6370.0763389308295;6373;6537.640429776408;6564.4748420127235;11121.499532520895;11204.831927521094;11248.493817778219;11268.154888383404;11298.548058077586;5290;5367.973160134253;5449.855530338673;5472.808451704251;5615.466530679579;3326.5841769778776;3371.140359208386;3406.5230867678547;3433.570803649544;3508.245727168671;2438.6585877977095;2441.597136472498;2443.2792326263793;2446.8287219894437;2471.431570738704;346.599677372635;349.49497975425777;353.07494364764483;372.3929994109584;376.2606478270212;393.54348955211816;420.54791099568087;454.1212753322332;484.5493690867527;534.657818995843;7403.370713489414;7522.3605993491165;7558.924410755932;7711;7856.292933636;434.8391095294761;452.57005844447906;485.50721018166587;505.43391401629674;526.9947300526945;3157.4790159623863;3208.342289830579;3240.060382489099;3244.23760416302;3268.1339445047083;48179.03641927142;50062.749686251336;50089.24866126938;50170;50516;46885;47537.286940695914;47739.76130119397;47767.522324777005;48007.519924800305;43306;43475.56524434778;43557.34663980043;43596.346054809204;44069.33895991627;6358.237011558643;7130.893036604559;7367.839930767951;7415.258474152542;7453.105627324756;32926.34147317088;33101.33797324088;33439;33571.83214084012;33753.3249335007;38340.42489362606;38799.224015518965;43839;43858.34212486879;43946.34080488859;7076.150861896605;7173.426125910019;7348.827950032392;7394.55632662042;7409.407247420086;9555.61777528891;9897.65358212459;10165.898341016495;10208.489575521045;10391.792164156523;9003.63985440575;9016.504092274989;9099.49952752605;9580.233581313618;9608.039196080335;9285.117913798178;9388.483633400228;9736.123748862636;9775.755606109904;9804.313698041069;9260.536973151451;9294.163525282756;9346.813063738551;9443.102905223992;9447;7946.443748937751;8113.310368618733;8357.540335281617;8429.662813487392;8577.785555361166;7798.766037018899;7986.520808751494;8078.115405927536;8197.79505512367;8290.502569845828 01:12:28 INFO - 2015-12-02 01:12:28,841 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:28 INFO - 2015-12-02 01:12:28,842 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:12:28 INFO - 2015-12-02 01:12:28,842 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1181 01:12:28 INFO - 2015-12-02 01:12:28,842 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:12:28 INFO - 2015-12-02 01:12:28,842 DEBUG : BROWSER_OUTPUT: __startTimestamp1449047548828__endTimestamp 01:12:28 INFO - 2015-12-02 01:12:28,842 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,842 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:28 INFO - 2015-12-02 01:12:28,843 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:12:28 INFO - 2015-12-02 01:12:28,843 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,843 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4877.79 Median:5008.82 stddev:536.11 (10.7%) stddev-sans-first:513.03 01:12:28 INFO - 2015-12-02 01:12:28,844 DEBUG : BROWSER_OUTPUT: Values: 2826.2 2901.4 2905.6 2916.4 2916.9 4857.8 4867.3 4870.3 4871.6 4885.4 4833.2 4844.6 4878.4 4887.1 4918.4 4391.2 4479.4 4498.7 4525.5 4551.9 4439.2 4479.2 4547.4 4569.1 4599.5 4540.3 4543.8 4548.8 4553.9 4591.1 4536.5 4571.6 4583.9 4608.1 4628.0 4228.0 4309.1 4404.2 4466.5 4485.6 4775.4 4836.2 4847.9 4850.4 4858.1 5186.7 5194.9 5214.8 5252.5 5266.8 5082.2 5128.6 5202.1 5255.9 5335.5 4941.5 4952.5 4982.5 5010.2 5022.3 5455.0 5463.8 5472.3 5485.1 5498.7 4882.1 4895.4 4942.5 4989.1 5091.7 5259.1 5336.9 5358.9 5365.4 5369.5 5205.3 5278.6 5286.5 5300.5 5332.1 4933.5 5046.6 5088.9 5097.9 5136.2 4016.3 4056.2 4086.5 4105.6 4124.2 3679.2 3688.0 3693.0 3706.9 3736.9 4742.7 4787.4 4854.9 4858.5 4889.2 5122.5 5209.6 5210.2 5215.6 5220.3 4888.2 4913.8 4996.6 4999.8 5013.3 4332.4 4435.3 4461.6 4626.4 4727.0 5284.7 5387.4 5439.9 5449.6 5476.9 5368.2 5408.5 5425.9 5440.9 5462.1 5135.5 5275.8 5292.7 5421.5 5474.6 5125.2 5296.8 5303.9 5305.2 5327.0 5113.6 5314.0 5362.2 5371.1 5372.0 4926.6 5032.3 5037.1 5199.0 5240.9 5014.8 5033.6 5067.7 5069.8 5085.3 4860.2 4930.4 4955.5 4964.7 5020.1 5153.7 5193.2 5264.1 5266.8 5277.3 5008.8 5095.7 5146.9 5159.7 5169.1 01:12:28 INFO - 2015-12-02 01:12:28,844 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,845 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40358.41 Median:31157.95 stddev:62432.59 (200.4%) stddev-sans-first:62536.02 01:12:28 INFO - 2015-12-02 01:12:28,846 DEBUG : BROWSER_OUTPUT: Values: 507.1 512.6 515.9 517.7 539.9 27429.9 30005.0 37378.3 37579.0 37771.6 40365.4 40453.6 40475.8 40571.6 40938.0 7567.8 8220.6 8446.7 8477.0 8556.0 7691.5 9878.5 10153.6 10156.6 10194.3 9839.2 9880.4 9915.0 9955.2 10058.3 7809.6 7985.5 9880.5 10046.2 10069.3 9746.6 9882.7 9885.7 9911.5 9994.3 36722.0 37120.6 37175.0 37203.0 37205.4 2693.4 2741.2 2763.6 3172.4 3274.7 24712.9 25467.6 25831.7 25852.5 26524.3 2170.9 2179.2 2180.5 2192.9 2217.0 252410.0 254337.0 254536.0 256979.0 258265.0 42101.2 52549.7 52838.7 53301.7 53485.0 47359.0 61671.4 63466.0 63474.4 64240.7 16012.2 16178.9 16375.9 16388.1 16398.2 11557.1 11746.6 11766.2 11883.7 11914.6 18841.2 19007.2 19092.9 19201.4 19307.7 7701.7 7810.6 7874.0 7927.1 7947.4 783.4 925.0 963.9 976.5 1012.2 26096.2 26215.3 26273.3 26355.7 26461.2 876.1 945.1 950.7 975.8 1016.7 12796.2 13324.1 13487.5 13542.8 13674.3 217867.0 222982.0 224529.0 224587.0 224782.0 42954.0 43583.3 45201.0 46152.3 50424.7 1307.1 1317.8 1318.5 1320.0 1330.7 25259.4 25788.9 26758.0 26945.0 27956.9 41651.6 42396.6 49527.0 49918.5 50696.0 238073.0 239208.0 242027.0 242039.0 244318.0 27244.7 27922.0 28741.6 29099.0 29265.7 38660.0 40114.4 40669.4 41309.8 41310.0 30755.5 32024.0 32663.8 32687.8 33063.2 29612.9 29986.6 30016.0 30260.7 31833.5 31879.4 33171.3 33184.8 33523.8 33722.8 26007.6 29269.3 29294.4 31560.4 31748.7 21495.7 21639.9 21790.2 21841.3 22158.9 01:12:28 INFO - 2015-12-02 01:12:28,846 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,846 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25318.33 Median:386.63 stddev:76659.99 (19827.5%) stddev-sans-first:76852.04 01:12:28 INFO - 2015-12-02 01:12:28,847 DEBUG : BROWSER_OUTPUT: Values: 308.9 317.5 319.7 319.9 326.2 15461.0 16107.5 16219.8 16660.1 16881.7 16093.7 16873.2 16928.8 17094.7 17098.6 4629.5 4734.2 4752.0 4803.6 4815.6 4726.9 4800.5 4836.1 4844.0 4855.8 3679.2 3753.1 3787.2 4814.9 4832.8 5184.9 5311.7 5349.5 5359.8 5377.9 4615.5 4624.7 4650.2 4650.9 4669.9 15543.7 15630.5 18791.5 19298.2 19916.1 1850.5 1870.1 1881.3 1904.0 1920.2 12104.4 12411.6 12423.9 12437.1 12909.0 1460.7 1483.7 1500.8 1554.6 1590.4 56408.4 57113.4 57448.1 57582.0 58041.4 5974.6 6022.9 6079.8 6090.6 8769.3 7033.2 7111.8 7130.2 7132.8 7145.9 5076.8 5092.6 5117.8 5168.3 5175.1 5368.2 5418.1 5446.1 5456.0 5471.8 2716.3 2730.8 2734.3 2781.8 2791.5 964.7 973.2 975.3 982.9 1046.3 380.9 392.4 394.9 405.3 406.1 10391.7 10431.3 10594.8 11337.4 11367.8 418.3 425.3 425.7 434.5 435.2 4800.3 5253.6 5438.2 5837.4 5990.6 416429.0 467566.0 468098.0 483123.0 503736.0 65057.3 68396.7 68441.0 68738.0 68798.0 434.4 434.8 435.2 436.1 436.7 9727.3 10191.1 10236.8 10260.6 10381.6 31949.8 32882.7 33566.3 33710.7 34360.3 42433.4 43527.0 43539.3 44942.8 45163.3 12303.0 12753.8 13557.9 13583.4 14166.4 16897.8 16983.2 17355.4 17433.1 17613.0 13591.7 13747.5 13873.6 13905.3 13946.5 13130.2 13143.7 13204.1 13393.7 13659.9 8566.4 8850.0 8977.5 14293.8 14395.9 12999.7 13439.7 13658.9 14083.4 14180.6 11190.2 11557.8 12284.8 13333.5 13723.2 01:12:28 INFO - 2015-12-02 01:12:28,848 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,848 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4582.30 Median:5837.10 stddev:2287.47 (39.2%) stddev-sans-first:2279.47 01:12:28 INFO - 2015-12-02 01:12:28,849 DEBUG : BROWSER_OUTPUT: Values: 1166.1 1562.3 1636.1 1641.7 1662.3 5927.6 6156.8 6346.9 6499.0 6569.9 6387.9 6413.1 6495.3 6554.3 6577.5 1904.0 1926.2 1926.7 1929.7 1948.8 1959.8 1970.9 1980.4 1996.8 2001.6 1913.6 1928.1 1929.4 1930.3 1951.4 1885.0 1920.9 1921.1 1924.4 1927.0 1949.7 1966.0 1976.8 1979.6 1983.1 5830.5 6403.7 6452.6 6500.1 6500.9 3730.9 3982.8 4099.3 4101.5 4147.0 2403.3 2443.3 2462.5 2475.5 2482.9 768.7 783.1 783.1 798.5 805.1 8233.9 8235.7 8302.2 8332.7 8361.4 3556.3 3632.2 3721.2 3758.6 3767.7 6916.3 7059.8 7060.9 7126.3 7145.2 4078.3 4085.5 4090.2 4097.3 4127.5 3801.9 3807.3 3811.4 3830.4 3835.9 2884.7 2908.1 2928.3 2961.1 2963.5 874.4 891.4 891.5 893.2 897.8 1151.6 1155.1 1173.9 1189.1 1196.8 6250.6 6263.7 6278.5 6307.5 6317.1 977.9 1019.8 1045.6 1053.8 1066.4 5095.4 5099.5 5103.3 5150.9 5150.9 6782.9 7079.7 7465.4 7498.9 7589.1 7611.3 7678.7 7706.5 7710.9 7732.3 6142.8 6230.2 6241.7 6278.9 6301.9 6241.4 6304.7 6331.8 6334.9 6384.3 6913.6 7068.0 7096.0 7136.8 7179.1 7005.3 7178.9 7224.9 7225.3 7248.6 6333.0 6406.1 6416.7 6418.5 6421.3 6363.6 6414.1 6435.9 6441.7 6469.3 5956.2 6050.0 6050.9 6083.1 6116.0 5809.5 5832.1 5845.5 5895.4 5926.3 5752.6 5787.2 5790.9 5793.6 5842.1 5153.6 5253.2 5254.7 5266.3 5315.2 5339.6 5368.9 5373.7 5377.4 5433.3 01:12:28 INFO - 2015-12-02 01:12:28,849 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,849 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4820.43 Median:5514.59 stddev:1452.02 (26.3%) stddev-sans-first:1415.72 01:12:28 INFO - 2015-12-02 01:12:28,851 DEBUG : BROWSER_OUTPUT: Values: 290.2 302.6 304.8 307.9 313.0 5478.9 5522.5 5555.3 5589.5 5598.8 5481.9 5497.4 5504.3 5506.6 5529.4 4052.8 4248.0 4254.1 4262.7 4284.6 4165.8 4174.7 4213.1 4234.0 4234.5 4123.5 4176.2 4183.4 4184.1 4214.5 4018.8 4125.3 4142.3 4148.8 4160.3 3635.5 3650.3 3662.4 3678.6 3679.8 5232.5 5235.6 5247.7 5247.9 5300.1 4729.0 4732.8 4743.4 4751.8 4753.7 5462.9 5617.2 5639.7 5645.2 5735.2 4014.3 4020.3 4026.4 4036.5 4060.5 6014.1 6015.6 6017.1 6024.9 6095.4 4077.4 4093.1 4100.1 4110.0 4112.6 3943.4 3994.8 4133.6 4139.9 4149.9 4664.6 4674.6 4676.5 4679.6 4692.3 5684.8 5703.4 5708.2 5709.4 5730.8 1414.2 1435.2 1440.5 1456.9 1457.7 922.5 935.4 945.5 950.6 959.4 5466.2 5467.3 5470.1 5472.4 5487.2 5915.8 5970.4 5978.3 6009.7 6025.8 5413.3 5457.1 5465.3 5481.9 5496.5 3222.1 3278.7 3292.6 3301.7 3310.2 6028.3 6055.2 6061.2 6075.0 6094.8 6149.0 6152.1 6153.7 6163.1 6223.4 5915.1 6049.2 6070.6 6073.1 6087.8 5980.3 5987.4 5992.3 6003.4 6003.9 5827.1 5845.2 5868.1 5899.0 5930.7 6025.9 6050.8 6062.8 6128.0 6128.4 3975.4 4031.6 4038.3 4062.1 4072.2 5956.9 5960.9 5980.0 6004.9 6018.7 5775.6 5786.1 5789.0 5834.5 5837.6 5639.0 5749.3 5817.8 5840.4 5850.4 5690.8 5708.4 5739.0 5758.7 5777.7 5685.1 5689.7 5751.3 5828.7 5834.6 5600.1 5642.2 5645.9 5724.5 5724.9 01:12:28 INFO - 2015-12-02 01:12:28,851 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-02 01:12:28,851 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11960.82 Median:5461.33 stddev:14723.44 (269.6%) stddev-sans-first:14740.19 01:12:28 INFO - 2015-12-02 01:12:28,852 DEBUG : BROWSER_OUTPUT: Values: 639.4 691.8 705.4 709.5 712.8 11718.4 12057.3 12115.2 12168.0 12255.3 13103.1 13254.6 13276.9 13301.5 13388.3 646.4 776.1 781.8 782.1 784.6 652.5 772.3 798.4 804.9 808.4 810.3 816.6 817.9 827.5 827.7 661.8 668.7 807.9 814.3 817.2 603.1 603.9 604.8 607.7 612.5 11620.4 11639.9 11651.8 11793.1 11813.5 8155.1 8574.6 8659.7 8660.5 8935.0 7737.2 7927.6 7953.4 8125.2 8281.8 2617.4 2674.8 2714.4 2738.7 2760.0 43061.0 43226.6 43754.8 43910.1 44309.1 6166.6 6370.1 6373.0 6537.6 6564.5 11121.5 11204.8 11248.5 11268.2 11298.5 5290.0 5368.0 5449.9 5472.8 5615.5 3326.6 3371.1 3406.5 3433.6 3508.2 2438.7 2441.6 2443.3 2446.8 2471.4 346.6 349.5 353.1 372.4 376.3 393.5 420.5 454.1 484.5 534.7 7403.4 7522.4 7558.9 7711.0 7856.3 434.8 452.6 485.5 505.4 527.0 3157.5 3208.3 3240.1 3244.2 3268.1 48179.0 50062.7 50089.2 50170.0 50516.0 46885.0 47537.3 47739.8 47767.5 48007.5 43306.0 43475.6 43557.3 43596.3 44069.3 6358.2 7130.9 7367.8 7415.3 7453.1 32926.3 33101.3 33439.0 33571.8 33753.3 38340.4 38799.2 43839.0 43858.3 43946.3 7076.2 7173.4 7348.8 7394.6 7409.4 9555.6 9897.7 10165.9 10208.5 10391.8 9003.6 9016.5 9099.5 9580.2 9608.0 9285.1 9388.5 9736.1 9775.8 9804.3 9260.5 9294.2 9346.8 9443.1 9447.0 7946.4 8113.3 8357.5 8429.7 8577.8 7798.8 7986.5 8078.1 8197.8 8290.5 01:12:28 INFO - 2015-12-02 01:12:28,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:28 INFO - 2015-12-02 01:12:28,852 DEBUG : BROWSER_OUTPUT: 01:12:29 INFO - 2015-12-02 01:12:29,516 INFO : Browser exited with error code: 0 01:12:29 INFO - 2015-12-02 01:12:29,547 INFO : Completed test dromaeo_css (00:18:34) 01:12:29 INFO - 2015-12-02 01:12:29,547 INFO : Starting test kraken 01:12:29 INFO - 2015-12-02 01:12:29,547 DEBUG : operating with platform_type : mac_ 01:12:29 INFO - 2015-12-02 01:12:29,547 INFO : Initialising browser for kraken test... 01:12:29 INFO - 2015-12-02 01:12:29,562 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpZ0536I/profile http://localhost:49269/getInfo.html 01:12:31 INFO - 2015-12-02 01:12:31,883 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:31 INFO - 2015-12-02 01:12:31,883 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:31 INFO - 2015-12-02 01:12:31,883 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:12:31 INFO - 2015-12-02 01:12:31,883 DEBUG : BROWSER_OUTPUT: __metrics 01:12:31 INFO - 2015-12-02 01:12:31,900 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:12:32 INFO - 2015-12-02 01:12:32,582 INFO : Browser initialized. 01:12:32 INFO - 2015-12-02 01:12:32,582 INFO : Running cycle 1/1 for kraken test... 01:12:32 INFO - 2015-12-02 01:12:32,583 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpZ0536I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:12:44 INFO - 2015-12-02 01:12:44,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 198082560 01:12:44 INFO - 2015-12-02 01:12:44,530 DEBUG : BROWSER_OUTPUT: 01:12:47 INFO - 2015-12-02 01:12:47,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:47 INFO - 2015-12-02 01:12:47,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 267026432 01:12:47 INFO - 2015-12-02 01:12:47,905 DEBUG : BROWSER_OUTPUT: 01:12:50 INFO - 2015-12-02 01:12:50,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 01:12:51 INFO - 2015-12-02 01:12:51,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 281292800 01:12:51 INFO - 2015-12-02 01:12:51,379 DEBUG : BROWSER_OUTPUT: 01:12:54 INFO - 2015-12-02 01:12:54,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 01:12:55 INFO - 2015-12-02 01:12:55,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 267001856 01:12:55 INFO - 2015-12-02 01:12:55,071 DEBUG : BROWSER_OUTPUT: 01:12:57 INFO - 2015-12-02 01:12:57,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 01:12:57 INFO - 2015-12-02 01:12:57,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 267599872 01:12:57 INFO - 2015-12-02 01:12:57,879 DEBUG : BROWSER_OUTPUT: 01:13:00 INFO - 2015-12-02 01:13:00,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:13:00 INFO - 2015-12-02 01:13:00,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 268222464 01:13:00 INFO - 2015-12-02 01:13:00,842 DEBUG : BROWSER_OUTPUT: 01:13:04 INFO - 2015-12-02 01:13:04,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 01:13:04 INFO - 2015-12-02 01:13:04,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 268312576 01:13:04 INFO - 2015-12-02 01:13:04,781 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-12-02 01:13:08,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 01:13:08 INFO - 2015-12-02 01:13:08,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 268873728 01:13:08 INFO - 2015-12-02 01:13:08,801 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-12-02 01:13:11,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 01:13:12 INFO - 2015-12-02 01:13:12,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 268312576 01:13:12 INFO - 2015-12-02 01:13:12,530 DEBUG : BROWSER_OUTPUT: 01:13:14 INFO - 2015-12-02 01:13:14,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:13:14 INFO - 2015-12-02 01:13:14,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 303009792 01:13:14 INFO - 2015-12-02 01:13:14,812 DEBUG : BROWSER_OUTPUT: 01:13:16 INFO - 2015-12-02 01:13:16,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:13:17 INFO - 2015-12-02 01:13:17,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 302276608 01:13:17 INFO - 2015-12-02 01:13:17,377 DEBUG : BROWSER_OUTPUT: 01:13:19 INFO - 2015-12-02 01:13:19,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:13:20 INFO - 2015-12-02 01:13:20,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 310763520 01:13:20 INFO - 2015-12-02 01:13:20,190 DEBUG : BROWSER_OUTPUT: 01:13:22 INFO - 2015-12-02 01:13:22,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:13:23 INFO - 2015-12-02 01:13:23,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 312557568 01:13:23 INFO - 2015-12-02 01:13:23,569 DEBUG : BROWSER_OUTPUT: 01:13:26 INFO - 2015-12-02 01:13:26,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:26 INFO - 2015-12-02 01:13:26,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 313090048 01:13:26 INFO - 2015-12-02 01:13:26,942 DEBUG : BROWSER_OUTPUT: 01:13:28 INFO - 2015-12-02 01:13:28,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 01:13:29 INFO - 2015-12-02 01:13:29,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 371597312 01:13:29 INFO - 2015-12-02 01:13:29,041 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,041 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:29 INFO - 2015-12-02 01:13:29,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:29 INFO - 2015-12-02 01:13:29,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:29 INFO - 2015-12-02 01:13:29,041 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:29 INFO - 2015-12-02 01:13:29,042 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;116;119;128;120;124;123;123;112;125 01:13:29 INFO - 2015-12-02 01:13:29,042 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;176;152;185;174;140;168;144;178;164;144 01:13:29 INFO - 2015-12-02 01:13:29,042 DEBUG : BROWSER_OUTPUT: |2;audio-dft;181;204;185;181;180;181;181;181;180;181 01:13:29 INFO - 2015-12-02 01:13:29,042 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;90;86;134;77;83;82;78;130;73 01:13:29 INFO - 2015-12-02 01:13:29,042 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;110;160;103;104;101;142;98;106;148 01:13:29 INFO - 2015-12-02 01:13:29,042 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;135;140;130;130;142;135;135;130;135 01:13:29 INFO - 2015-12-02 01:13:29,043 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;146;143;140;139;147;143;140;140;147 01:13:29 INFO - 2015-12-02 01:13:29,043 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;118;118;115;113;117;118;118;114;112 01:13:29 INFO - 2015-12-02 01:13:29,043 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;67;70;70;69;69;72;82;66;65 01:13:29 INFO - 2015-12-02 01:13:29,043 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;72;72;73;74;76;76;76;73;73 01:13:29 INFO - 2015-12-02 01:13:29,043 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;92;96;96;95;95;92;92;96;97 01:13:29 INFO - 2015-12-02 01:13:29,043 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;140;139;147;139;139;135;147;140;140 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;165;169;168;162;151;164;162;170;170 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;77;76;79;80;81;78;77;76;78 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,919 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:13:29 INFO - 2015-12-02 01:13:29,044 DEBUG : BROWSER_OUTPUT: __startTimestamp1449047609038__endTimestamp 01:13:29 INFO - 2015-12-02 01:13:29,045 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,045 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:29 INFO - 2015-12-02 01:13:29,045 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:13:29 INFO - 2015-12-02 01:13:29,045 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,045 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:121.10 Median:123.00 stddev:4.63 (3.8%) stddev-sans-first:4.91 01:13:29 INFO - 2015-12-02 01:13:29,045 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 119.0 128.0 120.0 124.0 123.0 123.0 112.0 125.0 01:13:29 INFO - 2015-12-02 01:13:29,046 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,046 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:162.50 Median:171.00 stddev:16.31 (9.5%) stddev-sans-first:16.55 01:13:29 INFO - 2015-12-02 01:13:29,046 DEBUG : BROWSER_OUTPUT: Values: 176.0 152.0 185.0 174.0 140.0 168.0 144.0 178.0 164.0 144.0 01:13:29 INFO - 2015-12-02 01:13:29,046 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,047 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.50 Median:181.00 stddev:7.34 (4.1%) stddev-sans-first:7.73 01:13:29 INFO - 2015-12-02 01:13:29,047 DEBUG : BROWSER_OUTPUT: Values: 181.0 204.0 185.0 181.0 180.0 181.0 181.0 181.0 180.0 181.0 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.60 Median:82.50 stddev:21.83 (26.5%) stddev-sans-first:22.94 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: Values: 83.0 90.0 86.0 134.0 77.0 83.0 82.0 78.0 130.0 73.0 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.00 Median:126.00 stddev:22.75 (18.1%) stddev-sans-first:23.84 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 160.0 103.0 104.0 101.0 142.0 98.0 106.0 148.0 01:13:29 INFO - 2015-12-02 01:13:29,048 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,049 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.80 Median:135.00 stddev:4.08 (3.0%) stddev-sans-first:4.30 01:13:29 INFO - 2015-12-02 01:13:29,049 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 140.0 130.0 130.0 142.0 135.0 135.0 130.0 135.0 01:13:29 INFO - 2015-12-02 01:13:29,049 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,049 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:142.60 Median:143.00 stddev:3.10 (2.2%) stddev-sans-first:3.23 01:13:29 INFO - 2015-12-02 01:13:29,049 DEBUG : BROWSER_OUTPUT: Values: 141.0 146.0 143.0 140.0 139.0 147.0 143.0 140.0 140.0 147.0 01:13:29 INFO - 2015-12-02 01:13:29,050 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,050 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:115.80 Median:117.50 stddev:2.30 (2.0%) stddev-sans-first:2.42 01:13:29 INFO - 2015-12-02 01:13:29,050 DEBUG : BROWSER_OUTPUT: Values: 115.0 118.0 118.0 115.0 113.0 117.0 118.0 118.0 114.0 112.0 01:13:29 INFO - 2015-12-02 01:13:29,050 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,050 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.50 stddev:5.21 (7.5%) stddev-sans-first:5.00 01:13:29 INFO - 2015-12-02 01:13:29,051 DEBUG : BROWSER_OUTPUT: Values: 63.0 67.0 70.0 70.0 69.0 69.0 72.0 82.0 66.0 65.0 01:13:29 INFO - 2015-12-02 01:13:29,051 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,051 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:73.50 stddev:2.01 (2.7%) stddev-sans-first:1.69 01:13:29 INFO - 2015-12-02 01:13:29,051 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 72.0 73.0 74.0 76.0 76.0 76.0 73.0 73.0 01:13:29 INFO - 2015-12-02 01:13:29,051 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,051 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:95.50 stddev:2.81 (2.9%) stddev-sans-first:2.01 01:13:29 INFO - 2015-12-02 01:13:29,053 DEBUG : BROWSER_OUTPUT: Values: 88.0 92.0 96.0 96.0 95.0 95.0 92.0 92.0 96.0 97.0 01:13:29 INFO - 2015-12-02 01:13:29,053 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,053 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:140.00 stddev:3.86 (2.8%) stddev-sans-first:3.91 01:13:29 INFO - 2015-12-02 01:13:29,053 DEBUG : BROWSER_OUTPUT: Values: 137.0 140.0 139.0 147.0 139.0 139.0 135.0 147.0 140.0 140.0 01:13:29 INFO - 2015-12-02 01:13:29,053 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:166.50 stddev:5.68 (3.4%) stddev-sans-first:6.00 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 169.0 168.0 162.0 151.0 164.0 162.0 170.0 170.0 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:78.00 stddev:1.89 (2.4%) stddev-sans-first:1.73 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: Values: 75.0 77.0 76.0 79.0 80.0 81.0 78.0 77.0 76.0 78.0 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:29 INFO - 2015-12-02 01:13:29,054 DEBUG : BROWSER_OUTPUT: 01:13:29 INFO - 2015-12-02 01:13:29,718 INFO : Browser exited with error code: 0 01:13:29 INFO - 2015-12-02 01:13:29,772 INFO : Completed test kraken (00:01:00) 01:13:29 INFO - 2015-12-02 01:13:29,772 INFO : Starting test v8_7 01:13:29 INFO - 2015-12-02 01:13:29,772 DEBUG : operating with platform_type : mac_ 01:13:29 INFO - 2015-12-02 01:13:29,772 INFO : Initialising browser for v8_7 test... 01:13:29 INFO - 2015-12-02 01:13:29,787 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpocJDl7/profile http://localhost:49269/getInfo.html 01:13:32 INFO - 2015-12-02 01:13:32,044 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:13:32 INFO - 2015-12-02 01:13:32,044 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:13:32 INFO - 2015-12-02 01:13:32,044 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:13:32 INFO - 2015-12-02 01:13:32,044 DEBUG : BROWSER_OUTPUT: __metrics 01:13:32 INFO - 2015-12-02 01:13:32,060 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:13:32 INFO - 2015-12-02 01:13:32,744 INFO : Browser initialized. 01:13:32 INFO - 2015-12-02 01:13:32,744 INFO : Running cycle 1/1 for v8_7 test... 01:13:32 INFO - 2015-12-02 01:13:32,744 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpocJDl7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:13:44 INFO - 2015-12-02 01:13:44,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 202813440 01:13:44 INFO - 2015-12-02 01:13:44,697 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 01:14:07 INFO - 2015-12-02 01:14:07,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 516063232 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |0;Richards;198.96538002387584 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;215.7497303128371 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.4022406938923 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6611.8421052631575 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1156.0693641618498 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |5;Earley;773.9938080495356 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |6;Boyer;14098.591549295774 01:14:07 INFO - 2015-12-02 01:14:07,773 DEBUG : BROWSER_OUTPUT: |7;RegExp;33459.016393442624 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: |8;Splay;673.8544474393531 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6448.717948717948 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: __startTimestamp1449047647767__endTimestamp 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:198.97 Median:198.97 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: Values: 199.0 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:215.75 Median:215.75 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: Values: 215.7 01:14:07 INFO - 2015-12-02 01:14:07,774 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.40 Median:361.40 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: Values: 361.4 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6611.84 Median:6611.84 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: Values: 6611.8 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1156.07 Median:1156.07 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: Values: 1156.1 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:773.99 Median:773.99 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: Values: 774.0 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14098.59 Median:14098.59 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,775 DEBUG : BROWSER_OUTPUT: Values: 14098.6 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33459.02 Median:33459.02 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: Values: 33459.0 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:673.85 Median:673.85 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: Values: 673.9 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6448.72 Median:6448.72 stddev:0.00 (0.0%) 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: Values: 6448.7 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:14:07 INFO - 2015-12-02 01:14:07,776 DEBUG : BROWSER_OUTPUT: 01:14:08 INFO - 2015-12-02 01:14:08,373 INFO : Browser exited with error code: 0 01:14:08 INFO - 2015-12-02 01:14:08,396 INFO : Completed test v8_7 (00:00:38) 01:14:08 INFO - 2015-12-02 01:14:08,565 INFO : Completed test suite (00:20:13) 01:14:08 INFO - 2015-12-02 01:14:08,565 DEBUG : Working with test: dromaeo_css 01:14:08 INFO - 2015-12-02 01:14:08,565 DEBUG : Generating results file: dromaeo_css 01:14:08 INFO - 2015-12-02 01:14:08,566 DEBUG : Working with test: kraken 01:14:08 INFO - 2015-12-02 01:14:08,566 DEBUG : Generating results file: kraken 01:14:08 INFO - 2015-12-02 01:14:08,566 INFO : javascript benchmark 01:14:08 INFO - 2015-12-02 01:14:08,566 DEBUG : Working with test: v8_7 01:14:08 INFO - 2015-12-02 01:14:08,567 DEBUG : Generating results file: v8_7 01:14:08 INFO - 2015-12-02 01:14:08,567 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:14:08 INFO - 2015-12-02 01:14:08,619 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 01:14:08 INFO - 2015-12-02 01:14:08,619 DEBUG : process_Request line: dromaeo_css 6077.04 graph.html#tests=[[72,52,55]] 01:14:08 INFO - 2015-12-02 01:14:08,619 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:14:08 INFO - 2015-12-02 01:14:08,647 DEBUG : process_Request line: kraken 1689.00 graph.html#tests=[[232,52,55]] 01:14:08 INFO - 2015-12-02 01:14:08,647 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:14:08 INFO - 2015-12-02 01:14:08,678 DEBUG : process_Request line: v8_7 17885.86 graph.html#tests=[[230,52,55]] 01:14:08 INFO - 2015-12-02 01:14:08,679 INFO : javascript benchmark 01:14:08 INFO - 2015-12-02 01:14:08,681 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [308.8532946850245, 317.5189587774522, 319.6547728453272, 319.85606477085315, 326.2349789743052, 15461.0, 16107.51677449677, 16219.83780162198, 16660.08369539675, 16881.746773798404, 16093.678126437464, 16873.24070416831, 16928.83071169288, 17094.658106837855, 17098.572535686613, 4629.490756016836, 4734.195186818232, 4751.952480475203, 4803.615710743132, 4815.614750819944, 4726.881827954311, 4800.49594792547, 4836.081144582536, 4844.006978569402, 4855.805767769302, 3679.1537946272374, 3753.0617345663586, 3787.20468701573, 4814.879628009293, 4832.830850920219, 5184.896302073957, 5311.681299122065, 5349.465053494659, 5359.785608575652, 5377.946220537823, 4615.492295847454, 4624.745638989854, 4650.232711602582, 4650.86047418578, 4669.902572895367, 15543.689126217412, 15630.452934147364, 18791.53021174468, 19298.228070877147, 19916.103775330146, 1850.4633656239675, 1870.149082167624, 1881.332127094889, 1903.9904800475908, 1920.2127127877502, 12104.394780260951, 12411.627651170389, 12423.875761242361, 12437.129400941938, 12909.0, 1460.6859525202133, 1483.6513419346445, 1500.7973923520294, 1554.6268895465007, 1590.4115477273367, 56408.43591564073, 57113.42886571123, 57448.138277925864, 57582.0, 58041.41958580445, 5974.581779275409, 6022.909656355158, 6079.817605471843, 6090.634561926298, 8769.254613357936, 7033.191183013917, 7111.751088711871, 7130.180029296594, 7132.821679458055, 7145.8928116078305, 5076.82231121909, 5092.643514953992, 5117.820876269313, 5168.250603662448, 5175.094358487249, 5368.194770784414, 5418.133098704188, 5446.128619420953, 5455.972720136453, 5471.835844924659, 2716.2801857507775, 2730.808843380984, 2734.3437574981863, 2781.763550098264, 2791.52544067509, 964.7009427077488, 973.2408721197477, 975.2685485885586, 982.921366290695, 1046.3460337289193, 380.8895420328129, 392.37808074202707, 394.88548320987167, 405.3231104056233, 406.05186888614827, 10391.740206494898, 10431.321964072311, 10594.755809618491, 11337.376444295478, 11367.772644547063, 418.2889088549478, 425.3407218810831, 425.68073944541595, 434.4807954494412, 435.17099924643605, 4800.3279540864305, 5253.589803612991, 5438.15708565173, 5837.416258374214, 5990.580659353804, 416429.0, 467566.0, 468098.0, 483123.0, 503736.0, 65057.34942650607, 68396.6580167106, 68441.0, 68738.0, 68798.0, 434.44174236107085, 434.79130017591734, 435.1883736830788, 436.1364498293397, 436.74668692158474, 9727.34336720277, 10191.133753631024, 10236.846447303446, 10260.589576417158, 10381.636642717469, 31949.840250798596, 32882.67117328796, 33566.328673426884, 33710.662893370754, 34360.312793743484, 42433.36349954815, 43527.0, 43539.346909797016, 44942.77528612467, 45163.322550161116, 12303.0, 12753.808692869428, 13557.932210338886, 13583.388747506584, 14166.362513686703, 16897.83102169012, 16983.15084245758, 17355.392561260294, 17433.128343582517, 17613.0, 13591.728165436438, 13747.518836840663, 13873.58379248624, 13905.304734763018, 13946.511872084428, 13130.212187268795, 13143.737125257632, 13204.075714700262, 13393.732125357243, 13659.931700341434, 8566.35752318591, 8850.0, 8977.506237157018, 14293.785593216318, 14395.928020359832, 12999.675008124872, 13439.664008399868, 13658.863411365759, 14083.436662533384, 14180.581941805736, 11190.160737944523, 11557.768844623228, 12284.81572776427, 13333.466661333438, 13723.245221512912], "dojo.html": [2826.208661574759, 2901.4342203270357, 2905.636795400575, 2916.431295897301, 2916.9416611667766, 4857.829975950838, 4867.26990951357, 4870.293807397925, 4871.585915197213, 4885.413750349959, 4833.154198015351, 4844.636652251078, 4878.365812444377, 4887.144749668802, 4918.36061312029, 4391.231534481453, 4479.3952816369865, 4498.685092043558, 4525.547445255481, 4551.931721024187, 4439.223135951212, 4479.238529449985, 4547.408836851205, 4569.109023740372, 4599.540045995407, 4540.341650460698, 4543.773181241063, 4548.840790572331, 4553.863384098482, 4591.104734576759, 4536.523665015159, 4571.565701258375, 4583.908321833561, 4608.147492713859, 4628.0, 4227.97886010568, 4309.07354918694, 4404.163208990281, 4466.464024317071, 4485.641148708096, 4775.403074615673, 4836.153673107192, 4847.903041939141, 4850.369451971256, 4858.149823780825, 5186.688798672092, 5194.92207616886, 5214.843554693365, 5252.474752524755, 5266.8419947401635, 5082.2122571001555, 5128.589712822965, 5202.08963431398, 5255.86860328491, 5335.466453354672, 4941.48114447985, 4952.523738130934, 4982.501749824988, 5010.248462730583, 5022.347094877716, 5455.045367060828, 5463.754131064032, 5472.288602481652, 5485.0949593317455, 5498.670079795145, 4882.12121818069, 4895.388076490439, 4942.481039490802, 4989.0770207511005, 5091.66904151229, 5259.132243179909, 5336.893262134736, 5358.91961620576, 5365.356157261075, 5369.543588794996, 5205.297284866495, 5278.5513231375, 5286.524212820865, 5300.522952934178, 5332.093544097513, 4933.506649335038, 5046.646734728607, 5088.898222035538, 5097.949020509822, 5136.229565565195, 4016.3172260715746, 4056.1887622475624, 4086.4891888513935, 4105.609967053125, 4124.237016151961, 3679.172186258124, 3688.0, 3692.9630703693156, 3706.870259540903, 3736.925261494755, 4742.715437073786, 4787.3776409066595, 4854.854354369375, 4858.489858564871, 4889.217725164028, 5122.538971492509, 5209.583233341324, 5210.192420174879, 5215.556677682363, 5220.295260139833, 4888.169011268093, 4913.754312284372, 4996.575291100297, 4999.75001249936, 5013.348264725635, 4332.415123958225, 4435.290353543418, 4461.553844615512, 4626.352310676508, 4727.030958653468, 5284.682919024871, 5387.353517577916, 5439.891202176013, 5449.564034877121, 5476.945230547723, 5368.22160786676, 5408.45915408456, 5425.891482170414, 5440.918386224131, 5462.098753705594, 5135.460776618551, 5275.788968441219, 5292.655977361459, 5421.457854214547, 5474.5894057945015, 5125.154349532286, 5296.841094767163, 5303.867403314794, 5305.151175811851, 5326.97336513315, 5113.64204505681, 5314.043472175045, 5362.222477740784, 5371.060064488777, 5371.973140134274, 4926.581240594446, 5032.295478632921, 5037.0681423936685, 5198.9740051299505, 5240.868978275574, 5014.7994080236385, 5033.6476446648385, 5067.721275329893, 5069.771860266371, 5085.288059671723, 4860.198067318853, 4930.359053323045, 4955.529224723646, 4964.652474326763, 5020.071286811805, 5153.665011774223, 5193.221016847503, 5264.078786212474, 5266.8419947401635, 5277.261183434245, 5008.824691135793, 5095.694258344512, 5146.948530514796, 5159.664621799571, 5169.06956747789], "mootools.html": [1166.0787977497778, 1562.2969663651356, 1636.108320965074, 1641.6962861870552, 1662.3184494357315, 5927.614705044169, 6156.846078848031, 6346.904796428045, 6499.0, 6569.868602627945, 6387.90418143727, 6413.13422687937, 6495.317991610884, 6554.344565543443, 6577.539572229945, 1904.0384605774066, 1926.2198809482181, 1926.7398901148306, 1929.6719557675158, 1948.7758907725581, 1959.8334141597982, 1970.940871773849, 1980.4157773456793, 1996.7903370146144, 2001.6296985057738, 1913.5598812273186, 1928.1034319041644, 1929.411529483507, 1930.3147382679158, 1951.4145756273133, 1885.0292099568733, 1920.8655394122418, 1921.1450904347432, 1924.3553409607798, 1927.0, 1949.6783030799902, 1965.9901700491405, 1976.802319768026, 1979.613975274822, 1983.0877796213758, 5830.47525722687, 6403.679816009181, 6452.580582262138, 6500.089987401768, 6500.869982600321, 3730.869419570302, 3982.8008599569907, 4099.3031184698675, 4101.52832424272, 4147.025449019478, 2403.2910291463886, 2443.315871555967, 2462.5444292805887, 2475.5296493666324, 2482.888270027853, 768.7347864986571, 783.0798811396643, 783.0916137280727, 798.5168972771447, 805.0621026504116, 8233.876491852627, 8235.711750088778, 8302.211289927447, 8332.708355207538, 8361.372897032747, 3556.28874225156, 3632.2372301816913, 3721.1627383838963, 3758.605346438639, 3767.7362584618813, 6916.273791251947, 7059.788206353817, 7060.858782824417, 7126.2873712628325, 7145.214026457085, 4078.347464405681, 4085.5097388313593, 4090.1615168890307, 4097.323941549671, 4127.545969943304, 3801.9429708554394, 3807.333716599584, 3811.4092315691114, 3830.3871380578976, 3835.884923452301, 2884.653841538987, 2908.06941778633, 2928.2679330167457, 2961.0968654560133, 2963.525835866251, 874.361715947362, 891.3760367742606, 891.527490430073, 893.1871996483299, 897.7755561109723, 1151.5566506894907, 1155.1163360029584, 1173.9236949598248, 1189.131933688395, 1196.8444102266649, 6250.562460627803, 6263.71813268404, 6278.46633036197, 6307.4954003679595, 6317.084022816666, 977.8826540815147, 1019.7501612105082, 1045.6497073480318, 1053.7629033467408, 1066.424130969268, 5095.388553373619, 5099.515546023122, 5103.311053007871, 5150.948490515122, 5150.948490515122, 6782.9321706783285, 7079.681414336367, 7465.4027677786735, 7498.850022999619, 7589.051368578927, 7611.314981651567, 7678.731244406419, 7706.460547761715, 7710.884336734954, 7732.342750866127, 6142.754289828446, 6230.221222347207, 6241.687915604201, 6278.905816412757, 6301.936980630135, 6241.438270555672, 6304.71628776697, 6331.810045698637, 6334.904976425265, 6384.329645387167, 6913.619750913748, 7068.045813815069, 7096.0420343253, 7136.750213742702, 7179.066721326194, 7005.299470052954, 7178.8564228714085, 7224.855502889807, 7225.313595208447, 7248.601326926859, 6333.0, 6406.1031455597185, 6416.743330266924, 6418.4865210783955, 6421.261554921244, 6363.6499992499, 6414.069959855701, 6435.903461447989, 6441.742330306735, 6469.320721324193, 5956.225690660186, 6049.969750151397, 6050.909236361546, 6083.117947897618, 6116.021436570128, 5809.477147056785, 5832.125181222681, 5845.503132233808, 5895.41045895407, 5926.259217597801, 5752.626079304831, 5787.247657804459, 5790.884182316246, 5793.623414478214, 5842.065269557021, 5153.639245252796, 5253.159494481018, 5254.65844720092, 5266.262723218676, 5315.2292917525965, 5339.599530035185, 5368.9463105370005, 5373.731313434391, 5377.354717433933, 5433.320834895638], "ext.html": [507.0847120946692, 512.6027328820167, 515.8761897144684, 517.6686920370961, 539.9217113518538, 27429.862850685742, 30005.0, 37378.25243495128, 37579.0, 37771.62228377716, 40365.394519082234, 40453.59546404535, 40475.79762101185, 40571.59428405715, 40938.0, 7567.848643027136, 8220.630071646776, 8446.662133514652, 8476.957615211915, 8556.0, 7691.538507689528, 9878.456684882329, 10153.593856245778, 10156.593736250541, 10194.286399951969, 9839.163671087967, 9880.40717556949, 9915.0, 9955.203583713286, 10058.34620749649, 7809.609519524001, 7985.5208687478935, 9880.505974701236, 10046.196304295712, 10069.345492542961, 9746.610135594568, 9882.703518894445, 9885.654002109963, 9911.504424778732, 9994.250431217688, 36722.0, 37120.628793711985, 37175.0, 37203.0, 37205.441918371245, 2693.380522479821, 2741.2144078229226, 2763.6130941668184, 3172.397244523533, 3274.7052765251005, 24712.876435617705, 25467.61798573023, 25831.74168258331, 25852.482950341077, 26524.336891577674, 2170.8914554272224, 2179.2263746370127, 2180.509385388275, 2192.9342119736434, 2216.9556608867892, 252410.0, 254337.0, 254536.0, 256979.0, 258265.0, 42101.15797684029, 52549.7372513135, 52838.73580632072, 53301.73349133229, 53485.0, 47359.0, 61671.383286166565, 63466.0, 63474.365256347766, 64240.678796605716, 16012.199390030451, 16178.919105404397, 16375.91812040956, 16388.098654574114, 16398.180090995404, 11557.133215008907, 11746.647600571996, 11766.176367654181, 11883.70290742721, 11914.642560723192, 18841.246350146113, 19007.239710411428, 19092.904535477235, 19201.42357952694, 19307.710384344246, 7701.691932322757, 7810.648520816577, 7873.960630196812, 7927.128015918244, 7947.4436789425345, 783.3928705253475, 924.9583768730289, 963.942163470194, 976.4727047394327, 1012.1750773119884, 26096.217113486626, 26215.282082306625, 26273.34316642061, 26355.736442635327, 26461.206163815117, 876.1151237250423, 945.0974319524837, 950.7100334397936, 975.7853272280087, 1016.7305663999047, 12796.23222606628, 13324.133931294435, 13487.460501580023, 13542.796858047137, 13674.31628418595, 217867.0, 222982.0, 224529.0, 224587.0, 224782.0, 42954.0, 43583.34624980628, 45201.0, 46152.3077153843, 50424.74787626112, 1307.1307580458888, 1317.795741660025, 1318.4660212613715, 1320.0363734473697, 1330.7005923667098, 25259.368515787253, 25788.871055644602, 26758.0, 26945.0, 27956.86021569879, 41651.583484164774, 42396.57603423926, 49527.0, 49918.50081499284, 50696.0, 238073.0, 239208.0, 242027.0, 242039.0, 244318.0, 27244.727552725013, 27922.022729204382, 28741.568876466452, 29099.0, 29265.70734292715, 38659.976534611225, 40114.39828402635, 40669.38995915123, 41309.79345103376, 41310.0, 30755.53866692046, 32024.0, 32663.836680816443, 32687.836560817996, 33063.17342066467, 29612.851935740182, 29986.550201746555, 30016.0, 30260.69739302667, 31833.5224971621, 31879.362412752078, 33171.336573267916, 33184.834075829465, 33523.83238083794, 33722.83138584292, 26007.60988585135, 29269.26826829261, 29294.41411171722, 31560.36879262448, 31748.68251317457, 21495.677564836853, 21639.891800540896, 21790.237341692966, 21841.344759657237, 22158.88920555387], "prototype.html": [290.15998683810363, 302.6368357970435, 304.8384356291166, 307.944569977404, 312.97809153359276, 5478.917816232754, 5522.530584900283, 5555.333359996806, 5589.496945274925, 5598.832035038945, 5481.862953426166, 5497.367802702691, 5504.339479262484, 5506.64206826557, 5529.419410961851, 4052.7568345899194, 4248.001719595908, 4254.106637606106, 4262.744235345874, 4284.571542845714, 4165.791710414483, 4174.70777045607, 4213.073123912734, 4234.047339348653, 4234.491860976687, 4123.505179378464, 4176.227397931377, 4183.414321994908, 4184.121334519755, 4214.473190851144, 4018.839246430139, 4125.278076336659, 4142.316517774563, 4148.751074935499, 4160.33434650456, 3635.4546817977252, 3650.3064417760543, 3662.414013757786, 3678.6137455567045, 3679.8344074516713, 5232.502912223333, 5235.6073294502685, 5247.68513889164, 5247.86880327991, 5300.125479295912, 4728.952710472886, 4732.83435079774, 4743.407074115736, 4751.809927602892, 4753.714777113384, 5462.91805622912, 5617.241672374218, 5639.746211420496, 5645.2096706461125, 5735.2257445245195, 4014.277430062617, 4020.2763502569524, 4026.396040593905, 4036.535798383194, 4060.4924384451942, 6014.12795144706, 6015.639061656271, 6017.097435384683, 6024.939750602525, 6095.420935011167, 4077.3680079587116, 4093.1404405074672, 4100.138970816162, 4109.97945010273, 4112.629863312316, 3943.369060950234, 3994.800259986989, 4133.648639865645, 4139.855105071308, 4149.875503734893, 4664.603508701731, 4674.6260299176665, 4676.532346765296, 4679.578837904605, 4692.319613656069, 5684.829455116271, 5703.429657034263, 5708.229389032511, 5709.400512946081, 5730.828075157752, 1414.1515090945556, 1435.2034620785564, 1440.4526280013529, 1456.8980171388114, 1457.6865973815682, 922.4741897118712, 935.4106912645126, 945.4658118163353, 950.6102497975935, 959.4339339789558, 5466.180072989004, 5467.289252397242, 5470.070088085035, 5472.425395333512, 5487.204355368529, 5915.822525324161, 5970.432808883149, 5978.342382338026, 6009.699515024231, 6025.78909738157, 5413.2692086568595, 5457.072297709399, 5465.262189604353, 5481.890362192734, 5496.477834605706, 3222.113918672384, 3278.7377009839156, 3292.604887413526, 3301.7028467437567, 3310.2220978070136, 6028.336882942873, 6055.2430946131735, 6061.181740464981, 6075.027995520695, 6094.75620975156, 6148.9692551537855, 6152.077188421773, 6153.661548614779, 6163.075538669146, 6223.408776166257, 5915.053591425265, 6049.21360223177, 6070.605410648293, 6073.089036644538, 6087.786927457518, 5980.312264089685, 5987.43119403656, 5992.310884248192, 6003.3996600339615, 6003.909941350796, 5827.125931110198, 5845.18167456548, 5868.149118377897, 5898.997170481114, 5930.733117009831, 6025.939740602538, 6050.757969681164, 6062.787802426894, 6128.019516877278, 6128.417800308964, 3975.363941769303, 4031.637152656275, 4038.333674943601, 4062.106336605942, 4072.20591984572, 5956.851078723066, 5960.8807823844145, 5980.0431930890845, 6004.8799024020145, 6018.699065046818, 5775.624584402, 5786.103154011135, 5789.0, 5834.504067154339, 5837.591368604157, 5639.0, 5749.281339832521, 5817.825465236049, 5840.357560668408, 5850.356460789395, 5690.829275121753, 5708.400617935057, 5739.0, 5758.654480731169, 5777.653340799566, 5685.147227915846, 5689.715514224189, 5751.338596061507, 5828.708564571839, 5834.562407819515, 5600.0759874620235, 5642.238297829905, 5645.858853528694, 5724.513416359656, 5724.885502289848], "yui.html": [639.4372951802413, 691.7993781803276, 705.4180301251467, 709.5246185056012, 712.7754757251465, 11718.414079296033, 12057.336846473441, 12115.212511186777, 12168.0, 12255.264684118947, 13103.148295360796, 13254.602361929134, 13276.933615331935, 13301.534446294381, 13388.330583470835, 646.3923911523177, 776.0609662308614, 781.7850091224901, 782.1318336646318, 784.619459562112, 652.4943169044005, 772.289493665826, 798.4171554765026, 804.859149648812, 808.3654331349892, 810.3193317613204, 816.5957850863801, 817.9468334558264, 827.5407149032285, 827.7103013945101, 661.8312330355728, 668.7157957867887, 807.9192080791933, 814.3241109878786, 817.1705718695529, 603.1314906534576, 603.9426254505815, 604.7973928733879, 607.729560345642, 612.5375341617095, 11620.360880151587, 11639.94180029103, 11651.76696466066, 11793.11551633631, 11813.527458901719, 8155.143709910433, 8574.614142363609, 8659.696910608161, 8660.523671198082, 8935.0, 7737.226277372218, 7927.563983980879, 7953.4432589718745, 8125.228103330174, 8281.83436331276, 2617.358747106971, 2674.7726443252345, 2714.3892624159603, 2738.698743138253, 2759.9724002760117, 43061.0, 43226.56773432257, 43754.78122609366, 43910.12179756387, 44309.11381772347, 6166.630002199882, 6370.0763389308295, 6373.0, 6537.640429776408, 6564.4748420127235, 11121.499532520895, 11204.831927521094, 11248.493817778219, 11268.154888383404, 11298.548058077586, 5290.0, 5367.973160134253, 5449.855530338673, 5472.808451704251, 5615.466530679579, 3326.5841769778776, 3371.140359208386, 3406.5230867678547, 3433.570803649544, 3508.245727168671, 2438.6585877977095, 2441.597136472498, 2443.2792326263793, 2446.8287219894437, 2471.431570738704, 346.599677372635, 349.49497975425777, 353.07494364764483, 372.3929994109584, 376.2606478270212, 393.54348955211816, 420.54791099568087, 454.1212753322332, 484.5493690867527, 534.657818995843, 7403.370713489414, 7522.3605993491165, 7558.924410755932, 7711.0, 7856.292933636, 434.8391095294761, 452.57005844447906, 485.50721018166587, 505.43391401629674, 526.9947300526945, 3157.4790159623863, 3208.342289830579, 3240.060382489099, 3244.23760416302, 3268.1339445047083, 48179.03641927142, 50062.749686251336, 50089.24866126938, 50170.0, 50516.0, 46885.0, 47537.286940695914, 47739.76130119397, 47767.522324777005, 48007.519924800305, 43306.0, 43475.56524434778, 43557.34663980043, 43596.346054809204, 44069.33895991627, 6358.237011558643, 7130.893036604559, 7367.839930767951, 7415.258474152542, 7453.105627324756, 32926.34147317088, 33101.33797324088, 33439.0, 33571.83214084012, 33753.3249335007, 38340.42489362606, 38799.224015518965, 43839.0, 43858.34212486879, 43946.34080488859, 7076.150861896605, 7173.426125910019, 7348.827950032392, 7394.55632662042, 7409.407247420086, 9555.61777528891, 9897.65358212459, 10165.898341016495, 10208.489575521045, 10391.792164156523, 9003.63985440575, 9016.504092274989, 9099.49952752605, 9580.233581313618, 9608.039196080335, 9285.117913798178, 9388.483633400228, 9736.123748862636, 9775.755606109904, 9804.313698041069, 9260.536973151451, 9294.163525282756, 9346.813063738551, 9443.102905223992, 9447.0, 7946.443748937751, 8113.310368618733, 8357.540335281617, 8429.662813487392, 8577.785555361166, 7798.766037018899, 7986.520808751494, 8078.115405927536, 8197.79505512367, 8290.502569845828]}, "summary": {"suite": 6077.036534560694, "subtests": {"jquery.html": {"filtered": 7096.4812229610725, "value": 7096.4812229610725}, "dojo.html": {"filtered": 4843.4054807924385, "value": 4843.4054807924385}, "mootools.html": {"filtered": 3806.028329030275, "value": 3806.028329030275}, "ext.html": {"filtered": 17031.027764821447, "value": 17031.027764821447}, "prototype.html": {"filtered": 4344.147885432048, "value": 4344.147885432048}, "yui.html": {"filtered": 5203.488719025057, "value": 5203.488719025057}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1449046434, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151201235259", "branch": "Mozilla-Aurora", "revision": "b4e23b2390f5f1049b130fd0866d44df30698c0d"}}, {"talos_counters": {}, "results": {"audio-dft": [181.0, 204.0, 185.0, 181.0, 180.0, 181.0, 181.0, 181.0, 180.0, 181.0], "ai-astar": [121.0, 116.0, 119.0, 128.0, 120.0, 124.0, 123.0, 123.0, 112.0, 125.0], "imaging-gaussian-blur": [136.0, 135.0, 140.0, 130.0, 130.0, 142.0, 135.0, 135.0, 130.0, 135.0], "audio-beat-detection": [176.0, 152.0, 185.0, 174.0, 140.0, 168.0, 144.0, 178.0, 164.0, 144.0], "json-stringify-tinderbox": [70.0, 72.0, 72.0, 73.0, 74.0, 76.0, 76.0, 76.0, 73.0, 73.0], "stanford-crypto-pbkdf2": [163.0, 165.0, 169.0, 168.0, 162.0, 151.0, 164.0, 162.0, 170.0, 170.0], "json-parse-financial": [63.0, 67.0, 70.0, 70.0, 69.0, 69.0, 72.0, 82.0, 66.0, 65.0], "stanford-crypto-sha256-iterative": [75.0, 77.0, 76.0, 79.0, 80.0, 81.0, 78.0, 77.0, 76.0, 78.0], "audio-fft": [83.0, 90.0, 86.0, 134.0, 77.0, 83.0, 82.0, 78.0, 130.0, 73.0], "imaging-darkroom": [141.0, 146.0, 143.0, 140.0, 139.0, 147.0, 143.0, 140.0, 140.0, 147.0], "stanford-crypto-ccm": [137.0, 140.0, 139.0, 147.0, 139.0, 139.0, 135.0, 147.0, 140.0, 140.0], "audio-oscillator": [108.0, 110.0, 160.0, 103.0, 104.0, 101.0, 142.0, 98.0, 106.0, 148.0], "stanford-crypto-aes": [88.0, 92.0, 96.0, 96.0, 95.0, 95.0, 92.0, 92.0, 96.0, 97.0], "imaging-desaturate": [115.0, 118.0, 118.0, 115.0, 113.0, 117.0, 118.0, 118.0, 114.0, 112.0]}, "summary": {"suite": 1689.0000000000002, "subtests": {"audio-fft": {"filtered": 91.6, "value": 91.6}, "stanford-crypto-pbkdf2": {"filtered": 164.4, "value": 164.4}, "audio-beat-detection": {"filtered": 162.5, "value": 162.5}, "stanford-crypto-ccm": {"filtered": 140.3, "value": 140.3}, "imaging-darkroom": {"filtered": 142.6, "value": 142.6}, "json-parse-financial": {"filtered": 69.3, "value": 69.3}, "audio-oscillator": {"filtered": 118.0, "value": 118.0}, "ai-astar": {"filtered": 121.1, "value": 121.1}, "audio-dft": {"filtered": 183.5, "value": 183.5}, "stanford-crypto-sha256-iterative": {"filtered": 77.7, "value": 77.7}, "json-stringify-tinderbox": {"filtered": 73.5, "value": 73.5}, "imaging-gaussian-blur": {"filtered": 134.8, "value": 134.8}, "stanford-crypto-aes": {"filtered": 93.9, "value": 93.9}, "imaging-desaturate": {"filtered": 115.8, "value": 115.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1449046434, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151201235259", "branch": "Mozilla-Aurora", "revision": "b4e23b2390f5f1049b130fd0866d44df30698c0d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [215.7497303128371], "Encrypt": [361.4022406938923], "NavierStokes": [6448.717948717948], "Decrypt": [6611.8421052631575], "Splay": [673.8544474393531], "Richards": [198.96538002387584], "RegExp": [33459.016393442624], "Earley": [773.9938080495356], "Boyer": [14098.591549295774], "RayTrace": [1156.0693641618498]}, "summary": {"suite": 17885.864870427722, "subtests": {"DeltaBlue": {"filtered": 306.45692999999994, "value": 306.45692999999994}, "Encrypt": {"filtered": 736.5228270000001, "value": 736.5228270000001}, "NavierStokes": {"filtered": 230.12326043737562, "value": 230.12326043737562}, "Decrypt": {"filtered": 40.25822089552237, "value": 40.25822089552237}, "Splay": {"filtered": 120.93264399999997, "value": 120.93264399999997}, "RegExp": {"filtered": 27.2268912297893, "value": 27.2268912297893}, "Richards": {"filtered": 177.42785199999994, "value": 177.42785199999994}, "Earley": {"filtered": 861.070196, "value": 861.070196}, "Boyer": {"filtered": 47.27160139860137, "value": 47.27160139860137}, "RayTrace": {"filtered": 640.0904850000001, "value": 640.0904850000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1449046434, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151201235259", "branch": "Mozilla-Aurora", "revision": "b4e23b2390f5f1049b130fd0866d44df30698c0d"}}] 01:14:08 INFO - RETURN: dromaeo_css: 6077.04 01:14:08 INFO - RETURN: kraken: 1689.00 01:14:08 INFO - RETURN: v8_7: 17885.86 01:14:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17885.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1689.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6077.04"}}} 01:14:08 INFO - Return code: 0 01:14:08 INFO - # TBPL SUCCESS # 01:14:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:14:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:14:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:14:08 INFO - 2015-12-02 01:14:08.813 screenresolution[1665:9988] starting screenresolution argv=screenresolution get 01:14:08 INFO - 2015-12-02 01:14:08.816 screenresolution[1665:9988] Display 0: 1600x1200x32@60 01:14:08 INFO - 2015-12-02 01:14:08.823 screenresolution[1666:9991] starting screenresolution argv=screenresolution list 01:14:08 INFO - Available Modes on Display 0 01:14:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:14:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:14:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:14:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:14:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:14:09 INFO - Intel HD Graphics 3000: 01:14:09 INFO - Chipset Model: Intel HD Graphics 3000 01:14:09 INFO - Type: GPU 01:14:09 INFO - Bus: Built-In 01:14:09 INFO - VRAM (Total): 512 MB 01:14:09 INFO - VRAM (Dynamic, Max): 10 01:14:09 INFO - Vendor: Intel (0x8086) 01:14:09 INFO - Device ID: 0x0116 01:14:09 INFO - Revision ID: 0x0009 01:14:09 INFO - Displays: 01:14:09 INFO - Display: 01:14:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:14:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:14:09 INFO - Display Serial Number: 1600x1200 60 01:14:09 INFO - Main Display: Yes 01:14:09 INFO - Mirror: Off 01:14:09 INFO - Online: Yes 01:14:09 INFO - Rotation: Supported 01:14:09 INFO - Return code: 0 01:14:09 INFO - Running post-action listener: _resource_record_post_action 01:14:09 INFO - Running post-run listener: _resource_record_post_run 01:14:10 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 39171072; Write bytes: 685260800; Read time: 4338; Write time: 51637 01:14:10 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 342858240; Write bytes: 347488256; Read time: 35645; Write time: 7894 01:14:10 INFO - run-tests - Wall time: 1215s; CPU: 30.0%; Read bytes: 36733952; Write bytes: 336437248; Read time: 3803; Write time: 43721 01:14:10 INFO - Running post-run listener: _upload_blobber_files 01:14:10 INFO - Blob upload gear active. 01:14:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:14:10 INFO - Copying logs to upload dir... 01:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1313.881494 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-02 01:14:10.244328) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 01:14:10.248106) ========= 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.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010200 build_url: 'https://queue.taskcluster.net/v1/task/dtX5mx3TQ8GLXXO_yRf5Zw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 01:14:10.269182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 01:14:10.269492) ========= 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.XtXRqKWCKT/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.ME33dfS6xa/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 01:14:10.318096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 01:14:10.318401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 01:14:10.318730) ========= ========= Total master_lag: 0.20 =========