builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0027 starttime: 1446815744.4 results: success (0) buildid: 20151106032135 builduid: 831987405d0347129ddfd0cb51e0d836 revision: b918dbd0c3a02030769ecc9bc71e5024c748ac90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.400828) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.401319) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.401666) ========= 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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.006106 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.464764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.465103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.495364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.495720) ========= 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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.040636 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.550539) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.550879) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.551310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.551624) ========= 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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-06 05:15:44-- 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.18M=0.001s 2015-11-06 05:15:44 (9.18 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.357072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.925146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:44.925527) ========= 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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.146970 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:45.087293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:45.087695) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b918dbd0c3a02030769ecc9bc71e5024c748ac90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b918dbd0c3a02030769ecc9bc71e5024c748ac90 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-06 05:15:45,172 truncating revision to first 12 chars 2015-11-06 05:15:45,172 Setting DEBUG logging. 2015-11-06 05:15:45,172 attempt 1/10 2015-11-06 05:15:45,172 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b918dbd0c3a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-06 05:15:45,888 unpacking tar archive at: mozilla-central-b918dbd0c3a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:46.080273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:46.080648) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:46.094484) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:46.094966) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 05:15:46.095461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2015-11-06 05:15:46.095807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:15:46 INFO - MultiFileLogger online at 20151106 05:15:46 in /builds/slave/test 05:15:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:15:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:46 INFO - {'append_to_log': False, 05:15:46 INFO - 'base_work_dir': '/builds/slave/test', 05:15:46 INFO - 'blob_upload_branch': 'Firefox', 05:15:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:46 INFO - 'branch': 'Firefox', 05:15:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:46 INFO - 'config_files': ('talos/mac_config.py',), 05:15:46 INFO - 'default_actions': ('clobber', 05:15:46 INFO - 'read-buildbot-config', 05:15:46 INFO - 'download-and-extract', 05:15:46 INFO - 'populate-webroot', 05:15:46 INFO - 'create-virtualenv', 05:15:46 INFO - 'install', 05:15:46 INFO - 'run-tests'), 05:15:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:46 INFO - 'download_minidump_stackwalk': True, 05:15:46 INFO - 'download_symbols': 'ondemand', 05:15:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:46 INFO - 'installer_path': 'installer.exe', 05:15:46 INFO - 'log_level': 'info', 05:15:46 INFO - 'log_name': 'talos', 05:15:46 INFO - 'log_to_console': True, 05:15:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:15:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:15:46 INFO - 'opt_config_files': (), 05:15:46 INFO - 'pip_index': False, 05:15:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:46 INFO - 'cmd': ('bash', 05:15:46 INFO - '-c', 05:15:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:46 INFO - 'enabled': True, 05:15:46 INFO - 'halt_on_failure': False, 05:15:46 INFO - 'name': 'check_screen_resolution'},), 05:15:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:46 INFO - 'cmd': ('bash', 05:15:46 INFO - '-c', 05:15:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:46 INFO - 'enabled': True, 05:15:46 INFO - 'halt_on_failure': False, 05:15:46 INFO - 'name': 'check_screen_resolution'},), 05:15:46 INFO - 'run_cmd_checks_enabled': True, 05:15:46 INFO - 'sps_profile': False, 05:15:46 INFO - 'sps_profile_interval': 0, 05:15:46 INFO - 'suite': 'dromaeojs-e10s', 05:15:46 INFO - 'system_bits': '64', 05:15:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:46 INFO - 'title': 't-yosemite-r5-0027', 05:15:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:46 INFO - 'use_talos_json': True, 05:15:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:46 INFO - 'work_dir': 'build'} 05:15:46 INFO - ##### 05:15:46 INFO - ##### Running clobber step. 05:15:46 INFO - ##### 05:15:46 INFO - Running pre-action listener: _resource_record_pre_action 05:15:46 INFO - Running main action method: clobber 05:15:46 INFO - rmtree: /builds/slave/test/build 05:15:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:51 INFO - Running post-action listener: _resource_record_post_action 05:15:51 INFO - ##### 05:15:51 INFO - ##### Running read-buildbot-config step. 05:15:51 INFO - ##### 05:15:51 INFO - Running pre-action listener: _resource_record_pre_action 05:15:51 INFO - Running main action method: read_buildbot_config 05:15:51 INFO - Using buildbot properties: 05:15:51 INFO - { 05:15:51 INFO - "properties": { 05:15:51 INFO - "buildnumber": 4, 05:15:51 INFO - "product": "firefox", 05:15:51 INFO - "script_repo_revision": "production", 05:15:51 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:15:51 INFO - "repository": "", 05:15:51 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:15:51 INFO - "buildid": "20151106032135", 05:15:51 INFO - "slavename": "t-yosemite-r5-0027", 05:15:51 INFO - "pgo_build": "False", 05:15:51 INFO - "basedir": "/builds/slave/test", 05:15:51 INFO - "project": "", 05:15:51 INFO - "platform": "yosemite", 05:15:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:15:51 INFO - "slavebuilddir": "test", 05:15:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:15:51 INFO - "branch": "mozilla-central", 05:15:51 INFO - "repo_path": "mozilla-central", 05:15:51 INFO - "stage_platform": "macosx64", 05:15:51 INFO - "builduid": "831987405d0347129ddfd0cb51e0d836", 05:15:51 INFO - "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90" 05:15:51 INFO - }, 05:15:51 INFO - "sourcestamp": { 05:15:51 INFO - "repository": "", 05:15:51 INFO - "hasPatch": false, 05:15:51 INFO - "project": "", 05:15:51 INFO - "branch": "mozilla-central-macosx64-talos", 05:15:51 INFO - "changes": [ 05:15:51 INFO - { 05:15:51 INFO - "category": null, 05:15:51 INFO - "files": [ 05:15:51 INFO - { 05:15:51 INFO - "url": null, 05:15:51 INFO - "name": "https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:15:51 INFO - } 05:15:51 INFO - ], 05:15:51 INFO - "repository": "", 05:15:51 INFO - "rev": "b918dbd0c3a02030769ecc9bc71e5024c748ac90", 05:15:51 INFO - "who": "cbook@mozilla.com", 05:15:51 INFO - "when": 1446814777, 05:15:51 INFO - "number": 6630101, 05:15:51 INFO - "comments": "merge fx-team to mozilla-central a=merge", 05:15:51 INFO - "project": "", 05:15:51 INFO - "at": "Fri 06 Nov 2015 04:59:37", 05:15:51 INFO - "branch": "mozilla-central-macosx64-talos", 05:15:51 INFO - "revlink": "", 05:15:51 INFO - "properties": [ 05:15:51 INFO - [ 05:15:51 INFO - "buildid", 05:15:51 INFO - "20151106032135", 05:15:51 INFO - "Change" 05:15:51 INFO - ], 05:15:51 INFO - [ 05:15:51 INFO - "builduid", 05:15:51 INFO - "831987405d0347129ddfd0cb51e0d836", 05:15:51 INFO - "Change" 05:15:51 INFO - ], 05:15:51 INFO - [ 05:15:51 INFO - "pgo_build", 05:15:51 INFO - "False", 05:15:51 INFO - "Change" 05:15:51 INFO - ] 05:15:51 INFO - ], 05:15:51 INFO - "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90" 05:15:51 INFO - } 05:15:51 INFO - ], 05:15:51 INFO - "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90" 05:15:51 INFO - } 05:15:51 INFO - } 05:15:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:15:51 INFO - Running post-action listener: _resource_record_post_action 05:15:51 INFO - ##### 05:15:51 INFO - ##### Running download-and-extract step. 05:15:51 INFO - ##### 05:15:51 INFO - Running pre-action listener: _resource_record_pre_action 05:15:51 INFO - Running main action method: download_and_extract 05:15:51 INFO - mkdir: /builds/slave/test/build/tests 05:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:51 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json 05:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json 05:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:15:51 INFO - Downloaded 1149 bytes. 05:15:51 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:15:51 INFO - Using the following test package requirements: 05:15:51 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:15:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'jsshell-mac.zip'], 05:15:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:15:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:15:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:15:51 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:15:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:15:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:15:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:15:51 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:51 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:53 INFO - Downloaded 17462093 bytes. 05:15:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:15:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:15:57 INFO - Return code: 0 05:15:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:57 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:59 INFO - Downloaded 17462093 bytes. 05:15:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:15:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:15:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:16:05 INFO - Return code: 0 05:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:05 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:16:06 INFO - Downloaded 11131450 bytes. 05:16:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:16:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:16:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:16:06 INFO - Return code: 0 05:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:06 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:16:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:16:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:16:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:16:09 INFO - Downloaded 108690706 bytes. 05:16:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:16:09 INFO - mkdir: /builds/slave/test/properties 05:16:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:09 INFO - Contents: 05:16:09 INFO - build_url:https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:16:09 INFO - Running post-action listener: _resource_record_post_action 05:16:09 INFO - Running post-action listener: set_extra_try_arguments 05:16:09 INFO - ##### 05:16:09 INFO - ##### Running populate-webroot step. 05:16:09 INFO - ##### 05:16:09 INFO - Running pre-action listener: _resource_record_pre_action 05:16:09 INFO - Running main action method: populate_webroot 05:16:09 INFO - Guessing talos json url... 05:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:09 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:16:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:16:10 INFO - Downloaded 99 bytes. 05:16:10 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:16:10 INFO - Contents: 05:16:10 INFO - 20151106032135 05:16:10 INFO - https://hg.mozilla.org/mozilla-central/rev/b918dbd0c3a02030769ecc9bc71e5024c748ac90 05:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:10 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/b918dbd0c3/testing/talos/talos.json 05:16:10 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/b918dbd0c3/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/b918dbd0c3/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:16:10 INFO - Downloaded 4264 bytes. 05:16:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:16:10 INFO - '../fennec_ids.txt'], 05:16:10 INFO - 'tests': ['tcheck2']}, 05:16:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:10 INFO - '--tppagecycles', 05:16:10 INFO - '7'], 05:16:10 INFO - 'tests': ['tsvgm']}}, 05:16:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:16:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:16:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'tests': ['damp', 'tps']}, 05:16:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['damp', 'tps']}, 05:16:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:10 INFO - 'other': {'tests': ['a11yr', 05:16:10 INFO - 'ts_paint', 05:16:10 INFO - 'tpaint', 05:16:10 INFO - 'sessionrestore', 05:16:10 INFO - 'sessionrestore_no_auto_restore']}, 05:16:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['a11yr', 05:16:10 INFO - 'ts_paint', 05:16:10 INFO - 'tpaint', 05:16:10 INFO - 'sessionrestore', 05:16:10 INFO - 'sessionrestore_no_auto_restore']}, 05:16:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['a11yr', 05:16:10 INFO - 'ts_paint', 05:16:10 INFO - 'tpaint', 05:16:10 INFO - 'sessionrestore', 05:16:10 INFO - 'sessionrestore_no_auto_restore']}, 05:16:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['a11yr', 05:16:10 INFO - 'ts_paint', 05:16:10 INFO - 'tpaint', 05:16:10 INFO - 'sessionrestore', 05:16:10 INFO - 'sessionrestore_no_auto_restore']}, 05:16:10 INFO - 'other_l64': {'tests': ['a11yr', 05:16:10 INFO - 'ts_paint', 05:16:10 INFO - 'tpaint', 05:16:10 INFO - 'sessionrestore', 05:16:10 INFO - 'sessionrestore_no_auto_restore']}, 05:16:10 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:10 INFO - 'ts_paint', 05:16:10 INFO - 'tpaint', 05:16:10 INFO - 'sessionrestore', 05:16:10 INFO - 'sessionrestore_no_auto_restore']}, 05:16:10 INFO - 'svgr': {'tests': ['tsvgx', 05:16:10 INFO - 'tsvgr_opacity', 05:16:10 INFO - 'tart', 05:16:10 INFO - 'tscrollx', 05:16:10 INFO - 'cart']}, 05:16:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['tsvgx', 05:16:10 INFO - 'tsvgr_opacity', 05:16:10 INFO - 'tart', 05:16:10 INFO - 'tscrollx', 05:16:10 INFO - 'cart']}, 05:16:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'tests': ['tp5o']}, 05:16:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'talos_options': ['--e10s'], 05:16:10 INFO - 'tests': ['tp5o']}, 05:16:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'talos_options': ['--xperf_path', 05:16:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:10 INFO - 'tests': ['tp5n']}, 05:16:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:10 INFO - 'talos_options': ['--e10s', 05:16:10 INFO - '--xperf_path', 05:16:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:16:10 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:16:10 INFO - 'tests': ['tp5n']}}, 05:16:10 INFO - 'talos.zip': {'path': '', 05:16:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:10 INFO - Running post-action listener: _resource_record_post_action 05:16:10 INFO - ##### 05:16:10 INFO - ##### Running create-virtualenv step. 05:16:10 INFO - ##### 05:16:10 INFO - Running pre-action listener: _resource_record_pre_action 05:16:10 INFO - Running main action method: create_virtualenv 05:16:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:16:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:11 INFO - Using real prefix '/tools/python27' 05:16:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:15 INFO - Installing pip.................done. 05:16:15 INFO - Return code: 0 05:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:15 INFO - 'HOME': '/Users/cltbld', 05:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:15 INFO - 'LOGNAME': 'cltbld', 05:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:15 INFO - 'MOZ_NO_REMOTE': '1', 05:16:15 INFO - 'NO_EM_RESTART': '1', 05:16:15 INFO - 'PAGER': '/bin/cat', 05:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:15 INFO - 'PWD': '/builds/slave/test', 05:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:15 INFO - 'SHELL': '/bin/bash', 05:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:15 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:15 INFO - 'USER': 'cltbld', 05:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:15 INFO - 'XPC_FLAGS': '0x0', 05:16:15 INFO - 'XPC_SERVICE_NAME': '0', 05:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:16 INFO - Cleaning up... 05:16:16 INFO - Return code: 0 05:16:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:16 INFO - 'HOME': '/Users/cltbld', 05:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:16 INFO - 'LOGNAME': 'cltbld', 05:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:16 INFO - 'MOZ_NO_REMOTE': '1', 05:16:16 INFO - 'NO_EM_RESTART': '1', 05:16:16 INFO - 'PAGER': '/bin/cat', 05:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:16 INFO - 'PWD': '/builds/slave/test', 05:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:16 INFO - 'SHELL': '/bin/bash', 05:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:16 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:16 INFO - 'USER': 'cltbld', 05:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:16 INFO - 'XPC_FLAGS': '0x0', 05:16:16 INFO - 'XPC_SERVICE_NAME': '0', 05:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 INFO - Downloading/unpacking psutil>=0.7.1 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:16:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:19 INFO - Installing collected packages: psutil 05:16:19 INFO - Running setup.py install for psutil 05:16:19 INFO - building 'psutil._psutil_osx' extension 05:16:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:16:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:16:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:16:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:16:21 INFO - building 'psutil._psutil_posix' extension 05:16:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:16:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:22 INFO - ^ 05:16:22 INFO - 1 warning generated. 05:16:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:16:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:22 INFO - Successfully installed psutil 05:16:22 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:22 INFO - 'HOME': '/Users/cltbld', 05:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PAGER': '/bin/cat', 05:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:22 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - 'XPC_FLAGS': '0x0', 05:16:22 INFO - 'XPC_SERVICE_NAME': '0', 05:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:25 INFO - Installing collected packages: mozsystemmonitor 05:16:25 INFO - Running setup.py install for mozsystemmonitor 05:16:25 INFO - Successfully installed mozsystemmonitor 05:16:25 INFO - Cleaning up... 05:16:25 INFO - Return code: 0 05:16:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:25 INFO - 'HOME': '/Users/cltbld', 05:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:25 INFO - 'LOGNAME': 'cltbld', 05:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:25 INFO - 'MOZ_NO_REMOTE': '1', 05:16:25 INFO - 'NO_EM_RESTART': '1', 05:16:25 INFO - 'PAGER': '/bin/cat', 05:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:25 INFO - 'PWD': '/builds/slave/test', 05:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:25 INFO - 'SHELL': '/bin/bash', 05:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:25 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:25 INFO - 'USER': 'cltbld', 05:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:25 INFO - 'XPC_FLAGS': '0x0', 05:16:25 INFO - 'XPC_SERVICE_NAME': '0', 05:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:29 INFO - Downloading docopt-0.6.1.tar.gz 05:16:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:29 INFO - Running setup.py install for blobuploader 05:16:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:29 INFO - Running setup.py install for requests 05:16:29 INFO - Running setup.py install for docopt 05:16:30 INFO - Successfully installed blobuploader requests docopt 05:16:30 INFO - Cleaning up... 05:16:30 INFO - Return code: 0 05:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:30 INFO - 'HOME': '/Users/cltbld', 05:16:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:30 INFO - 'LOGNAME': 'cltbld', 05:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:30 INFO - 'MOZ_NO_REMOTE': '1', 05:16:30 INFO - 'NO_EM_RESTART': '1', 05:16:30 INFO - 'PAGER': '/bin/cat', 05:16:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:30 INFO - 'PWD': '/builds/slave/test', 05:16:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:30 INFO - 'SHELL': '/bin/bash', 05:16:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:30 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:30 INFO - 'USER': 'cltbld', 05:16:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:30 INFO - 'XPC_FLAGS': '0x0', 05:16:30 INFO - 'XPC_SERVICE_NAME': '0', 05:16:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-9zN5ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-NftrIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-cjK4qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-CAiHDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-pNOJkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-OZW75l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-7nFNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-mp4MbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-f3bdet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-1NU4qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-7RBPQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-D206sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-qftLET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-JQTIfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:32 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-LS3gHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:32 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-j6h2u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:32 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Sqt8Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:32 INFO - Running setup.py install for manifestparser 05:16:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:32 INFO - Running setup.py install for mozcrash 05:16:32 INFO - Running setup.py install for mozdebug 05:16:32 INFO - Running setup.py install for mozdevice 05:16:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozfile 05:16:33 INFO - Running setup.py install for mozhttpd 05:16:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozinfo 05:16:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozInstall 05:16:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozleak 05:16:33 INFO - Running setup.py install for mozlog 05:16:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Running setup.py install for moznetwork 05:16:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Running setup.py install for mozprocess 05:16:34 INFO - Running setup.py install for mozprofile 05:16:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Running setup.py install for mozrunner 05:16:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Running setup.py install for mozscreenshot 05:16:35 INFO - Running setup.py install for moztest 05:16:35 INFO - Running setup.py install for mozversion 05:16:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:35 INFO - Cleaning up... 05:16:35 INFO - Return code: 0 05:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:35 INFO - 'HOME': '/Users/cltbld', 05:16:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:35 INFO - 'LOGNAME': 'cltbld', 05:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:35 INFO - 'MOZ_NO_REMOTE': '1', 05:16:35 INFO - 'NO_EM_RESTART': '1', 05:16:35 INFO - 'PAGER': '/bin/cat', 05:16:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:35 INFO - 'PWD': '/builds/slave/test', 05:16:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:35 INFO - 'SHELL': '/bin/bash', 05:16:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:35 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:35 INFO - 'USER': 'cltbld', 05:16:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:35 INFO - 'XPC_FLAGS': '0x0', 05:16:35 INFO - 'XPC_SERVICE_NAME': '0', 05:16:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:35 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-RP7804-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:35 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-UT3om5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:35 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-yAg6Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-uJsCq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-__wpCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-ZqLVLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-1s0_Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-2XrPe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-yuCjcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-VcrSlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:36 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-65gmVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:37 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-SuqPWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:37 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-2tC84G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:37 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-D8FANh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:37 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-ofrOst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:37 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-8E1KLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:37 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-HITtuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:40 INFO - Downloading blessings-1.5.1.tar.gz 05:16:40 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:40 INFO - Installing collected packages: blessings 05:16:40 INFO - Running setup.py install for blessings 05:16:40 INFO - Successfully installed blessings 05:16:40 INFO - Cleaning up... 05:16:40 INFO - Return code: 0 05:16:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:40 INFO - Reading from file tmpfile_stdout 05:16:40 INFO - Current package versions: 05:16:40 INFO - blessings == 1.5.1 05:16:40 INFO - blobuploader == 1.2.4 05:16:40 INFO - docopt == 0.6.1 05:16:40 INFO - manifestparser == 1.1 05:16:40 INFO - mozInstall == 1.12 05:16:40 INFO - mozcrash == 0.16 05:16:40 INFO - mozdebug == 0.1 05:16:40 INFO - mozdevice == 0.47 05:16:40 INFO - mozfile == 1.2 05:16:40 INFO - mozhttpd == 0.7 05:16:40 INFO - mozinfo == 0.9 05:16:40 INFO - mozleak == 0.1 05:16:40 INFO - mozlog == 3.0 05:16:40 INFO - moznetwork == 0.27 05:16:40 INFO - mozprocess == 0.22 05:16:40 INFO - mozprofile == 0.27 05:16:40 INFO - mozrunner == 6.11 05:16:40 INFO - mozscreenshot == 0.1 05:16:40 INFO - mozsystemmonitor == 0.0 05:16:40 INFO - moztest == 0.7 05:16:40 INFO - mozversion == 1.4 05:16:40 INFO - psutil == 3.1.1 05:16:40 INFO - requests == 1.2.3 05:16:40 INFO - wsgiref == 0.1.2 05:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e401228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7eb6383c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, '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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:16:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:41 INFO - 'HOME': '/Users/cltbld', 05:16:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:41 INFO - 'LOGNAME': 'cltbld', 05:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:41 INFO - 'MOZ_NO_REMOTE': '1', 05:16:41 INFO - 'NO_EM_RESTART': '1', 05:16:41 INFO - 'PAGER': '/bin/cat', 05:16:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:41 INFO - 'PWD': '/builds/slave/test', 05:16:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:41 INFO - 'SHELL': '/bin/bash', 05:16:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:16:41 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:16:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:41 INFO - 'USER': 'cltbld', 05:16:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:41 INFO - 'XPC_FLAGS': '0x0', 05:16:41 INFO - 'XPC_SERVICE_NAME': '0', 05:16:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:41 INFO - Cleaning up... 05:16:41 INFO - Return code: 0 05:16:41 INFO - Running post-action listener: _resource_record_post_action 05:16:41 INFO - Running post-action listener: _start_resource_monitoring 05:16:41 INFO - Starting resource monitoring. 05:16:41 INFO - ##### 05:16:41 INFO - ##### Running install step. 05:16:41 INFO - ##### 05:16:41 INFO - Running pre-action listener: _resource_record_pre_action 05:16:41 INFO - Running main action method: install 05:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:41 INFO - Reading from file tmpfile_stdout 05:16:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:41 INFO - Reading from file tmpfile_stdout 05:16:41 INFO - Output received: 05:16:41 INFO - Usage: mozinstall [options] installer 05:16:41 INFO - Options: 05:16:41 INFO - -h, --help show this help message and exit 05:16:41 INFO - -d DEST, --destination=DEST 05:16:41 INFO - Directory to install application into. [default: 05:16:41 INFO - "/builds/slave/test"] 05:16:41 INFO - --app=APP Application being installed. [default: firefox] 05:16:41 INFO - mkdir: /builds/slave/test/build/application 05:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:17:19 INFO - Reading from file tmpfile_stdout 05:17:19 INFO - Output received: 05:17:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:17:19 INFO - Running post-action listener: _resource_record_post_action 05:17:19 INFO - ##### 05:17:19 INFO - ##### Running run-tests step. 05:17:19 INFO - ##### 05:17:19 INFO - Running pre-action listener: _resource_record_pre_action 05:17:19 INFO - Running main action method: run_tests 05:17:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:20 INFO - 2015-11-06 05:17:20.002 screenresolution[1631:7586] starting screenresolution argv=screenresolution get 05:17:20 INFO - 2015-11-06 05:17:20.005 screenresolution[1631:7586] Display 0: 1600x1200x32@60 05:17:20 INFO - 2015-11-06 05:17:20.011 screenresolution[1632:7588] starting screenresolution argv=screenresolution list 05:17:20 INFO - Available Modes on Display 0 05:17:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:20 INFO - Intel HD Graphics 3000: 05:17:20 INFO - Chipset Model: Intel HD Graphics 3000 05:17:20 INFO - Type: GPU 05:17:20 INFO - Bus: Built-In 05:17:20 INFO - VRAM (Total): 512 MB 05:17:20 INFO - VRAM (Dynamic, Max): 10 05:17:20 INFO - Vendor: Intel (0x8086) 05:17:20 INFO - Device ID: 0x0116 05:17:20 INFO - Revision ID: 0x0009 05:17:20 INFO - Displays: 05:17:20 INFO - Display: 05:17:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:20 INFO - Display Serial Number: 1600x1200 60 05:17:20 INFO - Main Display: Yes 05:17:20 INFO - Mirror: Off 05:17:20 INFO - Online: Yes 05:17:20 INFO - Rotation: Supported 05:17:20 INFO - Return code: 0 05:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:20 INFO - Python 2.7.3 05:17:20 INFO - Return code: 0 05:17:20 INFO - grabbing minidump binary from tooltool 05:17: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')]} 05:17:20 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 0x10e3499f0>, '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 0x10e0a8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e313990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:17:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:20 INFO - Return code: 0 05:17:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0027', '--webServer', 'localhost'] in /builds/slave/test/build 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0027 --webServer localhost 05:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOnxyVmgDf/Render', 05:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:20 INFO - 'HOME': '/Users/cltbld', 05:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:20 INFO - 'LOGNAME': 'cltbld', 05:17:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:20 INFO - 'MOZ_NO_REMOTE': '1', 05:17:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:20 INFO - 'NO_EM_RESTART': '1', 05:17:20 INFO - 'PAGER': '/bin/cat', 05:17:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:20 INFO - 'PWD': '/builds/slave/test', 05:17:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:20 INFO - 'SHELL': '/bin/bash', 05:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UhRjX68VZ4/Listeners', 05:17:20 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 05:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:20 INFO - 'USER': 'cltbld', 05:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:20 INFO - 'XPC_FLAGS': '0x0', 05:17:20 INFO - 'XPC_SERVICE_NAME': '0', 05:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:17:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0027', '--webServer', 'localhost'] with output_timeout 3600 05:17:20 INFO - mozversion INFO | application_buildid: 20151106032135 05:17:20 INFO - mozversion INFO | application_changeset: b918dbd0c3a02030769ecc9bc71e5024c748ac90 05:17:20 INFO - mozversion INFO | application_display_name: Nightly 05:17:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:20 INFO - mozversion INFO | application_name: Firefox 05:17:20 INFO - mozversion INFO | application_remotingname: firefox 05:17:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:17:20 INFO - mozversion INFO | application_vendor: Mozilla 05:17:20 INFO - mozversion INFO | application_version: 45.0a1 05:17:20 INFO - mozversion INFO | platform_buildid: 20151106032135 05:17:20 INFO - mozversion INFO | platform_changeset: b918dbd0c3a02030769ecc9bc71e5024c748ac90 05:17:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:17:20 INFO - mozversion INFO | platform_version: 45.0a1 05:17:20 INFO - 2015-11-06 05:17:20,718 DEBUG : using testdate: 1446815840 05:17:20 INFO - 2015-11-06 05:17:20,719 DEBUG : actual date: 1446815840 05:17:20 INFO - 2015-11-06 05:17:20,767 INFO : starting webserver on 'localhost:49265' 05:17:20 INFO - 2015-11-06 05:17:20,768 INFO : Starting test suite t-yosemite-r5-0027.e 05:17:20 INFO - 2015-11-06 05:17:20,768 INFO : Starting test dromaeo_css 05:17:20 INFO - 2015-11-06 05:17:20,768 DEBUG : operating with platform_type : mac_ 05:17:20 INFO - 2015-11-06 05:17:20,769 INFO : Initialising browser for dromaeo_css test... 05:17:20 INFO - 2015-11-06 05:17:20,800 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpUzIyXI/profile http://localhost:49265/getInfo.html 05:17:24 INFO - 2015-11-06 05:17:24,369 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:17:24 INFO - 2015-11-06 05:17:24,369 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:17:24 INFO - 2015-11-06 05:17:24,369 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:17:24 INFO - 2015-11-06 05:17:24,369 DEBUG : BROWSER_OUTPUT: __metrics 05:17:25 INFO - 2015-11-06 05:17:25,026 INFO : Browser initialized. 05:17:25 INFO - 2015-11-06 05:17:25,026 INFO : Running cycle 1/1 for dromaeo_css test... 05:17:25 INFO - 2015-11-06 05:17:25,026 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpUzIyXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:17:37 INFO - 2015-11-06 05:17:37,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 233705472 05:17:37 INFO - 2015-11-06 05:17:37,034 DEBUG : BROWSER_OUTPUT: 05:18:26 INFO - 2015-11-06 05:18:26,906 DEBUG : BROWSER_OUTPUT: 1446815906903 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:20:38 INFO - 2015-11-06 05:20:38,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 05:20:39 INFO - 2015-11-06 05:20:39,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 258834432 05:20:39 INFO - 2015-11-06 05:20:39,775 DEBUG : BROWSER_OUTPUT: 05:23:41 INFO - 2015-11-06 05:23:41,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 05:23:42 INFO - 2015-11-06 05:23:42,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 265850880 05:23:42 INFO - 2015-11-06 05:23:42,430 DEBUG : BROWSER_OUTPUT: 05:26:44 INFO - 2015-11-06 05:26:44,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 05:26:44 INFO - 2015-11-06 05:26:44,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 267878400 05:26:44 INFO - 2015-11-06 05:26:44,796 DEBUG : BROWSER_OUTPUT: 05:29:46 INFO - 2015-11-06 05:29:46,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 05:29:47 INFO - 2015-11-06 05:29:47,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 272318464 05:29:47 INFO - 2015-11-06 05:29:47,133 DEBUG : BROWSER_OUTPUT: 05:32:49 INFO - 2015-11-06 05:32:49,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 05:32:50 INFO - 2015-11-06 05:32:50,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 276164608 05:32:50 INFO - 2015-11-06 05:32:50,377 DEBUG : BROWSER_OUTPUT: 05:35:52 INFO - 2015-11-06 05:35:52,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 05:35:53 INFO - 2015-11-06 05:35:53,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 281059328 05:35:53 INFO - 2015-11-06 05:35:53,049 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,049 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:35:53 INFO - 2015-11-06 05:35:53,049 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:35:53 INFO - 2015-11-06 05:35:53,049 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:35:53 INFO - 2015-11-06 05:35:53,049 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:35:53 INFO - 2015-11-06 05:35:53,049 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2968.4359971605395;3058.0825752274313;3059.281068948795;3176.1583180457174;3205.583274174358;5045.596352291817;5082.0598189335;5103.948960510394;5114.795408183672;5117.5650069744115;4880.438749543795;4920.237363208699;4977.626677999156;4988.401391832976;5098.209777484487;4608.700434471749;4646.97676511617;4707.717536947777;4786.4974177711365;4793.9520604794025;4554.339620755005;4627.375304333922;4634.21218392874;4640.303954406832;4660.86017419478;4497.910041799146;4537.478190008158;4614.5385461453925;4671.065786842645;4710.5289471052965;4649.907001859978;4671.182543054986;4680.899988502699;4691.249400095969;4726.834560790356;4639.5360463953675;4645.326427667969;4670.182718024366;4690.906181876378;4764.833230836939;4762.738049407316;4825.252085926687;4916.680415772999;4994.750262486898;5039.974800125976;5237.947620523784;5347.331583552056;5367;5394.460553944574;5400.83797486076;5289.021531016736;5419.187121931703;5483.479069488392;5485.314335708036;5489.094299440588;4961.875953101201;4963.8262660806695;4967.726775027336;4981.651284410056;5048.899022019539;5473.124300112043;5529.640573362719;5550.694711790809;5561.054620714488;5619.578531610146;4976.4525902150735;5137.434882162959;5341.946580534145;5342.1452567589;5346.331708536433;5396.4333744957;5411.080116380225;5428.83713488596;5471.890562188734;5506.146547285177;5361.758720857492;5425.430329815392;5435.945640543544;5455.918161227585;5489.807856724996;5051.772670229849;5232.738363081907;5310.707911064928;5377.7311134443125;5389.110796718497;4244.278472659656;4249.596288352602;4249.660027197817;4254.914901701949;4257.829686812554;3858.3826587745825;3866.613338666111;3878.5927477614446;3896.7661940283106;3928.626780455852;4812.302216178635;4969.950300497021;4991.675541089818;5054.671446355975;5105.7191854448365;5433.239346491494;5457.836264912059;5488.807891723771;5502.779888804403;5513.531349835229;5071.721055341992;5075.441701412841;5145.845624631267;5171.793128274902;5184.7407629618365;4616.838410655611;4646.605038571759;4664.137134630104;4683.484816670163;4767.570918617272;5528.695921724344;5551.8889622206525;5571.164325351067;5572.637778544301;5575.832725018256;5208.687478751287;5471.206675032177;5496.367917689517;5509.559235261089;5522.696251706195;5523.558115350843;5584.692841893735;5586.664800112007;5591.021571224938;5598.3282006159525;5398.9190162146815;5448.945510544844;5463.890722185454;5465.426130256265;5471.069918113851;5173.689578625294;5199.66202196856;5504.036793561191;5512.6968016759465;5578.30271216098;4961.1318019345745;5085.084684756779;5258.605604579595;5275.577953763613;5288.550473209821;5282.996230716151;5283.2075188722;5292.788288468572;5349.1976203569775;5353.304070470814;4961.404631444249;4967.801287948441;5018.297438358706;5186.06650802844;5226.137687281708;5282.392524859691;5286.392064912584;5297.205419186998;5342.091844386386;5373.086575282133;5191.065608190562;5194.610404219774;5242.5281724644965;5245.344331958505;5248.6325957182635 05:35:53 INFO - 2015-11-06 05:35:53,050 DEBUG : BROWSER_OUTPUT: |1;ext.html;505.58541995563655;521.7886755863874;527.2118183315944;549.1433363952233;559.5635404384581;37232.25535489292;37949.620503794955;38189;38230.235395292075;38334.424983625235;39930.60069399305;40419.797901010454;40442.59557404425;40820.183596328054;40886.59113408865;8704.825903481942;8780.341474389446;8809;8819.250363719091;8867.512286824222;8512.446690965067;8614.095519970408;8633.223009929105;8686.652533898636;8748.037715851251;8532.914670853273;8635.654573817039;8638;8644.827103457927;8704.912950870505;8584.442011269279;8585.18440748128;8603.569821508961;8606.268467180296;8681.95659021704;8435.367347448966;8580.099089595627;8593.054763975957;8611.6985905493;8700.129987001312;37232.813835930916;37711.811440942896;37731.62268377309;38042.80978595117;38066.670666106766;2999.820010799337;3087.4905640569277;3187.7768556201077;3287.7205437537837;3399.7790143640586;26251.73748262531;26527.368603470975;26625.73374266252;26757.331066723487;27451.588226176624;2237.5413040326694;2278.897449614771;2282.7260728712495;2283.44055706353;2301.5972204864247;262369;262596;263444;264005;267113.9999999981;38139.61860381416;39270.214595708494;39331.606683933365;53976.730116349165;54272.01503917244;37735.43396849049;37955.81022094927;38122.42816357757;38165.809170953966;38275.23449530994;12955.481780728855;12974.870251297554;12978.870211297955;13096.934515327554;13102.80345794814;10125.64560240388;10192.949035254924;10193;10212.795744085226;10266.6406675766;13080.215187088805;13110;13118;13149.934250328688;13290.202587844567;5426.2674538936735;5727.828165155052;5749.367569567345;5749.3963133871175;5760.395158508296;828.6850996621246;870.277669534285;882.2412725056446;889.3596610440472;993.6224234790733;27044.459110817672;27187.592186117225;27196;27315.621298241167;27784.444311113664;1019.5157300282455;1020.3418794877263;1033.1115240892825;1116;1131.4641744548287;14155.363008664635;14166.575002749934;14249.145051296955;14627.19550424737;14712.264386780618;359935;364023;365555;367209;367762;53955.460445395045;54286.72856635691;54308;54475.45524544783;54484.63788405321;1315.7763180259187;1319.577735124751;1327.8074679171466;1330.7937269723209;1342.543340475595;26312.8684356577;26882.731172688804;27403.725962740915;27460.45079098367;27533.31166720848;43532.782336088116;44570.55429445664;44625.10749785051;44632.33051504295;44754.77622611866;245303;247525;247571;247850;248640;30370.84814575913;30856.38287234198;42730.14539709251;44069.55930440783;44439.55560444354;40111.79944100261;40592.188156236116;40838.1832363357;40949.795251023555;41221.48087062926;34325;34891.65108348884;35009.64990350064;35119.18974848791;35704.28591428105;33659.32681346311;33829.492557612146;34193;34245.48631770476;34339.4849077269;34378.82810585931;35009.64990350064;35027.299454011285;35228;35454.29091418105;29114.854425727735;30469.390612187188;30728.078157655305;30740.23149421193;30780.53829192519;22877.771222287563;22938.54122917566;22991.6551251728;23177.188798391977;23255.88372058129 05:35:53 INFO - 2015-11-06 05:35:53,054 DEBUG : BROWSER_OUTPUT: |2;jquery.html;307.3698917219699;308.0143540669857;308.31400134700283;314.7277604871786;315.96208454985396;10991.175661825375;11402.087832973362;16124.113173775439;16580.668386632275;16766.91616541917;10853.403062831541;10905.730129390016;10993;11068.225224234307;11224.775504489906;4124.9587504124875;4238.87283381499;4242.639375653073;4249.490061192661;4272.444582204309;4085.162541678949;4171.895702607444;4175.561566035568;4192.496900371944;4232.174725928445;4115.1975364803875;4119.052617897885;4187.476565429321;4327.350897365389;4336.891577710551;4286.7642279674765;4290.656747460196;4304.569543045702;4319.848805291831;4320.395144679747;3661.7802931824176;3698.130939229306;3837.846486140551;3838.6929045676557;3841.8847434577006;12084.516619335216;12181.208221465666;12260.080493962989;12319.69200769979;12594.43325050375;1811.1759149587037;1853.4347024157626;1952.3654812185955;2076.4497408186844;2164.6211912915333;11503.482343294572;13149;13482.123661961941;13927.860721392757;14302.499412520512;1646.4072933743842;1650.8844380893343;1675.790526184227;1693.7290033594566;1748.4841971618403;49759.502404976214;62415;62643.686781566255;63760.68119659418;63868;15983.840161598468;16309.347626094823;16384.918075409547;16434.6713065738;16462.094584797713;22969.770302297096;23065.538689226123;23257.651135232984;23268;23343.533129337316;8910.599023043978;8932.821343573092;9004.59479323432;9032.954835225783;9091.95442524105;7553.622318884034;7583.27958843909;7584.5070070445245;7614.162442131361;7691.923080769121;7675.117361503499;7724.188960159215;7728.26581474759;7754.7673569793;7817.061952565615;3194.6965038321323;3258.4258435835422;3284.425225585513;3310.7185889199204;3406.0803583032443;351.0889242415927;352.6121266606712;357.5816294934932;366.4667908193572;409.4227139732962;9225;9465.290103242285;9602.759931001641;9610.423374597547;9696.75758106053;373.6655693154666;373.8840959302625;376.06547728894225;381.44118865861094;390.392938979889;4974.701517908937;5199.896002079937;5202.14164662834;5266.0257852297445;5284.524392804666;479792;529062;537378.6262137407;553780;559439;64475;67038.66480667566;67381.32618673751;67530.66234668795;67853;450.7858767085608;460.3784890397936;461.15838594564383;461.4462644826289;461.70220207965673;10219.28465007472;10377.429241391796;10441.216908732027;10453.111485523816;10516.106130978953;32295.67704322927;33236.16909577183;33387.33225335431;33615.83192084024;33680.66319336873;44435;45107.54892451165;45299.77350113228;45514.31728524008;45940.310895337265;5647.20939068539;5714.20001199824;5716.571257155813;5728.570357223141;5740.942590574041;10496.160307175254;10597.735056623646;11018.063464605279;11021.724456888642;11084.778304434027;8017;8299.709510167115;9185.127412895765;9452.905470945203;9572.234221262142;12961.805572916603;13849.861501384858;13989.930050349683;14013.29933503341;14113.506027288995;13692;13706;14183.574492765234;14438.32890915184;14538.709225815213;13415.932920335727;13504.932475337953;13672;13952.37214325378;13987;13736.175829450265;14212.928935355258;14263.928680356532;14293.64265893361;14645.048071875293 05:35:53 INFO - 2015-11-06 05:35:53,054 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1456.2500312339141;1568.2237292540194;1625.983740162598;1639.5737108351825;1650.0594661043203;6476.870462590746;6506.54454188207;6940.479464040198;7254.0932383452;7281.34467897889;6941.4793890458295;7082.114735658043;7084.64576771162;7156.284371562854;7174.7130114795345;1990.044778506318;1998.6702194138022;2025.7670367907658;2027.027027027028;2029.6955456681542;2023.666095094315;2033.918643254268;2050.661640829261;2050.6821442676332;2074.751029876417;1972.0139930034982;2011.718359429681;2013.7281467001915;2038.0319348309508;2038.1847261095606;2012.4163992442175;2018.8687735297158;2049.456893923104;2049.5695903860205;2051.2205361962433;2027.482991837087;2044.4684382060623;2046.6623007203793;2050.323393280214;2076.252549082329;7078.646067696594;7109.537880037781;7141.392981596518;7145.749898753571;7171.103612048494;4270.12462445198;4350.782460876943;4359.411479450266;4359.585839345257;4374.650027997753;2642.881070351839;2649.205238428483;2683.047518131055;2741.616173735679;2768.0726956469607;821.2157389692829;829.402829962426;837.6816809612369;847.5465625890181;853.6884037326394;9076.954615226881;9080;9087.772805679844;9094.954525227331;9162.129597688208;3866.052817059838;3877.3990031545154;3930.331843586597;3950.6049395060263;3955.7626542407547;8006.119326874039;8018.358531317481;8035.638396272065;8066.677332906618;8124.7562573122905;4397.032652816375;4404.559544045634;4407.933880991788;4414;4443.955560444419;3619.5475565554307;3775.0562359410146;3915.4322623219473;4031.07285324377;4066.9186616267507;3303.6861498157637;3388.9491657625153;3394.253264281854;3419.2990436960363;3436.3127374525193;1082.2802836113897;1094.195766111907;1097.7475180708482;1100.4167791070745;1102.6802227354137;904.2359206470522;910.4264313482464;916.5279880861361;917.2936838634214;917.8531434970373;6713.832154196184;6740.359665831738;6759.695813688396;6799.932000680029;6818.113645226089;389.8187342885572;397.97811120388656;399.32514051253287;399.40289267545205;423.66953776054726;5385.272988146628;5428.050091234098;5441.428649991773;5441.918371224435;5493.258410114583;8139.959300203461;8292.626831792584;8326.417150799507;8408.915910840935;8416.873746893802;8371.916280837235;8394.748157555283;8429.367797415218;8444.451110677786;8459.196376344238;6584.440322572635;6624.072629831828;6703.229128650268;6735.764248251386;6758.695858686371;6746.392824645805;6752.797416077526;6776.15298087739;6814.352636499525;6833.658317084225;7488.251174882468;7639.04511936008;7666.348360389429;7667.501612395176;7721.343685786771;7595.240475952361;7787.104482984303;7839.490433121829;7912.32745216663;7926.841463170819;5744.5978781486565;6051.213342265477;6287.339829317856;6387.297397286202;6435.871282574416;6703.162104736908;6795.082663840319;6843.281455447305;6933.445324374139;6942.166939967236;5939.376365481735;6269.090981807703;6363.427291543783;6426.550141490051;6505.5446118773125;6122.6938653068055;6175.104609831639;6203.8138855834395;6281.089242059968;6304.968475157595;6367.395097465918;6367.872642547216;6415.005674120519;6428.035794630843;6434.903476447764;5766.192733017297;5809.360970293349;5875.030619947832;5879.647221166743;5880.26496687914;5580.581456390868;5929.9110513341475;5977.103434484862;5978.043513037893;6037.09443583466 05:35:53 INFO - 2015-11-06 05:35:53,058 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.38307171867353;296.7729686789605;298.95216765317554;299.34592914481857;304.4276759691779;5668.546516278698;5753.856153596157;5802.187693722877;5830.737616807243;5837.766489340422;5754.74103665335;5766.423357664232;5769.509591684712;5773.653580785145;5786.305643322808;4134.111166099288;4302.247106756321;4338.4143140676;4369.934450983238;4370.082282720632;4238.4490016298;4239.47006624172;4305.5909688579695;4344.674149438789;4354.172707185625;4251.213525497793;4254.404383386328;4274.465691788527;4283.935740963888;4303.655707543389;4247.787610619472;4269.231538323101;4300.075483770988;4315.180115777992;4316.956830431687;3670.210904655512;3676.0442285005824;3698.14942563212;3703.5185925629694;3711.925761484755;5374.811881584164;5470.316210473691;5569.610127291091;5571.8885622287735;5629.8311050668135;4815.6388270879825;4844.5882100021545;4851.393575803025;4866.4403593586485;4873.147199240118;5946.137810017523;5950.553708471882;5965.105234214859;5993.91009134859;6016.42843929826;3985.880423587297;3990.700697447703;4026.033751899523;4026.094128821021;4028.5568587455355;6098.0852872069545;6219.720112594944;6283.340249273851;6292;6304.716287767062;4028.7582745035393;4031.133306339151;4037.555868854424;4074.9388759168637;4081.9387709184384;4110.650594699424;4115.506139263308;4115.794210289474;4118.279301122351;4158.2307273154565;4803.159447096744;4806.639502037361;4815.807367705323;4855.247436647325;4864.197407427735;5735.139729040594;5942.61373010753;5946.137810017523;5994;6026.035834266497;1464.326409851459;1487;1487.5760408283588;1488.5087920986266;1501.2643804535699;923.9076092390842;932.6735642525198;944.1832814615308;949.1362859797551;953.3231405702029;5688.857778555486;5693.146028095819;5703.201551782754;5739.540836733051;5773.566982476331;6237.126802247689;6255.718492667841;6288.496920246369;6305.684715764193;6309.905351419732;5753.85615359611;5767.019606666877;5771.451712087345;5817.301923769175;5838.357780644125;3380.4084285250474;3424.6917777400154;3464.9653503465147;3501.6673416025437;3520.436730123219;6345.936540634627;6360.173177486897;6389.233292004989;6416.935830641727;6433.260175079832;6202.2867370253;6296.937030629727;6376.426121648981;6464.127342808754;6515.2181738190775;6319.178506794087;6365.8726825464155;6421.8073457796345;6427.485801135991;6447.548671593037;6235.407636274546;6277.843053923689;6296.338884417253;6296.905546416716;6311.558190926591;5960.731767070405;6085;6102.4507794298725;6129.08063790435;6130.846728831815;6308.243010838729;6417.614943103429;6493.026046093124;6523.869522609616;6524.380183882524;4066.7153299268766;4117.382392641128;4119.485064366954;4148.377743338523;4162.334026555736;6171.413715697002;6295.244570651551;6317.368263173646;6344.777932772331;6361;6134.969325153345;6147.139400483847;6173.81478555644;6184.721687523982;6185;6108.297545782292;6108.541859360477;6163.075538669235;6168.136460895388;6173.969130154321;5850.473457388685;5929.199558059607;5937.970310148595;5959.612625179349;6020.217371741645;6133.44798968095;6139.447449729546;6180.505559555135;6198.256209254918;6206.751729930752;5975.671338076448;5984.251968503937;5997.850053748692;6070.514358851193;6074.544409169242 05:35:53 INFO - 2015-11-06 05:35:53,058 DEBUG : BROWSER_OUTPUT: |5;yui.html;628.1494439088387;643.1703102997134;673.7002034094827;688.8758933084874;720.5712601002404;12577.811332830004;12794.424250908709;12876.034297427695;12980.545680901147;13021.088523803337;12050.096242781805;12557.183783054117;12573.748525029494;12678.746425071493;12704;848.2704873808535;857.8927634045745;866.9306455483578;887.5784002598779;888.0719647967857;858.1932982995963;861.3023451004675;862.3316929379719;870.8954925408959;872.0538216035609;895.7133717210495;909.4316052467208;915.5010519266982;917.6650522559285;919.4069824962895;899.7705585075829;900.0279697926256;905.4748246017294;913.634546181526;913.7989642278689;662.9657733935077;665.3346653346654;669.581511555278;670.4770279182197;674.2650510943047;13285.13646612967;13406;13433.596992090253;13608.183508989492;13627;10929.836052459219;10963.232573719843;10985.791562928072;11185.49665265065;11252.099832013419;8880.1563851434;8888.73333799987;8888.778402028525;8893.644254229823;9422.199113075398;3096.938061238785;3116.703913128249;3158.384115097557;3295.0279667497907;3304.0913748719054;48222.27666585004;48623.75688121572;48624.27063594049;48697.51302486965;48996.75501622469;8315.501069935823;8391.992960844738;8517.105703901125;8624.137586241452;8927.508987005647;18292.817071829377;18492.167852446673;18521.722174167397;18550.72173917392;18589.81410185908;6465.288818229991;6469.8706025880165;6526.934730652728;6528.183977002875;6542.869142617121;3505.1412403961194;3620.71034317254;3635.2002559436883;3663.358912190356;3664.4320130379833;2648.748368904951;2675.879585418661;2683.5706286993986;2697.1099537153086;2704.9729502705113;389.93760998240714;395.580684474458;396.8710169195023;399.7241903086861;403.40094958985884;435.8932061644854;439.56483081748837;476.5901324860617;486.13225392673905;520.7084032941565;6667.399934005865;7059.92940070603;7182.2458641842895;7344.375728063068;7348.265173482716;529.343613918738;558.3076984539142;558.439945348404;559.6026820957165;563.6411617381191;3281.868725250963;3515.7538972272205;3516.8593256269464;3597.460380942827;3597.568291805;57196.14205786917;57668.134977975365;57928.71035644795;57945.42054579485;58047;48551.75724121357;49251.26123108156;49393.259101113515;49493.50506494961;49724.254136187985;44619.55380446154;44996.3250551242;45019.77490112528;45341;45506.08987820291;6959.130108736408;7010.859782804418;7094.255103214088;7496.175420703609;7681.347085497572;32740;33154.834225828716;33560.328793423505;33732.66267337295;34140;42751.78624106859;42893.785531073394;44477.555224447344;45001.32498012467;45142.32286515639;7016.684249208696;7071.858562828817;7158;7376.7418140364825;7434.962825185839;10464.215183861394;10478.528466219192;10673.626423075155;10772.299800512941;10788.136949044214;9454.669086581936;9663.565139568596;9685;9791.167750741266;10352.792944140925;9491.193248573949;9818.165455936325;9949.602015919281;10142.239332050274;10753.354798712102;9303;9372.250219982248;9467.573959171992;9730.95134524323;10112.696619101438;8131.512109273463;8139.348852091937;8174.632141553526;8215.753527393948;8936.24041956441;7558.470907036454;7761.61191940412;8239.794005149679;8297.08732039463;8339.45793523419 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,277 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: __startTimestamp1446816953044__endTimestamp 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,059 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:35:53 INFO - 2015-11-06 05:35:53,060 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:35:53 INFO - 2015-11-06 05:35:53,060 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,060 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5030.11 Median:5173.69 stddev:528.12 (10.2%) stddev-sans-first:504.36 05:35:53 INFO - 2015-11-06 05:35:53,061 DEBUG : BROWSER_OUTPUT: Values: 2968.4 3058.1 3059.3 3176.2 3205.6 5045.6 5082.1 5103.9 5114.8 5117.6 4880.4 4920.2 4977.6 4988.4 5098.2 4608.7 4647.0 4707.7 4786.5 4794.0 4554.3 4627.4 4634.2 4640.3 4660.9 4497.9 4537.5 4614.5 4671.1 4710.5 4649.9 4671.2 4680.9 4691.2 4726.8 4639.5 4645.3 4670.2 4690.9 4764.8 4762.7 4825.3 4916.7 4994.8 5040.0 5237.9 5347.3 5367.0 5394.5 5400.8 5289.0 5419.2 5483.5 5485.3 5489.1 4961.9 4963.8 4967.7 4981.7 5048.9 5473.1 5529.6 5550.7 5561.1 5619.6 4976.5 5137.4 5341.9 5342.1 5346.3 5396.4 5411.1 5428.8 5471.9 5506.1 5361.8 5425.4 5435.9 5455.9 5489.8 5051.8 5232.7 5310.7 5377.7 5389.1 4244.3 4249.6 4249.7 4254.9 4257.8 3858.4 3866.6 3878.6 3896.8 3928.6 4812.3 4970.0 4991.7 5054.7 5105.7 5433.2 5457.8 5488.8 5502.8 5513.5 5071.7 5075.4 5145.8 5171.8 5184.7 4616.8 4646.6 4664.1 4683.5 4767.6 5528.7 5551.9 5571.2 5572.6 5575.8 5208.7 5471.2 5496.4 5509.6 5522.7 5523.6 5584.7 5586.7 5591.0 5598.3 5398.9 5448.9 5463.9 5465.4 5471.1 5173.7 5199.7 5504.0 5512.7 5578.3 4961.1 5085.1 5258.6 5275.6 5288.6 5283.0 5283.2 5292.8 5349.2 5353.3 4961.4 4967.8 5018.3 5186.1 5226.1 5282.4 5286.4 5297.2 5342.1 5373.1 5191.1 5194.6 5242.5 5245.3 5248.6 05:35:53 INFO - 2015-11-06 05:35:53,061 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,062 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44473.96 Median:35579.29 stddev:77906.00 (219.0%) stddev-sans-first:78054.61 05:35:53 INFO - 2015-11-06 05:35:53,062 DEBUG : BROWSER_OUTPUT: Values: 505.6 521.8 527.2 549.1 559.6 37232.3 37949.6 38189.0 38230.2 38334.4 39930.6 40419.8 40442.6 40820.2 40886.6 8704.8 8780.3 8809.0 8819.3 8867.5 8512.4 8614.1 8633.2 8686.7 8748.0 8532.9 8635.7 8638.0 8644.8 8704.9 8584.4 8585.2 8603.6 8606.3 8682.0 8435.4 8580.1 8593.1 8611.7 8700.1 37232.8 37711.8 37731.6 38042.8 38066.7 2999.8 3087.5 3187.8 3287.7 3399.8 26251.7 26527.4 26625.7 26757.3 27451.6 2237.5 2278.9 2282.7 2283.4 2301.6 262369.0 262596.0 263444.0 264005.0 267114.0 38139.6 39270.2 39331.6 53976.7 54272.0 37735.4 37955.8 38122.4 38165.8 38275.2 12955.5 12974.9 12978.9 13096.9 13102.8 10125.6 10192.9 10193.0 10212.8 10266.6 13080.2 13110.0 13118.0 13149.9 13290.2 5426.3 5727.8 5749.4 5749.4 5760.4 828.7 870.3 882.2 889.4 993.6 27044.5 27187.6 27196.0 27315.6 27784.4 1019.5 1020.3 1033.1 1116.0 1131.5 14155.4 14166.6 14249.1 14627.2 14712.3 359935.0 364023.0 365555.0 367209.0 367762.0 53955.5 54286.7 54308.0 54475.5 54484.6 1315.8 1319.6 1327.8 1330.8 1342.5 26312.9 26882.7 27403.7 27460.5 27533.3 43532.8 44570.6 44625.1 44632.3 44754.8 245303.0 247525.0 247571.0 247850.0 248640.0 30370.8 30856.4 42730.1 44069.6 44439.6 40111.8 40592.2 40838.2 40949.8 41221.5 34325.0 34891.7 35009.6 35119.2 35704.3 33659.3 33829.5 34193.0 34245.5 34339.5 34378.8 35009.6 35027.3 35228.0 35454.3 29114.9 30469.4 30728.1 30740.2 30780.5 22877.8 22938.5 22991.7 23177.2 23255.9 05:35:53 INFO - 2015-11-06 05:35:53,062 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,063 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27446.47 Median:2035.90 stddev:86989.41 (4272.8%) stddev-sans-first:87209.57 05:35:53 INFO - 2015-11-06 05:35:53,063 DEBUG : BROWSER_OUTPUT: Values: 307.4 308.0 308.3 314.7 316.0 10991.2 11402.1 16124.1 16580.7 16766.9 10853.4 10905.7 10993.0 11068.2 11224.8 4125.0 4238.9 4242.6 4249.5 4272.4 4085.2 4171.9 4175.6 4192.5 4232.2 4115.2 4119.1 4187.5 4327.4 4336.9 4286.8 4290.7 4304.6 4319.8 4320.4 3661.8 3698.1 3837.8 3838.7 3841.9 12084.5 12181.2 12260.1 12319.7 12594.4 1811.2 1853.4 1952.4 2076.4 2164.6 11503.5 13149.0 13482.1 13927.9 14302.5 1646.4 1650.9 1675.8 1693.7 1748.5 49759.5 62415.0 62643.7 63760.7 63868.0 15983.8 16309.3 16384.9 16434.7 16462.1 22969.8 23065.5 23257.7 23268.0 23343.5 8910.6 8932.8 9004.6 9033.0 9092.0 7553.6 7583.3 7584.5 7614.2 7691.9 7675.1 7724.2 7728.3 7754.8 7817.1 3194.7 3258.4 3284.4 3310.7 3406.1 351.1 352.6 357.6 366.5 409.4 9225.0 9465.3 9602.8 9610.4 9696.8 373.7 373.9 376.1 381.4 390.4 4974.7 5199.9 5202.1 5266.0 5284.5 479792.0 529062.0 537378.6 553780.0 559439.0 64475.0 67038.7 67381.3 67530.7 67853.0 450.8 460.4 461.2 461.4 461.7 10219.3 10377.4 10441.2 10453.1 10516.1 32295.7 33236.2 33387.3 33615.8 33680.7 44435.0 45107.5 45299.8 45514.3 45940.3 5647.2 5714.2 5716.6 5728.6 5740.9 10496.2 10597.7 11018.1 11021.7 11084.8 8017.0 8299.7 9185.1 9452.9 9572.2 12961.8 13849.9 13989.9 14013.3 14113.5 13692.0 13706.0 14183.6 14438.3 14538.7 13415.9 13504.9 13672.0 13952.4 13987.0 13736.2 14212.9 14263.9 14293.6 14645.0 05:35:53 INFO - 2015-11-06 05:35:53,064 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,064 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4928.92 Median:6236.45 stddev:2558.26 (41.0%) stddev-sans-first:2552.12 05:35:53 INFO - 2015-11-06 05:35:53,065 DEBUG : BROWSER_OUTPUT: Values: 1456.3 1568.2 1626.0 1639.6 1650.1 6476.9 6506.5 6940.5 7254.1 7281.3 6941.5 7082.1 7084.6 7156.3 7174.7 1990.0 1998.7 2025.8 2027.0 2029.7 2023.7 2033.9 2050.7 2050.7 2074.8 1972.0 2011.7 2013.7 2038.0 2038.2 2012.4 2018.9 2049.5 2049.6 2051.2 2027.5 2044.5 2046.7 2050.3 2076.3 7078.6 7109.5 7141.4 7145.7 7171.1 4270.1 4350.8 4359.4 4359.6 4374.7 2642.9 2649.2 2683.0 2741.6 2768.1 821.2 829.4 837.7 847.5 853.7 9077.0 9080.0 9087.8 9095.0 9162.1 3866.1 3877.4 3930.3 3950.6 3955.8 8006.1 8018.4 8035.6 8066.7 8124.8 4397.0 4404.6 4407.9 4414.0 4444.0 3619.5 3775.1 3915.4 4031.1 4066.9 3303.7 3388.9 3394.3 3419.3 3436.3 1082.3 1094.2 1097.7 1100.4 1102.7 904.2 910.4 916.5 917.3 917.9 6713.8 6740.4 6759.7 6799.9 6818.1 389.8 398.0 399.3 399.4 423.7 5385.3 5428.1 5441.4 5441.9 5493.3 8140.0 8292.6 8326.4 8408.9 8416.9 8371.9 8394.7 8429.4 8444.5 8459.2 6584.4 6624.1 6703.2 6735.8 6758.7 6746.4 6752.8 6776.2 6814.4 6833.7 7488.3 7639.0 7666.3 7667.5 7721.3 7595.2 7787.1 7839.5 7912.3 7926.8 5744.6 6051.2 6287.3 6387.3 6435.9 6703.2 6795.1 6843.3 6933.4 6942.2 5939.4 6269.1 6363.4 6426.6 6505.5 6122.7 6175.1 6203.8 6281.1 6305.0 6367.4 6367.9 6415.0 6428.0 6434.9 5766.2 5809.4 5875.0 5879.6 5880.3 5580.6 5929.9 5977.1 5978.0 6037.1 05:35:53 INFO - 2015-11-06 05:35:53,065 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,065 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5020.67 Median:5794.25 stddev:1554.53 (26.8%) stddev-sans-first:1517.84 05:35:53 INFO - 2015-11-06 05:35:53,066 DEBUG : BROWSER_OUTPUT: Values: 292.4 296.8 299.0 299.3 304.4 5668.5 5753.9 5802.2 5830.7 5837.8 5754.7 5766.4 5769.5 5773.7 5786.3 4134.1 4302.2 4338.4 4369.9 4370.1 4238.4 4239.5 4305.6 4344.7 4354.2 4251.2 4254.4 4274.5 4283.9 4303.7 4247.8 4269.2 4300.1 4315.2 4317.0 3670.2 3676.0 3698.1 3703.5 3711.9 5374.8 5470.3 5569.6 5571.9 5629.8 4815.6 4844.6 4851.4 4866.4 4873.1 5946.1 5950.6 5965.1 5993.9 6016.4 3985.9 3990.7 4026.0 4026.1 4028.6 6098.1 6219.7 6283.3 6292.0 6304.7 4028.8 4031.1 4037.6 4074.9 4081.9 4110.7 4115.5 4115.8 4118.3 4158.2 4803.2 4806.6 4815.8 4855.2 4864.2 5735.1 5942.6 5946.1 5994.0 6026.0 1464.3 1487.0 1487.6 1488.5 1501.3 923.9 932.7 944.2 949.1 953.3 5688.9 5693.1 5703.2 5739.5 5773.6 6237.1 6255.7 6288.5 6305.7 6309.9 5753.9 5767.0 5771.5 5817.3 5838.4 3380.4 3424.7 3465.0 3501.7 3520.4 6345.9 6360.2 6389.2 6416.9 6433.3 6202.3 6296.9 6376.4 6464.1 6515.2 6319.2 6365.9 6421.8 6427.5 6447.5 6235.4 6277.8 6296.3 6296.9 6311.6 5960.7 6085.0 6102.5 6129.1 6130.8 6308.2 6417.6 6493.0 6523.9 6524.4 4066.7 4117.4 4119.5 4148.4 4162.3 6171.4 6295.2 6317.4 6344.8 6361.0 6135.0 6147.1 6173.8 6184.7 6185.0 6108.3 6108.5 6163.1 6168.1 6174.0 5850.5 5929.2 5938.0 5959.6 6020.2 6133.4 6139.4 6180.5 6198.3 6206.8 5975.7 5984.3 5997.9 6070.5 6074.5 05:35:53 INFO - 2015-11-06 05:35:53,067 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,067 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13000.98 Median:558.37 stddev:15894.27 (2846.5%) stddev-sans-first:15911.70 05:35:53 INFO - 2015-11-06 05:35:53,068 DEBUG : BROWSER_OUTPUT: Values: 628.1 643.2 673.7 688.9 720.6 12577.8 12794.4 12876.0 12980.5 13021.1 12050.1 12557.2 12573.7 12678.7 12704.0 848.3 857.9 866.9 887.6 888.1 858.2 861.3 862.3 870.9 872.1 895.7 909.4 915.5 917.7 919.4 899.8 900.0 905.5 913.6 913.8 663.0 665.3 669.6 670.5 674.3 13285.1 13406.0 13433.6 13608.2 13627.0 10929.8 10963.2 10985.8 11185.5 11252.1 8880.2 8888.7 8888.8 8893.6 9422.2 3096.9 3116.7 3158.4 3295.0 3304.1 48222.3 48623.8 48624.3 48697.5 48996.8 8315.5 8392.0 8517.1 8624.1 8927.5 18292.8 18492.2 18521.7 18550.7 18589.8 6465.3 6469.9 6526.9 6528.2 6542.9 3505.1 3620.7 3635.2 3663.4 3664.4 2648.7 2675.9 2683.6 2697.1 2705.0 389.9 395.6 396.9 399.7 403.4 435.9 439.6 476.6 486.1 520.7 6667.4 7059.9 7182.2 7344.4 7348.3 529.3 558.3 558.4 559.6 563.6 3281.9 3515.8 3516.9 3597.5 3597.6 57196.1 57668.1 57928.7 57945.4 58047.0 48551.8 49251.3 49393.3 49493.5 49724.3 44619.6 44996.3 45019.8 45341.0 45506.1 6959.1 7010.9 7094.3 7496.2 7681.3 32740.0 33154.8 33560.3 33732.7 34140.0 42751.8 42893.8 44477.6 45001.3 45142.3 7016.7 7071.9 7158.0 7376.7 7435.0 10464.2 10478.5 10673.6 10772.3 10788.1 9454.7 9663.6 9685.0 9791.2 10352.8 9491.2 9818.2 9949.6 10142.2 10753.4 9303.0 9372.3 9467.6 9731.0 10112.7 8131.5 8139.3 8174.6 8215.8 8936.2 7558.5 7761.6 8239.8 8297.1 8339.5 05:35:53 INFO - 2015-11-06 05:35:53,068 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:35:53 INFO - 2015-11-06 05:35:53,068 DEBUG : BROWSER_OUTPUT: 05:35:53 INFO - 2015-11-06 05:35:53,722 INFO : Browser exited with error code: 0 05:35:53 INFO - 2015-11-06 05:35:53,753 INFO : Completed test dromaeo_css (00:18:32) 05:35:53 INFO - 2015-11-06 05:35:53,753 INFO : Starting test kraken 05:35:53 INFO - 2015-11-06 05:35:53,753 DEBUG : operating with platform_type : mac_ 05:35:53 INFO - 2015-11-06 05:35:53,753 INFO : Initialising browser for kraken test... 05:35:53 INFO - 2015-11-06 05:35:53,767 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpaxPZzN/profile http://localhost:49265/getInfo.html 05:35:56 INFO - 2015-11-06 05:35:56,755 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:35:56 INFO - 2015-11-06 05:35:56,755 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:35:56 INFO - 2015-11-06 05:35:56,755 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:35:56 INFO - 2015-11-06 05:35:56,755 DEBUG : BROWSER_OUTPUT: __metrics 05:35:57 INFO - 2015-11-06 05:35:57,392 INFO : Browser initialized. 05:35:57 INFO - 2015-11-06 05:35:57,393 INFO : Running cycle 1/1 for kraken test... 05:35:57 INFO - 2015-11-06 05:35:57,393 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpaxPZzN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:36:09 INFO - 2015-11-06 05:36:09,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 234643456 05:36:09 INFO - 2015-11-06 05:36:09,383 DEBUG : BROWSER_OUTPUT: 05:36:11 INFO - 2015-11-06 05:36:11,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:12 INFO - 2015-11-06 05:36:12,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 251412480 05:36:12 INFO - 2015-11-06 05:36:12,561 DEBUG : BROWSER_OUTPUT: 05:36:15 INFO - 2015-11-06 05:36:15,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 05:36:15 INFO - 2015-11-06 05:36:15,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 260198400 05:36:15 INFO - 2015-11-06 05:36:15,920 DEBUG : BROWSER_OUTPUT: 05:36:18 INFO - 2015-11-06 05:36:18,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 05:36:19 INFO - 2015-11-06 05:36:19,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 259813376 05:36:19 INFO - 2015-11-06 05:36:19,529 DEBUG : BROWSER_OUTPUT: 05:36:21 INFO - 2015-11-06 05:36:21,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 05:36:22 INFO - 2015-11-06 05:36:22,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 260255744 05:36:22 INFO - 2015-11-06 05:36:22,180 DEBUG : BROWSER_OUTPUT: 05:36:24 INFO - 2015-11-06 05:36:24,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:24 INFO - 2015-11-06 05:36:24,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 260816896 05:36:24 INFO - 2015-11-06 05:36:24,983 DEBUG : BROWSER_OUTPUT: 05:36:28 INFO - 2015-11-06 05:36:28,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:28 INFO - 2015-11-06 05:36:28,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 261857280 05:36:28 INFO - 2015-11-06 05:36:28,769 DEBUG : BROWSER_OUTPUT: 05:36:32 INFO - 2015-11-06 05:36:32,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:32 INFO - 2015-11-06 05:36:32,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 262115328 05:36:32 INFO - 2015-11-06 05:36:32,677 DEBUG : BROWSER_OUTPUT: 05:36:35 INFO - 2015-11-06 05:36:35,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 05:36:36 INFO - 2015-11-06 05:36:36,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 260173824 05:36:36 INFO - 2015-11-06 05:36:36,375 DEBUG : BROWSER_OUTPUT: 05:36:38 INFO - 2015-11-06 05:36:38,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:38 INFO - 2015-11-06 05:36:38,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 260763648 05:36:38 INFO - 2015-11-06 05:36:38,588 DEBUG : BROWSER_OUTPUT: 05:36:40 INFO - 2015-11-06 05:36:40,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:41 INFO - 2015-11-06 05:36:41,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 261009408 05:36:41 INFO - 2015-11-06 05:36:41,111 DEBUG : BROWSER_OUTPUT: 05:36:43 INFO - 2015-11-06 05:36:43,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:43 INFO - 2015-11-06 05:36:43,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 261304320 05:36:43 INFO - 2015-11-06 05:36:43,923 DEBUG : BROWSER_OUTPUT: 05:36:46 INFO - 2015-11-06 05:36:46,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:47 INFO - 2015-11-06 05:36:47,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 264093696 05:36:47 INFO - 2015-11-06 05:36:47,252 DEBUG : BROWSER_OUTPUT: 05:36:50 INFO - 2015-11-06 05:36:50,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:50 INFO - 2015-11-06 05:36:50,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 264118272 05:36:50 INFO - 2015-11-06 05:36:50,627 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 05:36:52 INFO - 2015-11-06 05:36:52,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 265207808 05:36:52 INFO - 2015-11-06 05:36:52,649 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,649 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:36:52 INFO - 2015-11-06 05:36:52,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:36:52 INFO - 2015-11-06 05:36:52,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;102;108;110;112;121;110;115;109;112 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;136;156;176;148;165;163;144;177;145 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;175;176;186;187;184;184;185;187;181 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;74;86;118;75;73;78;78;125;75 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;92;131;96;100;99;138;98;95;135 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;125;125;131;131;136;129;125;130;131;131 05:36:52 INFO - 2015-11-06 05:36:52,650 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;134;137;142;143;143;138;143;142;142;137 05:36:52 INFO - 2015-11-06 05:36:52,651 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;106;131;131;121;117;119;116;116;116;115 05:36:52 INFO - 2015-11-06 05:36:52,651 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;63;66;69;70;69;77;67;70 05:36:52 INFO - 2015-11-06 05:36:52,651 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;76;70;72;73;77;77;77;78;78 05:36:52 INFO - 2015-11-06 05:36:52,651 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;90;97;99;97;98;97;99;100;99 05:36:52 INFO - 2015-11-06 05:36:52,651 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;139;147;142;156;156;139;137;145;146 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;161;171;172;179;174;167;163;175;179 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;70;73;79;79;79;84;80;79 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,701 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1446817012643__endTimestamp 05:36:52 INFO - 2015-11-06 05:36:52,652 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:4.92 (4.4%) stddev-sans-first:5.17 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: Values: 109.0 102.0 108.0 110.0 112.0 121.0 110.0 115.0 109.0 112.0 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:156.10 Median:159.50 stddev:13.84 (8.7%) stddev-sans-first:14.56 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: Values: 151.0 136.0 156.0 176.0 148.0 165.0 163.0 144.0 177.0 145.0 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,653 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.00 Median:184.50 stddev:7.06 (3.8%) stddev-sans-first:4.52 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: Values: 165.0 175.0 176.0 186.0 187.0 184.0 184.0 185.0 187.0 181.0 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.70 Median:75.00 stddev:19.29 (25.7%) stddev-sans-first:20.07 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 86.0 118.0 75.0 73.0 78.0 78.0 125.0 75.0 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.50 stddev:19.13 (20.5%) stddev-sans-first:19.22 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 131.0 96.0 100.0 99.0 138.0 98.0 95.0 135.0 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:129.40 Median:131.00 stddev:3.53 (2.7%) stddev-sans-first:3.37 05:36:52 INFO - 2015-11-06 05:36:52,654 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 131.0 131.0 136.0 129.0 125.0 130.0 131.0 131.0 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:140.10 Median:142.00 stddev:3.28 (2.3%) stddev-sans-first:2.64 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: Values: 134.0 137.0 142.0 143.0 143.0 138.0 143.0 142.0 142.0 137.0 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:118.80 Median:118.00 stddev:7.51 (6.4%) stddev-sans-first:6.38 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: Values: 106.0 131.0 131.0 121.0 117.0 119.0 116.0 116.0 116.0 115.0 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,655 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.40 Median:69.00 stddev:4.74 (6.9%) stddev-sans-first:4.43 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 63.0 66.0 69.0 70.0 69.0 77.0 67.0 70.0 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:77.00 stddev:3.22 (4.2%) stddev-sans-first:2.92 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: Values: 70.0 76.0 70.0 72.0 73.0 77.0 77.0 77.0 78.0 78.0 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:97.50 stddev:3.63 (3.7%) stddev-sans-first:2.96 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 97.0 99.0 97.0 98.0 97.0 99.0 100.0 99.0 05:36:52 INFO - 2015-11-06 05:36:52,656 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:145.50 stddev:7.98 (5.5%) stddev-sans-first:7.00 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: Values: 131.0 139.0 147.0 142.0 156.0 156.0 139.0 137.0 145.0 146.0 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:173.00 stddev:8.60 (5.0%) stddev-sans-first:6.46 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: Values: 152.0 161.0 171.0 172.0 179.0 174.0 167.0 163.0 175.0 179.0 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:79.00 stddev:4.95 (6.3%) stddev-sans-first:4.68 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 73.0 79.0 79.0 79.0 84.0 80.0 79.0 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:36:52 INFO - 2015-11-06 05:36:52,657 DEBUG : BROWSER_OUTPUT: 05:36:53 INFO - 2015-11-06 05:36:53,322 INFO : Browser exited with error code: 0 05:36:53 INFO - 2015-11-06 05:36:53,374 INFO : Completed test kraken (00:00:59) 05:36:53 INFO - 2015-11-06 05:36:53,375 INFO : Starting test v8_7 05:36:53 INFO - 2015-11-06 05:36:53,375 DEBUG : operating with platform_type : mac_ 05:36:53 INFO - 2015-11-06 05:36:53,375 INFO : Initialising browser for v8_7 test... 05:36:53 INFO - 2015-11-06 05:36:53,389 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpF7tV7o/profile http://localhost:49265/getInfo.html 05:36:56 INFO - 2015-11-06 05:36:56,246 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:36:56 INFO - 2015-11-06 05:36:56,246 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:36:56 INFO - 2015-11-06 05:36:56,246 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:36:56 INFO - 2015-11-06 05:36:56,246 DEBUG : BROWSER_OUTPUT: __metrics 05:36:56 INFO - 2015-11-06 05:36:56,908 INFO : Browser initialized. 05:36:56 INFO - 2015-11-06 05:36:56,909 INFO : Running cycle 1/1 for v8_7 test... 05:36:56 INFO - 2015-11-06 05:36:56,909 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpF7tV7o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:37:08 INFO - 2015-11-06 05:37:08,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 233480192 05:37:08 INFO - 2015-11-06 05:37:08,891 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 05:37:30 INFO - 2015-11-06 05:37:30,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 253624320 05:37:30 INFO - 2015-11-06 05:37:30,583 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,583 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:37:30 INFO - 2015-11-06 05:37:30,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |0;Richards;170.88174982911826 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.02020202020202 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |2;Encrypt;352.98270384751146 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6147.239263803681 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1203.3694344163657 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |5;Earley;863.5578583765113 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |6;Boyer;13025.974025974027 05:37:30 INFO - 2015-11-06 05:37:30,584 DEBUG : BROWSER_OUTPUT: |7;RegExp;30787.878787878788 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: |8;Splay;694.9270326615705 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6153.374233128834 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1446817050580__endTimestamp 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.88 Median:170.88 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: Values: 170.9 05:37:30 INFO - 2015-11-06 05:37:30,585 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.02 Median:202.02 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: Values: 202.0 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:352.98 Median:352.98 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: Values: 353.0 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6147.24 Median:6147.24 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,586 DEBUG : BROWSER_OUTPUT: Values: 6147.2 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1203.37 Median:1203.37 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: Values: 1203.4 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:863.56 Median:863.56 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: Values: 863.6 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13025.97 Median:13025.97 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,587 DEBUG : BROWSER_OUTPUT: Values: 13026.0 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30787.88 Median:30787.88 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: Values: 30787.9 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:694.93 Median:694.93 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: Values: 694.9 05:37:30 INFO - 2015-11-06 05:37:30,588 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-06 05:37:30,589 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6153.37 Median:6153.37 stddev:0.00 (0.0%) 05:37:30 INFO - 2015-11-06 05:37:30,589 DEBUG : BROWSER_OUTPUT: Values: 6153.4 05:37:30 INFO - 2015-11-06 05:37:30,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:37:30 INFO - 2015-11-06 05:37:30,589 DEBUG : BROWSER_OUTPUT: 05:37:31 INFO - 2015-11-06 05:37:31,238 INFO : Browser exited with error code: 0 05:37:31 INFO - 2015-11-06 05:37:31,260 INFO : Completed test v8_7 (00:00:37) 05:37:31 INFO - 2015-11-06 05:37:31,707 INFO : Completed test suite (00:20:10) 05:37:31 INFO - 2015-11-06 05:37:31,708 DEBUG : Working with test: dromaeo_css 05:37:31 INFO - 2015-11-06 05:37:31,708 DEBUG : Generating results file: dromaeo_css 05:37:31 INFO - 2015-11-06 05:37:31,709 DEBUG : Working with test: kraken 05:37:31 INFO - 2015-11-06 05:37:31,709 DEBUG : Generating results file: kraken 05:37:31 INFO - 2015-11-06 05:37:31,709 INFO : javascript benchmark 05:37:31 INFO - 2015-11-06 05:37:31,709 DEBUG : Working with test: v8_7 05:37:31 INFO - 2015-11-06 05:37:31,709 DEBUG : Generating results file: v8_7 05:37:31 INFO - 2015-11-06 05:37:31,709 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:31 INFO - 2015-11-06 05:37:31,760 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:37:31 INFO - 2015-11-06 05:37:31,761 DEBUG : process_Request line: dromaeo_css 6345.01 graph.html#tests=[[72,1,57]] 05:37:31 INFO - 2015-11-06 05:37:31,761 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:31 INFO - 2015-11-06 05:37:31,795 DEBUG : process_Request line: kraken 1657.60 graph.html#tests=[[232,1,57]] 05:37:31 INFO - 2015-11-06 05:37:31,795 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:31 INFO - 2015-11-06 05:37:31,824 DEBUG : process_Request line: v8_7 18500.97 graph.html#tests=[[230,1,57]] 05:37:31 INFO - 2015-11-06 05:37:31,825 INFO : javascript benchmark 05:37:31 INFO - 2015-11-06 05:37:31,827 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [307.3698917219699, 308.0143540669857, 308.31400134700283, 314.7277604871786, 315.96208454985396, 10991.175661825375, 11402.087832973362, 16124.113173775439, 16580.668386632275, 16766.91616541917, 10853.403062831541, 10905.730129390016, 10993.0, 11068.225224234307, 11224.775504489906, 4124.9587504124875, 4238.87283381499, 4242.639375653073, 4249.490061192661, 4272.444582204309, 4085.162541678949, 4171.895702607444, 4175.561566035568, 4192.496900371944, 4232.174725928445, 4115.1975364803875, 4119.052617897885, 4187.476565429321, 4327.350897365389, 4336.891577710551, 4286.7642279674765, 4290.656747460196, 4304.569543045702, 4319.848805291831, 4320.395144679747, 3661.7802931824176, 3698.130939229306, 3837.846486140551, 3838.6929045676557, 3841.8847434577006, 12084.516619335216, 12181.208221465666, 12260.080493962989, 12319.69200769979, 12594.43325050375, 1811.1759149587037, 1853.4347024157626, 1952.3654812185955, 2076.4497408186844, 2164.6211912915333, 11503.482343294572, 13149.0, 13482.123661961941, 13927.860721392757, 14302.499412520512, 1646.4072933743842, 1650.8844380893343, 1675.790526184227, 1693.7290033594566, 1748.4841971618403, 49759.502404976214, 62415.0, 62643.686781566255, 63760.68119659418, 63868.0, 15983.840161598468, 16309.347626094823, 16384.918075409547, 16434.6713065738, 16462.094584797713, 22969.770302297096, 23065.538689226123, 23257.651135232984, 23268.0, 23343.533129337316, 8910.599023043978, 8932.821343573092, 9004.59479323432, 9032.954835225783, 9091.95442524105, 7553.622318884034, 7583.27958843909, 7584.5070070445245, 7614.162442131361, 7691.923080769121, 7675.117361503499, 7724.188960159215, 7728.26581474759, 7754.7673569793, 7817.061952565615, 3194.6965038321323, 3258.4258435835422, 3284.425225585513, 3310.7185889199204, 3406.0803583032443, 351.0889242415927, 352.6121266606712, 357.5816294934932, 366.4667908193572, 409.4227139732962, 9225.0, 9465.290103242285, 9602.759931001641, 9610.423374597547, 9696.75758106053, 373.6655693154666, 373.8840959302625, 376.06547728894225, 381.44118865861094, 390.392938979889, 4974.701517908937, 5199.896002079937, 5202.14164662834, 5266.0257852297445, 5284.524392804666, 479792.0, 529062.0, 537378.6262137407, 553780.0, 559439.0, 64475.0, 67038.66480667566, 67381.32618673751, 67530.66234668795, 67853.0, 450.7858767085608, 460.3784890397936, 461.15838594564383, 461.4462644826289, 461.70220207965673, 10219.28465007472, 10377.429241391796, 10441.216908732027, 10453.111485523816, 10516.106130978953, 32295.67704322927, 33236.16909577183, 33387.33225335431, 33615.83192084024, 33680.66319336873, 44435.0, 45107.54892451165, 45299.77350113228, 45514.31728524008, 45940.310895337265, 5647.20939068539, 5714.20001199824, 5716.571257155813, 5728.570357223141, 5740.942590574041, 10496.160307175254, 10597.735056623646, 11018.063464605279, 11021.724456888642, 11084.778304434027, 8017.0, 8299.709510167115, 9185.127412895765, 9452.905470945203, 9572.234221262142, 12961.805572916603, 13849.861501384858, 13989.930050349683, 14013.29933503341, 14113.506027288995, 13692.0, 13706.0, 14183.574492765234, 14438.32890915184, 14538.709225815213, 13415.932920335727, 13504.932475337953, 13672.0, 13952.37214325378, 13987.0, 13736.175829450265, 14212.928935355258, 14263.928680356532, 14293.64265893361, 14645.048071875293], "dojo.html": [2968.4359971605395, 3058.0825752274313, 3059.281068948795, 3176.1583180457174, 3205.583274174358, 5045.596352291817, 5082.0598189335, 5103.948960510394, 5114.795408183672, 5117.5650069744115, 4880.438749543795, 4920.237363208699, 4977.626677999156, 4988.401391832976, 5098.209777484487, 4608.700434471749, 4646.97676511617, 4707.717536947777, 4786.4974177711365, 4793.9520604794025, 4554.339620755005, 4627.375304333922, 4634.21218392874, 4640.303954406832, 4660.86017419478, 4497.910041799146, 4537.478190008158, 4614.5385461453925, 4671.065786842645, 4710.5289471052965, 4649.907001859978, 4671.182543054986, 4680.899988502699, 4691.249400095969, 4726.834560790356, 4639.5360463953675, 4645.326427667969, 4670.182718024366, 4690.906181876378, 4764.833230836939, 4762.738049407316, 4825.252085926687, 4916.680415772999, 4994.750262486898, 5039.974800125976, 5237.947620523784, 5347.331583552056, 5367.0, 5394.460553944574, 5400.83797486076, 5289.021531016736, 5419.187121931703, 5483.479069488392, 5485.314335708036, 5489.094299440588, 4961.875953101201, 4963.8262660806695, 4967.726775027336, 4981.651284410056, 5048.899022019539, 5473.124300112043, 5529.640573362719, 5550.694711790809, 5561.054620714488, 5619.578531610146, 4976.4525902150735, 5137.434882162959, 5341.946580534145, 5342.1452567589, 5346.331708536433, 5396.4333744957, 5411.080116380225, 5428.83713488596, 5471.890562188734, 5506.146547285177, 5361.758720857492, 5425.430329815392, 5435.945640543544, 5455.918161227585, 5489.807856724996, 5051.772670229849, 5232.738363081907, 5310.707911064928, 5377.7311134443125, 5389.110796718497, 4244.278472659656, 4249.596288352602, 4249.660027197817, 4254.914901701949, 4257.829686812554, 3858.3826587745825, 3866.613338666111, 3878.5927477614446, 3896.7661940283106, 3928.626780455852, 4812.302216178635, 4969.950300497021, 4991.675541089818, 5054.671446355975, 5105.7191854448365, 5433.239346491494, 5457.836264912059, 5488.807891723771, 5502.779888804403, 5513.531349835229, 5071.721055341992, 5075.441701412841, 5145.845624631267, 5171.793128274902, 5184.7407629618365, 4616.838410655611, 4646.605038571759, 4664.137134630104, 4683.484816670163, 4767.570918617272, 5528.695921724344, 5551.8889622206525, 5571.164325351067, 5572.637778544301, 5575.832725018256, 5208.687478751287, 5471.206675032177, 5496.367917689517, 5509.559235261089, 5522.696251706195, 5523.558115350843, 5584.692841893735, 5586.664800112007, 5591.021571224938, 5598.3282006159525, 5398.9190162146815, 5448.945510544844, 5463.890722185454, 5465.426130256265, 5471.069918113851, 5173.689578625294, 5199.66202196856, 5504.036793561191, 5512.6968016759465, 5578.30271216098, 4961.1318019345745, 5085.084684756779, 5258.605604579595, 5275.577953763613, 5288.550473209821, 5282.996230716151, 5283.2075188722, 5292.788288468572, 5349.1976203569775, 5353.304070470814, 4961.404631444249, 4967.801287948441, 5018.297438358706, 5186.06650802844, 5226.137687281708, 5282.392524859691, 5286.392064912584, 5297.205419186998, 5342.091844386386, 5373.086575282133, 5191.065608190562, 5194.610404219774, 5242.5281724644965, 5245.344331958505, 5248.6325957182635], "mootools.html": [1456.2500312339141, 1568.2237292540194, 1625.983740162598, 1639.5737108351825, 1650.0594661043203, 6476.870462590746, 6506.54454188207, 6940.479464040198, 7254.0932383452, 7281.34467897889, 6941.4793890458295, 7082.114735658043, 7084.64576771162, 7156.284371562854, 7174.7130114795345, 1990.044778506318, 1998.6702194138022, 2025.7670367907658, 2027.027027027028, 2029.6955456681542, 2023.666095094315, 2033.918643254268, 2050.661640829261, 2050.6821442676332, 2074.751029876417, 1972.0139930034982, 2011.718359429681, 2013.7281467001915, 2038.0319348309508, 2038.1847261095606, 2012.4163992442175, 2018.8687735297158, 2049.456893923104, 2049.5695903860205, 2051.2205361962433, 2027.482991837087, 2044.4684382060623, 2046.6623007203793, 2050.323393280214, 2076.252549082329, 7078.646067696594, 7109.537880037781, 7141.392981596518, 7145.749898753571, 7171.103612048494, 4270.12462445198, 4350.782460876943, 4359.411479450266, 4359.585839345257, 4374.650027997753, 2642.881070351839, 2649.205238428483, 2683.047518131055, 2741.616173735679, 2768.0726956469607, 821.2157389692829, 829.402829962426, 837.6816809612369, 847.5465625890181, 853.6884037326394, 9076.954615226881, 9080.0, 9087.772805679844, 9094.954525227331, 9162.129597688208, 3866.052817059838, 3877.3990031545154, 3930.331843586597, 3950.6049395060263, 3955.7626542407547, 8006.119326874039, 8018.358531317481, 8035.638396272065, 8066.677332906618, 8124.7562573122905, 4397.032652816375, 4404.559544045634, 4407.933880991788, 4414.0, 4443.955560444419, 3619.5475565554307, 3775.0562359410146, 3915.4322623219473, 4031.07285324377, 4066.9186616267507, 3303.6861498157637, 3388.9491657625153, 3394.253264281854, 3419.2990436960363, 3436.3127374525193, 1082.2802836113897, 1094.195766111907, 1097.7475180708482, 1100.4167791070745, 1102.6802227354137, 904.2359206470522, 910.4264313482464, 916.5279880861361, 917.2936838634214, 917.8531434970373, 6713.832154196184, 6740.359665831738, 6759.695813688396, 6799.932000680029, 6818.113645226089, 389.8187342885572, 397.97811120388656, 399.32514051253287, 399.40289267545205, 423.66953776054726, 5385.272988146628, 5428.050091234098, 5441.428649991773, 5441.918371224435, 5493.258410114583, 8139.959300203461, 8292.626831792584, 8326.417150799507, 8408.915910840935, 8416.873746893802, 8371.916280837235, 8394.748157555283, 8429.367797415218, 8444.451110677786, 8459.196376344238, 6584.440322572635, 6624.072629831828, 6703.229128650268, 6735.764248251386, 6758.695858686371, 6746.392824645805, 6752.797416077526, 6776.15298087739, 6814.352636499525, 6833.658317084225, 7488.251174882468, 7639.04511936008, 7666.348360389429, 7667.501612395176, 7721.343685786771, 7595.240475952361, 7787.104482984303, 7839.490433121829, 7912.32745216663, 7926.841463170819, 5744.5978781486565, 6051.213342265477, 6287.339829317856, 6387.297397286202, 6435.871282574416, 6703.162104736908, 6795.082663840319, 6843.281455447305, 6933.445324374139, 6942.166939967236, 5939.376365481735, 6269.090981807703, 6363.427291543783, 6426.550141490051, 6505.5446118773125, 6122.6938653068055, 6175.104609831639, 6203.8138855834395, 6281.089242059968, 6304.968475157595, 6367.395097465918, 6367.872642547216, 6415.005674120519, 6428.035794630843, 6434.903476447764, 5766.192733017297, 5809.360970293349, 5875.030619947832, 5879.647221166743, 5880.26496687914, 5580.581456390868, 5929.9110513341475, 5977.103434484862, 5978.043513037893, 6037.09443583466], "ext.html": [505.58541995563655, 521.7886755863874, 527.2118183315944, 549.1433363952233, 559.5635404384581, 37232.25535489292, 37949.620503794955, 38189.0, 38230.235395292075, 38334.424983625235, 39930.60069399305, 40419.797901010454, 40442.59557404425, 40820.183596328054, 40886.59113408865, 8704.825903481942, 8780.341474389446, 8809.0, 8819.250363719091, 8867.512286824222, 8512.446690965067, 8614.095519970408, 8633.223009929105, 8686.652533898636, 8748.037715851251, 8532.914670853273, 8635.654573817039, 8638.0, 8644.827103457927, 8704.912950870505, 8584.442011269279, 8585.18440748128, 8603.569821508961, 8606.268467180296, 8681.95659021704, 8435.367347448966, 8580.099089595627, 8593.054763975957, 8611.6985905493, 8700.129987001312, 37232.813835930916, 37711.811440942896, 37731.62268377309, 38042.80978595117, 38066.670666106766, 2999.820010799337, 3087.4905640569277, 3187.7768556201077, 3287.7205437537837, 3399.7790143640586, 26251.73748262531, 26527.368603470975, 26625.73374266252, 26757.331066723487, 27451.588226176624, 2237.5413040326694, 2278.897449614771, 2282.7260728712495, 2283.44055706353, 2301.5972204864247, 262369.0, 262596.0, 263444.0, 264005.0, 267113.9999999981, 38139.61860381416, 39270.214595708494, 39331.606683933365, 53976.730116349165, 54272.01503917244, 37735.43396849049, 37955.81022094927, 38122.42816357757, 38165.809170953966, 38275.23449530994, 12955.481780728855, 12974.870251297554, 12978.870211297955, 13096.934515327554, 13102.80345794814, 10125.64560240388, 10192.949035254924, 10193.0, 10212.795744085226, 10266.6406675766, 13080.215187088805, 13110.0, 13118.0, 13149.934250328688, 13290.202587844567, 5426.2674538936735, 5727.828165155052, 5749.367569567345, 5749.3963133871175, 5760.395158508296, 828.6850996621246, 870.277669534285, 882.2412725056446, 889.3596610440472, 993.6224234790733, 27044.459110817672, 27187.592186117225, 27196.0, 27315.621298241167, 27784.444311113664, 1019.5157300282455, 1020.3418794877263, 1033.1115240892825, 1116.0, 1131.4641744548287, 14155.363008664635, 14166.575002749934, 14249.145051296955, 14627.19550424737, 14712.264386780618, 359935.0, 364023.0, 365555.0, 367209.0, 367762.0, 53955.460445395045, 54286.72856635691, 54308.0, 54475.45524544783, 54484.63788405321, 1315.7763180259187, 1319.577735124751, 1327.8074679171466, 1330.7937269723209, 1342.543340475595, 26312.8684356577, 26882.731172688804, 27403.725962740915, 27460.45079098367, 27533.31166720848, 43532.782336088116, 44570.55429445664, 44625.10749785051, 44632.33051504295, 44754.77622611866, 245303.0, 247525.0, 247571.0, 247850.0, 248640.0, 30370.84814575913, 30856.38287234198, 42730.14539709251, 44069.55930440783, 44439.55560444354, 40111.79944100261, 40592.188156236116, 40838.1832363357, 40949.795251023555, 41221.48087062926, 34325.0, 34891.65108348884, 35009.64990350064, 35119.18974848791, 35704.28591428105, 33659.32681346311, 33829.492557612146, 34193.0, 34245.48631770476, 34339.4849077269, 34378.82810585931, 35009.64990350064, 35027.299454011285, 35228.0, 35454.29091418105, 29114.854425727735, 30469.390612187188, 30728.078157655305, 30740.23149421193, 30780.53829192519, 22877.771222287563, 22938.54122917566, 22991.6551251728, 23177.188798391977, 23255.88372058129], "prototype.html": [292.38307171867353, 296.7729686789605, 298.95216765317554, 299.34592914481857, 304.4276759691779, 5668.546516278698, 5753.856153596157, 5802.187693722877, 5830.737616807243, 5837.766489340422, 5754.74103665335, 5766.423357664232, 5769.509591684712, 5773.653580785145, 5786.305643322808, 4134.111166099288, 4302.247106756321, 4338.4143140676, 4369.934450983238, 4370.082282720632, 4238.4490016298, 4239.47006624172, 4305.5909688579695, 4344.674149438789, 4354.172707185625, 4251.213525497793, 4254.404383386328, 4274.465691788527, 4283.935740963888, 4303.655707543389, 4247.787610619472, 4269.231538323101, 4300.075483770988, 4315.180115777992, 4316.956830431687, 3670.210904655512, 3676.0442285005824, 3698.14942563212, 3703.5185925629694, 3711.925761484755, 5374.811881584164, 5470.316210473691, 5569.610127291091, 5571.8885622287735, 5629.8311050668135, 4815.6388270879825, 4844.5882100021545, 4851.393575803025, 4866.4403593586485, 4873.147199240118, 5946.137810017523, 5950.553708471882, 5965.105234214859, 5993.91009134859, 6016.42843929826, 3985.880423587297, 3990.700697447703, 4026.033751899523, 4026.094128821021, 4028.5568587455355, 6098.0852872069545, 6219.720112594944, 6283.340249273851, 6292.0, 6304.716287767062, 4028.7582745035393, 4031.133306339151, 4037.555868854424, 4074.9388759168637, 4081.9387709184384, 4110.650594699424, 4115.506139263308, 4115.794210289474, 4118.279301122351, 4158.2307273154565, 4803.159447096744, 4806.639502037361, 4815.807367705323, 4855.247436647325, 4864.197407427735, 5735.139729040594, 5942.61373010753, 5946.137810017523, 5994.0, 6026.035834266497, 1464.326409851459, 1487.0, 1487.5760408283588, 1488.5087920986266, 1501.2643804535699, 923.9076092390842, 932.6735642525198, 944.1832814615308, 949.1362859797551, 953.3231405702029, 5688.857778555486, 5693.146028095819, 5703.201551782754, 5739.540836733051, 5773.566982476331, 6237.126802247689, 6255.718492667841, 6288.496920246369, 6305.684715764193, 6309.905351419732, 5753.85615359611, 5767.019606666877, 5771.451712087345, 5817.301923769175, 5838.357780644125, 3380.4084285250474, 3424.6917777400154, 3464.9653503465147, 3501.6673416025437, 3520.436730123219, 6345.936540634627, 6360.173177486897, 6389.233292004989, 6416.935830641727, 6433.260175079832, 6202.2867370253, 6296.937030629727, 6376.426121648981, 6464.127342808754, 6515.2181738190775, 6319.178506794087, 6365.8726825464155, 6421.8073457796345, 6427.485801135991, 6447.548671593037, 6235.407636274546, 6277.843053923689, 6296.338884417253, 6296.905546416716, 6311.558190926591, 5960.731767070405, 6085.0, 6102.4507794298725, 6129.08063790435, 6130.846728831815, 6308.243010838729, 6417.614943103429, 6493.026046093124, 6523.869522609616, 6524.380183882524, 4066.7153299268766, 4117.382392641128, 4119.485064366954, 4148.377743338523, 4162.334026555736, 6171.413715697002, 6295.244570651551, 6317.368263173646, 6344.777932772331, 6361.0, 6134.969325153345, 6147.139400483847, 6173.81478555644, 6184.721687523982, 6185.0, 6108.297545782292, 6108.541859360477, 6163.075538669235, 6168.136460895388, 6173.969130154321, 5850.473457388685, 5929.199558059607, 5937.970310148595, 5959.612625179349, 6020.217371741645, 6133.44798968095, 6139.447449729546, 6180.505559555135, 6198.256209254918, 6206.751729930752, 5975.671338076448, 5984.251968503937, 5997.850053748692, 6070.514358851193, 6074.544409169242], "yui.html": [628.1494439088387, 643.1703102997134, 673.7002034094827, 688.8758933084874, 720.5712601002404, 12577.811332830004, 12794.424250908709, 12876.034297427695, 12980.545680901147, 13021.088523803337, 12050.096242781805, 12557.183783054117, 12573.748525029494, 12678.746425071493, 12704.0, 848.2704873808535, 857.8927634045745, 866.9306455483578, 887.5784002598779, 888.0719647967857, 858.1932982995963, 861.3023451004675, 862.3316929379719, 870.8954925408959, 872.0538216035609, 895.7133717210495, 909.4316052467208, 915.5010519266982, 917.6650522559285, 919.4069824962895, 899.7705585075829, 900.0279697926256, 905.4748246017294, 913.634546181526, 913.7989642278689, 662.9657733935077, 665.3346653346654, 669.581511555278, 670.4770279182197, 674.2650510943047, 13285.13646612967, 13406.0, 13433.596992090253, 13608.183508989492, 13627.0, 10929.836052459219, 10963.232573719843, 10985.791562928072, 11185.49665265065, 11252.099832013419, 8880.1563851434, 8888.73333799987, 8888.778402028525, 8893.644254229823, 9422.199113075398, 3096.938061238785, 3116.703913128249, 3158.384115097557, 3295.0279667497907, 3304.0913748719054, 48222.27666585004, 48623.75688121572, 48624.27063594049, 48697.51302486965, 48996.75501622469, 8315.501069935823, 8391.992960844738, 8517.105703901125, 8624.137586241452, 8927.508987005647, 18292.817071829377, 18492.167852446673, 18521.722174167397, 18550.72173917392, 18589.81410185908, 6465.288818229991, 6469.8706025880165, 6526.934730652728, 6528.183977002875, 6542.869142617121, 3505.1412403961194, 3620.71034317254, 3635.2002559436883, 3663.358912190356, 3664.4320130379833, 2648.748368904951, 2675.879585418661, 2683.5706286993986, 2697.1099537153086, 2704.9729502705113, 389.93760998240714, 395.580684474458, 396.8710169195023, 399.7241903086861, 403.40094958985884, 435.8932061644854, 439.56483081748837, 476.5901324860617, 486.13225392673905, 520.7084032941565, 6667.399934005865, 7059.92940070603, 7182.2458641842895, 7344.375728063068, 7348.265173482716, 529.343613918738, 558.3076984539142, 558.439945348404, 559.6026820957165, 563.6411617381191, 3281.868725250963, 3515.7538972272205, 3516.8593256269464, 3597.460380942827, 3597.568291805, 57196.14205786917, 57668.134977975365, 57928.71035644795, 57945.42054579485, 58047.0, 48551.75724121357, 49251.26123108156, 49393.259101113515, 49493.50506494961, 49724.254136187985, 44619.55380446154, 44996.3250551242, 45019.77490112528, 45341.0, 45506.08987820291, 6959.130108736408, 7010.859782804418, 7094.255103214088, 7496.175420703609, 7681.347085497572, 32740.0, 33154.834225828716, 33560.328793423505, 33732.66267337295, 34140.0, 42751.78624106859, 42893.785531073394, 44477.555224447344, 45001.32498012467, 45142.32286515639, 7016.684249208696, 7071.858562828817, 7158.0, 7376.7418140364825, 7434.962825185839, 10464.215183861394, 10478.528466219192, 10673.626423075155, 10772.299800512941, 10788.136949044214, 9454.669086581936, 9663.565139568596, 9685.0, 9791.167750741266, 10352.792944140925, 9491.193248573949, 9818.165455936325, 9949.602015919281, 10142.239332050274, 10753.354798712102, 9303.0, 9372.250219982248, 9467.573959171992, 9730.95134524323, 10112.696619101438, 8131.512109273463, 8139.348852091937, 8174.632141553526, 8215.753527393948, 8936.24041956441, 7558.470907036454, 7761.61191940412, 8239.794005149679, 8297.08732039463, 8339.45793523419]}, "summary": {"suite": 6345.01344566009, "subtests": {"jquery.html": {"filtered": 7584.706718866078, "value": 7584.706718866078}, "dojo.html": {"filtered": 4998.428726399081, "value": 4998.428726399081}, "mootools.html": {"filtered": 3957.844495791678, "value": 3957.844495791678}, "ext.html": {"filtered": 16944.964863115263, "value": 16944.964863115263}, "prototype.html": {"filtered": 4502.806112857784, "value": 4502.806112857784}, "yui.html": {"filtered": 5699.002785390106, "value": 5699.002785390106}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0027.e"}, "testrun": {"date": 1446815840, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151106032135", "branch": "Firefox", "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90"}}, {"talos_counters": {}, "results": {"audio-dft": [165.0, 175.0, 176.0, 186.0, 187.0, 184.0, 184.0, 185.0, 187.0, 181.0], "ai-astar": [109.0, 102.0, 108.0, 110.0, 112.0, 121.0, 110.0, 115.0, 109.0, 112.0], "imaging-gaussian-blur": [125.0, 125.0, 131.0, 131.0, 136.0, 129.0, 125.0, 130.0, 131.0, 131.0], "audio-beat-detection": [151.0, 136.0, 156.0, 176.0, 148.0, 165.0, 163.0, 144.0, 177.0, 145.0], "json-stringify-tinderbox": [70.0, 76.0, 70.0, 72.0, 73.0, 77.0, 77.0, 77.0, 78.0, 78.0], "stanford-crypto-pbkdf2": [152.0, 161.0, 171.0, 172.0, 179.0, 174.0, 167.0, 163.0, 175.0, 179.0], "json-parse-financial": [61.0, 62.0, 63.0, 66.0, 69.0, 70.0, 69.0, 77.0, 67.0, 70.0], "stanford-crypto-sha256-iterative": [70.0, 71.0, 70.0, 73.0, 79.0, 79.0, 79.0, 84.0, 80.0, 79.0], "audio-fft": [75.0, 74.0, 86.0, 118.0, 75.0, 73.0, 78.0, 78.0, 125.0, 75.0], "imaging-darkroom": [134.0, 137.0, 142.0, 143.0, 143.0, 138.0, 143.0, 142.0, 142.0, 137.0], "stanford-crypto-ccm": [131.0, 139.0, 147.0, 142.0, 156.0, 156.0, 139.0, 137.0, 145.0, 146.0], "audio-oscillator": [90.0, 92.0, 131.0, 96.0, 100.0, 99.0, 138.0, 98.0, 95.0, 135.0], "stanford-crypto-aes": [90.0, 90.0, 97.0, 99.0, 97.0, 98.0, 97.0, 99.0, 100.0, 99.0], "imaging-desaturate": [106.0, 131.0, 131.0, 121.0, 117.0, 119.0, 116.0, 116.0, 116.0, 115.0]}, "summary": {"suite": 1657.6, "subtests": {"audio-fft": {"filtered": 85.7, "value": 85.7}, "stanford-crypto-pbkdf2": {"filtered": 169.3, "value": 169.3}, "audio-beat-detection": {"filtered": 156.1, "value": 156.1}, "stanford-crypto-ccm": {"filtered": 143.8, "value": 143.8}, "imaging-darkroom": {"filtered": 140.1, "value": 140.1}, "json-parse-financial": {"filtered": 67.4, "value": 67.4}, "audio-oscillator": {"filtered": 107.4, "value": 107.4}, "ai-astar": {"filtered": 110.8, "value": 110.8}, "audio-dft": {"filtered": 181.0, "value": 181.0}, "stanford-crypto-sha256-iterative": {"filtered": 76.4, "value": 76.4}, "json-stringify-tinderbox": {"filtered": 74.8, "value": 74.8}, "imaging-gaussian-blur": {"filtered": 129.4, "value": 129.4}, "stanford-crypto-aes": {"filtered": 96.6, "value": 96.6}, "imaging-desaturate": {"filtered": 118.8, "value": 118.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0027.e"}, "testrun": {"date": 1446815840, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151106032135", "branch": "Firefox", "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.02020202020202], "Encrypt": [352.98270384751146], "NavierStokes": [6153.374233128834], "Decrypt": [6147.239263803681], "Splay": [694.9270326615705], "Richards": [170.88174982911826], "RegExp": [30787.878787878788], "Earley": [863.5578583765113], "Boyer": [13025.974025974027], "RayTrace": [1203.3694344163657]}, "summary": {"suite": 18500.96949393289, "subtests": {"DeltaBlue": {"filtered": 327.2840999999999, "value": 327.2840999999999}, "Encrypt": {"filtered": 754.0907730000001, "value": 754.0907730000001}, "NavierStokes": {"filtered": 241.16849451645064, "value": 241.16849451645064}, "Decrypt": {"filtered": 43.30090119760482, "value": 43.30090119760482}, "Splay": {"filtered": 117.26554899999996, "value": 117.26554899999996}, "RegExp": {"filtered": 29.589079724409423, "value": 29.589079724409423}, "Richards": {"filtered": 206.5873039999999, "value": 206.5873039999999}, "Earley": {"filtered": 771.7641540000002, "value": 771.7641540000002}, "Boyer": {"filtered": 51.1641585244267, "value": 51.1641585244267}, "RayTrace": {"filtered": 614.9308590000003, "value": 614.9308590000003}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0027.e"}, "testrun": {"date": 1446815840, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151106032135", "branch": "Firefox", "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90"}}] 05:37:31 INFO - RETURN: dromaeo_css: 6345.01 05:37:31 INFO - RETURN: kraken: 1657.60 05:37:31 INFO - RETURN: v8_7: 18500.97 05:37:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "18500.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1657.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "6345.01"}}} 05:37:31 INFO - Return code: 0 05:37:31 INFO - # TBPL SUCCESS # 05:37:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:31 INFO - 2015-11-06 05:37:31.949 screenresolution[1666:10811] starting screenresolution argv=screenresolution get 05:37:31 INFO - 2015-11-06 05:37:31.952 screenresolution[1666:10811] Display 0: 1600x1200x32@60 05:37:31 INFO - 2015-11-06 05:37:31.958 screenresolution[1667:10814] starting screenresolution argv=screenresolution list 05:37:31 INFO - Available Modes on Display 0 05:37:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:32 INFO - Intel HD Graphics 3000: 05:37:32 INFO - Chipset Model: Intel HD Graphics 3000 05:37:32 INFO - Type: GPU 05:37:32 INFO - Bus: Built-In 05:37:32 INFO - VRAM (Total): 512 MB 05:37:32 INFO - VRAM (Dynamic, Max): 10 05:37:32 INFO - Vendor: Intel (0x8086) 05:37:32 INFO - Device ID: 0x0116 05:37:32 INFO - Revision ID: 0x0009 05:37:32 INFO - Displays: 05:37:32 INFO - Display: 05:37:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:32 INFO - Display Serial Number: 1600x1200 60 05:37:32 INFO - Main Display: Yes 05:37:32 INFO - Mirror: Off 05:37:32 INFO - Online: Yes 05:37:32 INFO - Rotation: Supported 05:37:32 INFO - Return code: 0 05:37:32 INFO - Running post-action listener: _resource_record_post_action 05:37:32 INFO - Running post-run listener: _resource_record_post_run 05:37:33 INFO - Total resource usage - Wall time: 1251s; CPU: 30.0%; Read bytes: 50718720; Write bytes: 704154624; Read time: 8532; Write time: 82487 05:37:33 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 336876032; Write bytes: 337371136; Read time: 33601; Write time: 7278 05:37:33 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 48957440; Write bytes: 355589120; Read time: 8011; Write time: 74451 05:37:33 INFO - Running post-run listener: _upload_blobber_files 05:37:33 INFO - Blob upload gear active. 05:37:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:37:33 INFO - Copying logs to upload dir... 05:37:33 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1307.232039 ========= master_lag: 0.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2015-11-06 05:37:34.040383) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:37:34.041655) ========= 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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010021 build_url: 'https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.15 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:37:34.204072) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-06 05:37:34.204517) ========= 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.SOnxyVmgDf/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.UhRjX68VZ4/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.005217 ========= master_lag: 4.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-06 05:37:39.016689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 05:37:39.017065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 05:37:39.024728) ========= ========= Total master_lag: 5.79 =========