builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0105 starttime: 1446806846.63 results: success (0) buildid: 20151106004026 builduid: 984775fdf43f4a3bbbc7de254780201c revision: e2c16a69c24a6eb733663b7ac874bdac7b376418 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:26.627023) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:26.627879) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:26.628227) ========= 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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.006302 basedir: '/builds/slave/test' ========= master_lag: 0.34 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:26.978540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:26.978945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.207421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.207827) ========= 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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.024903 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.277525) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.277892) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.278328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.278640) ========= 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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 02:47:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-06 02:47:27 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.247721 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.599557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.600002) ========= 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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.137067 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:27.779658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-06 02:47:27.780044) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e2c16a69c24a6eb733663b7ac874bdac7b376418 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e2c16a69c24a6eb733663b7ac874bdac7b376418 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 02:47:27,891 truncating revision to first 12 chars 2015-11-06 02:47:27,892 Setting DEBUG logging. 2015-11-06 02:47:27,892 attempt 1/10 2015-11-06 02:47:27,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e2c16a69c24a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-06 02:47:28,831 unpacking tar archive at: mozilla-aurora-e2c16a69c24a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.266740 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-06 02:47:29.118841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:29.119366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:29.762486) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:29.762905) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 02:47:29.763448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2015-11-06 02:47:29.764105) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 02:47:30 INFO - MultiFileLogger online at 20151106 02:47:30 in /builds/slave/test 02:47:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:47:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:30 INFO - {'append_to_log': False, 02:47:30 INFO - 'base_work_dir': '/builds/slave/test', 02:47:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:47:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:30 INFO - 'branch': 'Mozilla-Aurora', 02:47:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:30 INFO - 'config_files': ('talos/mac_config.py',), 02:47:30 INFO - 'default_actions': ('clobber', 02:47:30 INFO - 'read-buildbot-config', 02:47:30 INFO - 'download-and-extract', 02:47:30 INFO - 'populate-webroot', 02:47:30 INFO - 'create-virtualenv', 02:47:30 INFO - 'install', 02:47:30 INFO - 'run-tests'), 02:47:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:30 INFO - 'download_minidump_stackwalk': True, 02:47:30 INFO - 'download_symbols': 'ondemand', 02:47:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:30 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:30 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:30 INFO - 'installer_path': 'installer.exe', 02:47:30 INFO - 'log_level': 'info', 02:47:30 INFO - 'log_name': 'talos', 02:47:30 INFO - 'log_to_console': True, 02:47:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:47:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:47:30 INFO - 'opt_config_files': (), 02:47:30 INFO - 'pip_index': False, 02:47:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:30 INFO - 'cmd': ('bash', 02:47:30 INFO - '-c', 02:47:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:30 INFO - 'enabled': True, 02:47:30 INFO - 'halt_on_failure': False, 02:47:30 INFO - 'name': 'check_screen_resolution'},), 02:47:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:30 INFO - 'cmd': ('bash', 02:47:30 INFO - '-c', 02:47:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:30 INFO - 'enabled': True, 02:47:30 INFO - 'halt_on_failure': False, 02:47:30 INFO - 'name': 'check_screen_resolution'},), 02:47:30 INFO - 'run_cmd_checks_enabled': True, 02:47:30 INFO - 'sps_profile': False, 02:47:30 INFO - 'sps_profile_interval': 0, 02:47:30 INFO - 'suite': 'dromaeojs', 02:47:30 INFO - 'system_bits': '64', 02:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:30 INFO - 'title': 't-yosemite-r5-0105', 02:47:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:30 INFO - 'use_talos_json': True, 02:47:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:30 INFO - 'work_dir': 'build'} 02:47:30 INFO - ##### 02:47:30 INFO - ##### Running clobber step. 02:47:30 INFO - ##### 02:47:30 INFO - Running pre-action listener: _resource_record_pre_action 02:47:30 INFO - Running main action method: clobber 02:47:30 INFO - rmtree: /builds/slave/test/build 02:47:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:35 INFO - Running post-action listener: _resource_record_post_action 02:47:35 INFO - ##### 02:47:35 INFO - ##### Running read-buildbot-config step. 02:47:35 INFO - ##### 02:47:35 INFO - Running pre-action listener: _resource_record_pre_action 02:47:35 INFO - Running main action method: read_buildbot_config 02:47:35 INFO - Using buildbot properties: 02:47:35 INFO - { 02:47:35 INFO - "properties": { 02:47:35 INFO - "buildnumber": 410, 02:47:35 INFO - "product": "firefox", 02:47:35 INFO - "script_repo_revision": "production", 02:47:35 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:47:35 INFO - "repository": "", 02:47:35 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:47:35 INFO - "buildid": "20151106004026", 02:47:35 INFO - "slavename": "t-yosemite-r5-0105", 02:47:35 INFO - "stage_platform": "macosx64", 02:47:35 INFO - "basedir": "/builds/slave/test", 02:47:35 INFO - "nightly_build": "True", 02:47:35 INFO - "project": "", 02:47:35 INFO - "platform": "yosemite", 02:47:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:47:35 INFO - "slavebuilddir": "test", 02:47:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:47:35 INFO - "branch": "mozilla-aurora", 02:47:35 INFO - "repo_path": "releases/mozilla-aurora", 02:47:35 INFO - "pgo_build": "False", 02:47:35 INFO - "builduid": "984775fdf43f4a3bbbc7de254780201c", 02:47:35 INFO - "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418" 02:47:35 INFO - }, 02:47:35 INFO - "sourcestamp": { 02:47:35 INFO - "repository": "", 02:47:35 INFO - "hasPatch": false, 02:47:35 INFO - "project": "", 02:47:35 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:47:35 INFO - "changes": [ 02:47:35 INFO - { 02:47:35 INFO - "category": null, 02:47:35 INFO - "files": [ 02:47:35 INFO - { 02:47:35 INFO - "url": null, 02:47:35 INFO - "name": "https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:47:35 INFO - } 02:47:35 INFO - ], 02:47:35 INFO - "repository": "", 02:47:35 INFO - "rev": "e2c16a69c24a6eb733663b7ac874bdac7b376418", 02:47:35 INFO - "who": "sendchange", 02:47:35 INFO - "when": 1446806795, 02:47:35 INFO - "number": 6629657, 02:47:35 INFO - "comments": "", 02:47:35 INFO - "project": "", 02:47:35 INFO - "at": "Fri 06 Nov 2015 02:46:35", 02:47:35 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:47:35 INFO - "revlink": "", 02:47:35 INFO - "properties": [ 02:47:35 INFO - [ 02:47:35 INFO - "buildid", 02:47:35 INFO - "20151106004026", 02:47:35 INFO - "Change" 02:47:35 INFO - ], 02:47:35 INFO - [ 02:47:35 INFO - "builduid", 02:47:35 INFO - "984775fdf43f4a3bbbc7de254780201c", 02:47:35 INFO - "Change" 02:47:35 INFO - ], 02:47:35 INFO - [ 02:47:35 INFO - "nightly_build", 02:47:35 INFO - "True", 02:47:35 INFO - "Change" 02:47:35 INFO - ], 02:47:35 INFO - [ 02:47:35 INFO - "pgo_build", 02:47:35 INFO - "False", 02:47:35 INFO - "Change" 02:47:35 INFO - ] 02:47:35 INFO - ], 02:47:35 INFO - "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418" 02:47:35 INFO - } 02:47:35 INFO - ], 02:47:35 INFO - "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418" 02:47:35 INFO - } 02:47:35 INFO - } 02:47:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:47:35 INFO - Running post-action listener: _resource_record_post_action 02:47:35 INFO - ##### 02:47:35 INFO - ##### Running download-and-extract step. 02:47:35 INFO - ##### 02:47:35 INFO - Running pre-action listener: _resource_record_pre_action 02:47:35 INFO - Running main action method: download_and_extract 02:47:35 INFO - mkdir: /builds/slave/test/build/tests 02:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:35 INFO - https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/test_packages.json 02:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/test_packages.json 02:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:47:56 INFO - Downloaded 1149 bytes. 02:47:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:47:56 INFO - Using the following test package requirements: 02:47:56 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:47:56 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:47:56 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'jsshell-mac.zip'], 02:47:56 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:47:56 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:47:56 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:47:56 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:47:56 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:47:56 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:47:56 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:56 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:47:56 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:56 INFO - https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:47:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:47:58 INFO - Downloaded 17446019 bytes. 02:47:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:47:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:48:03 INFO - Return code: 0 02:48:03 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:03 INFO - https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:13 INFO - Downloaded 17446019 bytes. 02:48:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:48:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:48:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:48:18 INFO - Return code: 0 02:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:18 INFO - https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:48:19 INFO - Downloaded 11131307 bytes. 02:48:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:48:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:48:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:48:19 INFO - Return code: 0 02:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:19 INFO - https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:48:25 INFO - Downloaded 107838939 bytes. 02:48:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:48:25 INFO - mkdir: /builds/slave/test/properties 02:48:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:25 INFO - Contents: 02:48:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:48:25 INFO - Running post-action listener: _resource_record_post_action 02:48:25 INFO - Running post-action listener: set_extra_try_arguments 02:48:25 INFO - ##### 02:48:25 INFO - ##### Running populate-webroot step. 02:48:25 INFO - ##### 02:48:25 INFO - Running pre-action listener: _resource_record_pre_action 02:48:25 INFO - Running main action method: populate_webroot 02:48:25 INFO - Guessing talos json url... 02:48: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')]} 02:48:25 INFO - https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:48:26 INFO - Downloaded 107 bytes. 02:48:26 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:48:26 INFO - Contents: 02:48:26 INFO - 20151106004026 02:48:26 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/e2c16a69c24a6eb733663b7ac874bdac7b376418 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:26 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2c16a69c2/testing/talos/talos.json 02:48:26 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2c16a69c2/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2c16a69c2/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:48:26 INFO - Downloaded 4264 bytes. 02:48:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:48:26 INFO - '../fennec_ids.txt'], 02:48:26 INFO - 'tests': ['tcheck2']}, 02:48:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:26 INFO - '--tppagecycles', 02:48:26 INFO - '7'], 02:48:26 INFO - 'tests': ['tsvgm']}}, 02:48:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:48:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:48:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:48:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'tests': ['damp', 'tps']}, 02:48:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['damp', 'tps']}, 02:48:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:48:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:26 INFO - 'other': {'tests': ['a11yr', 02:48:26 INFO - 'ts_paint', 02:48:26 INFO - 'tpaint', 02:48:26 INFO - 'sessionrestore', 02:48:26 INFO - 'sessionrestore_no_auto_restore']}, 02:48:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['a11yr', 02:48:26 INFO - 'ts_paint', 02:48:26 INFO - 'tpaint', 02:48:26 INFO - 'sessionrestore', 02:48:26 INFO - 'sessionrestore_no_auto_restore']}, 02:48:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['a11yr', 02:48:26 INFO - 'ts_paint', 02:48:26 INFO - 'tpaint', 02:48:26 INFO - 'sessionrestore', 02:48:26 INFO - 'sessionrestore_no_auto_restore']}, 02:48:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['a11yr', 02:48:26 INFO - 'ts_paint', 02:48:26 INFO - 'tpaint', 02:48:26 INFO - 'sessionrestore', 02:48:26 INFO - 'sessionrestore_no_auto_restore']}, 02:48:26 INFO - 'other_l64': {'tests': ['a11yr', 02:48:26 INFO - 'ts_paint', 02:48:26 INFO - 'tpaint', 02:48:26 INFO - 'sessionrestore', 02:48:26 INFO - 'sessionrestore_no_auto_restore']}, 02:48:26 INFO - 'other_nol64': {'tests': ['a11yr', 02:48:26 INFO - 'ts_paint', 02:48:26 INFO - 'tpaint', 02:48:26 INFO - 'sessionrestore', 02:48:26 INFO - 'sessionrestore_no_auto_restore']}, 02:48:26 INFO - 'svgr': {'tests': ['tsvgx', 02:48:26 INFO - 'tsvgr_opacity', 02:48:26 INFO - 'tart', 02:48:26 INFO - 'tscrollx', 02:48:26 INFO - 'cart']}, 02:48:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['tsvgx', 02:48:26 INFO - 'tsvgr_opacity', 02:48:26 INFO - 'tart', 02:48:26 INFO - 'tscrollx', 02:48:26 INFO - 'cart']}, 02:48:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'tests': ['tp5o']}, 02:48:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'talos_options': ['--e10s'], 02:48:26 INFO - 'tests': ['tp5o']}, 02:48:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'talos_options': ['--xperf_path', 02:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:26 INFO - 'tests': ['tp5n']}, 02:48:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:26 INFO - 'talos_options': ['--e10s', 02:48:26 INFO - '--xperf_path', 02:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:48:26 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:48:26 INFO - 'tests': ['tp5n']}}, 02:48:26 INFO - 'talos.zip': {'path': '', 02:48:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:26 INFO - Running post-action listener: _resource_record_post_action 02:48:26 INFO - ##### 02:48:26 INFO - ##### Running create-virtualenv step. 02:48:26 INFO - ##### 02:48:26 INFO - Running pre-action listener: _resource_record_pre_action 02:48:26 INFO - Running main action method: create_virtualenv 02:48:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:27 INFO - Using real prefix '/tools/python27' 02:48:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:32 INFO - Installing pip.................done. 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:48:32 INFO - Cleaning up... 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:33 INFO - Downloading/unpacking psutil>=0.7.1 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:48:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:35 INFO - Installing collected packages: psutil 02:48:35 INFO - Running setup.py install for psutil 02:48:35 INFO - building 'psutil._psutil_osx' extension 02:48:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:48:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:48:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:48:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:48:38 INFO - building 'psutil._psutil_posix' extension 02:48:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:48:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:38 INFO - ^ 02:48:38 INFO - 1 warning generated. 02:48:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:38 INFO - Successfully installed psutil 02:48:38 INFO - Cleaning up... 02:48:38 INFO - Return code: 0 02:48:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:38 INFO - 'HOME': '/Users/cltbld', 02:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:38 INFO - 'LOGNAME': 'cltbld', 02:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:38 INFO - 'MOZ_NO_REMOTE': '1', 02:48:38 INFO - 'NO_EM_RESTART': '1', 02:48:38 INFO - 'PAGER': '/bin/cat', 02:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:38 INFO - 'PWD': '/builds/slave/test', 02:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:38 INFO - 'SHELL': '/bin/bash', 02:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:38 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:38 INFO - 'USER': 'cltbld', 02:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:38 INFO - 'XPC_FLAGS': '0x0', 02:48:38 INFO - 'XPC_SERVICE_NAME': '0', 02:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:48:41 INFO - Installing collected packages: mozsystemmonitor 02:48:41 INFO - Running setup.py install for mozsystemmonitor 02:48:41 INFO - Successfully installed mozsystemmonitor 02:48:41 INFO - Cleaning up... 02:48:41 INFO - Return code: 0 02:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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', '--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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:41 INFO - 'HOME': '/Users/cltbld', 02:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:41 INFO - 'LOGNAME': 'cltbld', 02:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:41 INFO - 'MOZ_NO_REMOTE': '1', 02:48:41 INFO - 'NO_EM_RESTART': '1', 02:48:41 INFO - 'PAGER': '/bin/cat', 02:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:41 INFO - 'PWD': '/builds/slave/test', 02:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:41 INFO - 'SHELL': '/bin/bash', 02:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:41 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:41 INFO - 'USER': 'cltbld', 02:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:41 INFO - 'XPC_FLAGS': '0x0', 02:48:41 INFO - 'XPC_SERVICE_NAME': '0', 02:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:46 INFO - Downloading docopt-0.6.1.tar.gz 02:48:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:46 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:46 INFO - Running setup.py install for blobuploader 02:48:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:46 INFO - Running setup.py install for requests 02:48:47 INFO - Running setup.py install for docopt 02:48:47 INFO - Successfully installed blobuploader requests docopt 02:48:47 INFO - Cleaning up... 02:48:47 INFO - Return code: 0 02:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:47 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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:47 INFO - 'HOME': '/Users/cltbld', 02:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:47 INFO - 'LOGNAME': 'cltbld', 02:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:47 INFO - 'MOZ_NO_REMOTE': '1', 02:48:47 INFO - 'NO_EM_RESTART': '1', 02:48:47 INFO - 'PAGER': '/bin/cat', 02:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:47 INFO - 'PWD': '/builds/slave/test', 02:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:47 INFO - 'SHELL': '/bin/bash', 02:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:47 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:47 INFO - 'USER': 'cltbld', 02:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:47 INFO - 'XPC_FLAGS': '0x0', 02:48:47 INFO - 'XPC_SERVICE_NAME': '0', 02:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-h8t0Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-wfjdVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-TZqjWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-cwrPAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-8JeyCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-6V3Vlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-PnVozm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-sK1ND7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-cyLEcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-yZzTZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Kb6SQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-ANAGsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Cftxc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-WSobH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-2cWoMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-0km6D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-CPo9Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:49 INFO - Running setup.py install for manifestparser 02:48:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:50 INFO - Running setup.py install for mozcrash 02:48:50 INFO - Running setup.py install for mozdebug 02:48:50 INFO - Running setup.py install for mozdevice 02:48:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:50 INFO - Running setup.py install for mozfile 02:48:50 INFO - Running setup.py install for mozhttpd 02:48:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:50 INFO - Running setup.py install for mozinfo 02:48:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozInstall 02:48:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozleak 02:48:51 INFO - Running setup.py install for mozlog 02:48:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for moznetwork 02:48:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozprocess 02:48:52 INFO - Running setup.py install for mozprofile 02:48:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Running setup.py install for mozrunner 02:48:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Running setup.py install for mozscreenshot 02:48:52 INFO - Running setup.py install for moztest 02:48:52 INFO - Running setup.py install for mozversion 02:48:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:53 INFO - Cleaning up... 02:48:53 INFO - Return code: 0 02:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:53 INFO - 'HOME': '/Users/cltbld', 02:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:53 INFO - 'LOGNAME': 'cltbld', 02:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:53 INFO - 'MOZ_NO_REMOTE': '1', 02:48:53 INFO - 'NO_EM_RESTART': '1', 02:48:53 INFO - 'PAGER': '/bin/cat', 02:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:53 INFO - 'PWD': '/builds/slave/test', 02:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:53 INFO - 'SHELL': '/bin/bash', 02:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:53 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:53 INFO - 'USER': 'cltbld', 02:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:53 INFO - 'XPC_FLAGS': '0x0', 02:48:53 INFO - 'XPC_SERVICE_NAME': '0', 02:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:53 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-HE2SIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:53 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-PSeEOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:53 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-31gFOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:53 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-1t2u0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:53 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-jLhZL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-48u0df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Yvp12A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-DocG49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-63NCDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-4iLBmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-LnDLLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:54 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-fWDsN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:55 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-GTIePf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:55 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-LTF2JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:55 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-KHgD50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:55 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-HBu7AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:55 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-p1nb48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:58 INFO - Downloading blessings-1.5.1.tar.gz 02:48:58 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:48:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:58 INFO - Installing collected packages: blessings 02:48:58 INFO - Running setup.py install for blessings 02:48:58 INFO - Successfully installed blessings 02:48:58 INFO - Cleaning up... 02:48:58 INFO - Return code: 0 02:48:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:59 INFO - Reading from file tmpfile_stdout 02:48:59 INFO - Current package versions: 02:48:59 INFO - blessings == 1.5.1 02:48:59 INFO - blobuploader == 1.2.4 02:48:59 INFO - docopt == 0.6.1 02:48:59 INFO - manifestparser == 1.1 02:48:59 INFO - mozInstall == 1.12 02:48:59 INFO - mozcrash == 0.16 02:48:59 INFO - mozdebug == 0.1 02:48:59 INFO - mozdevice == 0.46 02:48:59 INFO - mozfile == 1.2 02:48:59 INFO - mozhttpd == 0.7 02:48:59 INFO - mozinfo == 0.8 02:48:59 INFO - mozleak == 0.1 02:48:59 INFO - mozlog == 3.0 02:48:59 INFO - moznetwork == 0.27 02:48:59 INFO - mozprocess == 0.22 02:48:59 INFO - mozprofile == 0.27 02:48:59 INFO - mozrunner == 6.11 02:48:59 INFO - mozscreenshot == 0.1 02:48:59 INFO - mozsystemmonitor == 0.0 02:48:59 INFO - moztest == 0.7 02:48:59 INFO - mozversion == 1.4 02:48:59 INFO - psutil == 3.1.1 02:48:59 INFO - requests == 1.2.3 02:48:59 INFO - wsgiref == 0.1.2 02:48:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x105ca6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd13ad18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, '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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:48:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:59 INFO - 'HOME': '/Users/cltbld', 02:48:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:59 INFO - 'LOGNAME': 'cltbld', 02:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:59 INFO - 'MOZ_NO_REMOTE': '1', 02:48:59 INFO - 'NO_EM_RESTART': '1', 02:48:59 INFO - 'PAGER': '/bin/cat', 02:48:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:59 INFO - 'PWD': '/builds/slave/test', 02:48:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:59 INFO - 'SHELL': '/bin/bash', 02:48:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:48:59 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:48:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:59 INFO - 'USER': 'cltbld', 02:48:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:59 INFO - 'XPC_FLAGS': '0x0', 02:48:59 INFO - 'XPC_SERVICE_NAME': '0', 02:48:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:59 INFO - Cleaning up... 02:48:59 INFO - Return code: 0 02:48:59 INFO - Running post-action listener: _resource_record_post_action 02:48:59 INFO - Running post-action listener: _start_resource_monitoring 02:48:59 INFO - Starting resource monitoring. 02:48:59 INFO - ##### 02:48:59 INFO - ##### Running install step. 02:48:59 INFO - ##### 02:48:59 INFO - Running pre-action listener: _resource_record_pre_action 02:48:59 INFO - Running main action method: install 02:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:59 INFO - Reading from file tmpfile_stdout 02:48:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:59 INFO - Reading from file tmpfile_stdout 02:48:59 INFO - Output received: 02:48:59 INFO - Usage: mozinstall [options] installer 02:48:59 INFO - Options: 02:48:59 INFO - -h, --help show this help message and exit 02:48:59 INFO - -d DEST, --destination=DEST 02:48:59 INFO - Directory to install application into. [default: 02:48:59 INFO - "/builds/slave/test"] 02:48:59 INFO - --app=APP Application being installed. [default: firefox] 02:48:59 INFO - mkdir: /builds/slave/test/build/application 02:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:40 INFO - Reading from file tmpfile_stdout 02:49:40 INFO - Output received: 02:49:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:49:40 INFO - Running post-action listener: _resource_record_post_action 02:49:40 INFO - ##### 02:49:40 INFO - ##### Running run-tests step. 02:49:40 INFO - ##### 02:49:40 INFO - Running pre-action listener: _resource_record_pre_action 02:49:40 INFO - Running main action method: run_tests 02:49:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:40 INFO - 2015-11-06 02:49:40.155 screenresolution[1633:7837] starting screenresolution argv=screenresolution get 02:49:40 INFO - 2015-11-06 02:49:40.158 screenresolution[1633:7837] Display 0: 1600x1200x32@60 02:49:40 INFO - 2015-11-06 02:49:40.165 screenresolution[1634:7839] starting screenresolution argv=screenresolution list 02:49:40 INFO - Available Modes on Display 0 02:49:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:40 INFO - Intel HD Graphics 3000: 02:49:40 INFO - Chipset Model: Intel HD Graphics 3000 02:49:40 INFO - Type: GPU 02:49:40 INFO - Bus: Built-In 02:49:40 INFO - VRAM (Total): 512 MB 02:49:40 INFO - VRAM (Dynamic, Max): 10 02:49:40 INFO - Vendor: Intel (0x8086) 02:49:40 INFO - Device ID: 0x0116 02:49:40 INFO - Revision ID: 0x0009 02:49:40 INFO - Displays: 02:49:40 INFO - Display: 02:49:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:40 INFO - Display Serial Number: 1600x1200 60 02:49:40 INFO - Main Display: Yes 02:49:40 INFO - Mirror: Off 02:49:40 INFO - Online: Yes 02:49:40 INFO - Rotation: Supported 02:49:40 INFO - Return code: 0 02:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:40 INFO - Python 2.7.3 02:49:40 INFO - Return code: 0 02:49:40 INFO - grabbing minidump binary from tooltool 02:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:40 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 0x105c5b9f0>, '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 0x1059bacd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c25990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:49:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:49:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:40 INFO - Return code: 0 02:49:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0105', '--webServer', 'localhost'] in /builds/slave/test/build 02:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0105 --webServer localhost 02:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbMRqlBUF6/Render', 02:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:40 INFO - 'HOME': '/Users/cltbld', 02:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:40 INFO - 'LOGNAME': 'cltbld', 02:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:40 INFO - 'MOZ_NO_REMOTE': '1', 02:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:40 INFO - 'NO_EM_RESTART': '1', 02:49:40 INFO - 'PAGER': '/bin/cat', 02:49:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:40 INFO - 'PWD': '/builds/slave/test', 02:49:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:40 INFO - 'SHELL': '/bin/bash', 02:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebBtlJUg6P/Listeners', 02:49:40 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 02:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:40 INFO - 'USER': 'cltbld', 02:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:40 INFO - 'XPC_FLAGS': '0x0', 02:49:40 INFO - 'XPC_SERVICE_NAME': '0', 02:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:49:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0105', '--webServer', 'localhost'] with output_timeout 3600 02:49:40 INFO - mozversion INFO | application_buildid: 20151106004026 02:49:40 INFO - mozversion INFO | application_changeset: e2c16a69c24a6eb733663b7ac874bdac7b376418 02:49:40 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:49:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:40 INFO - mozversion INFO | application_name: Firefox 02:49:40 INFO - mozversion INFO | application_remotingname: firefox-dev 02:49:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:40 INFO - mozversion INFO | application_vendor: Mozilla 02:49:40 INFO - mozversion INFO | application_version: 44.0a2 02:49:40 INFO - mozversion INFO | platform_buildid: 20151106004026 02:49:40 INFO - mozversion INFO | platform_changeset: e2c16a69c24a6eb733663b7ac874bdac7b376418 02:49:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:40 INFO - mozversion INFO | platform_version: 44.0a2 02:49:40 INFO - 2015-11-06 02:49:40,886 DEBUG : using testdate: 1446806980 02:49:40 INFO - 2015-11-06 02:49:40,886 DEBUG : actual date: 1446806980 02:49:40 INFO - 2015-11-06 02:49:40,900 INFO : starting webserver on 'localhost:49263' 02:49:40 INFO - 2015-11-06 02:49:40,901 INFO : Starting test suite t-yosemite-r5-0105 02:49:40 INFO - 2015-11-06 02:49:40,901 INFO : Starting test dromaeo_css 02:49:40 INFO - 2015-11-06 02:49:40,901 DEBUG : operating with platform_type : mac_ 02:49:40 INFO - 2015-11-06 02:49:40,902 INFO : Initialising browser for dromaeo_css test... 02:49:40 INFO - 2015-11-06 02:49:40,928 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpv6PD7p/profile http://localhost:49263/getInfo.html 02:49:44 INFO - 2015-11-06 02:49:44,060 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:49:44 INFO - 2015-11-06 02:49:44,061 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:49:44 INFO - 2015-11-06 02:49:44,061 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:49:44 INFO - 2015-11-06 02:49:44,061 DEBUG : BROWSER_OUTPUT: __metrics 02:49:44 INFO - 2015-11-06 02:49:44,069 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:44 INFO - 2015-11-06 02:49:44,827 INFO : Browser initialized. 02:49:44 INFO - 2015-11-06 02:49:44,827 INFO : Running cycle 1/1 for dromaeo_css test... 02:49:44 INFO - 2015-11-06 02:49:44,828 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpv6PD7p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:49:56 INFO - 2015-11-06 02:49:56,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 200060928 02:49:56 INFO - 2015-11-06 02:49:56,879 DEBUG : BROWSER_OUTPUT: 02:50:48 INFO - 2015-11-06 02:50:48,527 DEBUG : BROWSER_OUTPUT: 1446807048525 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:52:58 INFO - 2015-11-06 02:52:58,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 02:53:00 INFO - 2015-11-06 02:53:00,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 326787072 02:53:00 INFO - 2015-11-06 02:53:00,134 DEBUG : BROWSER_OUTPUT: 02:56:02 INFO - 2015-11-06 02:56:02,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 02:56:03 INFO - 2015-11-06 02:56:03,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 345804800 02:56:03 INFO - 2015-11-06 02:56:03,480 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-11-06 02:59:05,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 02:59:06 INFO - 2015-11-06 02:59:06,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 308379648 02:59:06 INFO - 2015-11-06 02:59:06,337 DEBUG : BROWSER_OUTPUT: 03:02:08 INFO - 2015-11-06 03:02:08,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 03:02:09 INFO - 2015-11-06 03:02:09,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 301158400 03:02:09 INFO - 2015-11-06 03:02:09,019 DEBUG : BROWSER_OUTPUT: 03:05:12 INFO - 2015-11-06 03:05:12,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 03:05:12 INFO - 2015-11-06 03:05:12,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 301383680 03:05:12 INFO - 2015-11-06 03:05:12,865 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 03:08:15 INFO - 2015-11-06 03:08:15,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 344113152 03:08:15 INFO - 2015-11-06 03:08:15,682 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,682 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:08:15 INFO - 2015-11-06 03:08:15,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:08:15 INFO - 2015-11-06 03:08:15,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:08:15 INFO - 2015-11-06 03:08:15,682 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:08:15 INFO - 2015-11-06 03:08:15,682 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2784.8189867658602;2825.901093461729;2851.0306495791433;2864.6562412510502;2873.77009839213;4779.3786807715;4803.9519604803945;4805.327254184417;4813.253945638432;4893.755312234392;4696.412948381452;4803.711777293356;4821;4839.903201935959;4849.6847704899155;4347.586979236968;4454.599086082252;4538.931916021263;4574;4598.678092533524;4436.97781511092;4472.731636101845;4568.994821139344;4575.29082992135;4592.448906131269;4547.567981041812;4566.269396896497;4588.495265520807;4590.540945905416;4631.235846085392;4597.862064138081;4641.9535804641855;4643.674942754009;4652.185867473178;4676.883077923079;4345.087531618364;4385.8245670173155;4471.35165401015;4518.819247230107;4528.569785870337;4807.927881081787;4812.5668689818085;4843.128236917353;4880;4887.8778030549165;5153.072446959546;5171.612129090333;5177.068127737006;5195.688258704452;5225.425203227642;4821.180399332122;4920.606351491872;4937.506249375034;5054.06499797535;5177.8187763428095;4746.027064451813;4771.23660214364;4785.473597904228;4813.446453657804;4862.708237505725;5231.8168864089575;5246.108161612535;5282.735863206824;5283.207518872123;5301.920471192935;4677.695949763254;4868.391451068616;4871.780769865364;4912.091263116335;5036.11867923112;5021.397432308147;5027.069992051483;5027.698338099725;5044.9495505045215;5046.142155833517;4951.7276549789385;4996.90006199874;4997.550220480174;5001.699898006132;5002.224655178453;4778.761061946958;4895.583875370562;4898.951010489849;4959.082569724613;5050.84847454577;3856.325143099946;3895.474110995036;3986.242613903349;4003.7197396181987;4007.3788562772816;3582.444721068239;3592.4611308303965;3601.513795637555;3617.0595645132457;3632.818359082088;4681.344611754357;4776.259679749644;4813.278008298783;4816.686915350491;4916.06594746997;5131.974340128276;5148.382194136728;5152.948470515322;5172.482751724798;5190.55880250183;4800.903981920342;4817.7350245736825;4829.589484893753;4840.080384726891;4851.442084160296;4296.634786043159;4403.207422663887;4426.601605855489;4521.796519156645;4523.479799822997;5036.244563315532;5139.537441630271;5140.177571588528;5151.098557752453;5155.381354237516;5234.24103504982;5274.472552744694;5292.9206061908335;5299.364076310867;5357.19642053695;4951.430585482715;5393.433689462707;5407.351117865881;5419.403865574863;5435.565154787687;4997.700137991732;5051.696898186121;5072.467390924047;5087.3386459759995;5116;5194.3247377840635;5239.292695486213;5246.868828279171;5265.262863199078;5285.127953887719;4827.686200396963;5090.949090509195;5113.4375218726655;5125.5899528036925;5133.8716532087;4915.6067514598035;4965.702057876539;4971.055499455092;5018.774155162953;5032.874178145576;4966.379202599675;4977.8257760978195;4990.750462476789;4997.600191984559;5008.774605142705;5071.163258062378;5113.207452844815;5115.769790359368;5134.075866344094;5143.974280128576;4716.268978308368;4763.618910487222;4809.951900480951;4823.903521929472;4865.0756356292195 03:08:15 INFO - 2015-11-06 03:08:15,684 DEBUG : BROWSER_OUTPUT: |1;ext.html;497.686457531755;502.75616326081865;506.799814073441;517.3894804131126;528.4636094364218;29367.412651746978;30811.537826932585;36350;36805.89582312535;37070.44394334087;38683;40618.59381406185;40619.390709139385;40718.59281407185;40887.38668919969;7499.625018749068;8167.224113709203;8346.165383461635;8367.665293388258;8375.37184711146;7706.884396734054;9528.475933823636;9789.902100979007;9867.851982220272;9888.901110988905;9579.808403831954;9687.854682179774;9707.757306067335;9741.610335586603;9745.415275083482;7754.922450775476;8012.879806802903;9572.28207884408;9724.465154416468;9929.3545919515;9667.129958303716;9696.46669433181;9808.509574521246;9809.21526277896;9811.509424528746;36589.634103658886;37148;37213.06967325811;37230.44154337687;37387;2780.680221774481;2793.1899749072745;2800.0899707595113;2801.677807052174;2820.6192164057793;25361.873190634113;25517.744822551722;25815.096471623405;25817.483650327074;25863.22410327693;2105.3683894831643;2133.541288622938;2139.3474990128007;2151.709519214902;2172.3048624440185;246384;246658.9999999982;247611;249962;252740;50419;51646.74176629093;58409.70795145997;59015.11477327844;62986;58295;58585.70707146522;58757.70621146952;59135.704321478115;59167.40832591705;14018.789718154236;14142.858571414154;14148.787768183485;14181.574552763434;14287.78568321476;11860.169788114921;12001.459934302977;12083.637490875288;12084.577039803564;12106.636800895987;18948;19051.523711907037;19089.90455047716;19095.331663391713;19209.90395048016;7217;7527.134379546313;7552.320291173821;7592.126905405838;7602.885956710654;801.2188116586282;861.401326078382;882.7395918204145;892.8973168085753;986.4180133720996;25577.232683019538;25981.350466238116;26229.606555901297;26280.34299142537;26333;842.2756429470651;915.3683958068912;944.2210176604192;962.138885697311;1067.6636859389268;9695.70912872615;13318.800217996544;14136.85863141376;14822.925885370503;15251.771223431657;406919;424780;435943;451504;458314;49846.75076624594;50461.49538504568;50479.747601261755;50520.242196367086;51285.48714512807;1205.7588482303574;1240.9379531023233;1281.2760790153534;1307.8626744191913;1322.9603111906658;24447.633285501088;26677.333066673487;26917.86541067282;27355.72644273532;28009.159725208276;47225.29162062503;47716.7614161927;47732.7613361931;48116;48438.5156148434;243911;246105;247852;248978;249028;27867.581986269815;27930.860345698955;27995.160145195678;28129.859350703115;28157;38826.6117338823;39310.60689393069;39492.40761388524;40008.599914000486;40401;31764.841175793972;32321.51517727189;33285.20396692582;33443;33623.327533448704;31592.684073158973;32056.67943320537;32481;32554;32584.51123233106;32399.35201296008;32959.340813184084;33120.834395827864;33172;33303.167420813705;26311;28270.71729282681;28300.575491368058;28485.43029139447;28697;21802.563948721254;22216.88891555532;22411.32766017022;22523.32430027102;22563.548729025 03:08:15 INFO - 2015-11-06 03:08:15,686 DEBUG : BROWSER_OUTPUT: |2;jquery.html;305.6408719754288;311.15521359508926;311.18935173872063;314.5439113285735;319.8512691598407;13245.668858278525;13526.864731352684;15056.548303550884;15484.612884677874;15985.920070399647;13930.164190148598;15503.457378991738;16105.516834494954;16417.261223244954;16441.506754797374;4295.52749197588;4399.05420334628;4443.422355093833;4730.455997560273;4880.267959806022;3213.4055199788113;3286.8356582170795;4257;4406.383106365111;4426.2254105531565;4261.573842615745;4290.356446533029;4301.548337424572;4312.97843510782;4333.133373325331;4182.100848317596;4267.253230684618;4293.570642935712;4311.9784401078105;4321.481422229321;3696.907577310562;3699.9445008324897;3704.833282502294;3720.2931443025736;3726.4224045273027;11636.12729045325;12097.850704183089;12245;12369.814452783216;12399.876001239962;1644.3751374477622;1721.4577408116404;1782.857371410297;1793.8833975791663;1834.0096347972078;8576.228139467416;8596.441231320006;8664.350173736932;8920.821583568293;8947.821043579157;1297.8247936528542;1305.145129939891;1346.7845144776788;1352.7226918481688;1357.0568454923832;48602.756986215194;50022.2496662554;55366.72316638431;56371.436285637436;56785.43214567884;5911.940880591139;5999.730012149464;6006.909896351558;6106.511479081662;6110.541709371726;6923.723051077901;6924.203716572659;6935.653217339112;6939.23668396476;7039.718411263594;5052.368453943257;5063.974680126649;5085.059264036166;5143.434222235551;5152.562032227303;5481.287432633732;5505.421930697299;5530.2810634618045;5542.722863856791;5551;2693.245891150481;2724.986375068112;2739.301478123106;2747.7527022568065;2750.188694335176;947.0955237747934;951.1534734086669;961.7835986902891;983.1986930651639;1006.1799633298838;333.4640109202404;378.8105947026487;390.7069697726705;391.87851765952644;402.22772277227796;9899.7030089096;10542.578296868192;10831.945840270748;10873.184511161695;11121.666350009513;400.73951931244926;407.6983032555947;422.64497821829195;430.3802524364905;448.73748856918417;5684.175794509773;6051.364606716319;6056.515478761688;6094.2077529920825;6095.939040609537;551961;555610;558258;565758;568905;62679.686601566704;64180.67909660422;65000.34999650037;65460;65621.34378656153;479.4989236248129;484.95635392814813;486.5839707050492;487.32505479910577;488.999995010205;9857.95071024669;9998;10106.595736170471;10161.98380161978;10185.592576296865;30516.389672206875;30989.380212396078;32242.193945151557;33644.66355336415;33968.32063358669;43515;43593.56406435895;43643.34534982041;44386.778066109466;44960;5582.609217354746;5697.7151142443545;5726.627769195155;5733.569982251432;5748.166515855094;10002.8499572505;10582.470876455993;10651.30766500175;10681.679549613524;10682;9107.408018478778;9184.724458266262;9329.393589416666;9336.439813611205;9347.205487533363;8612.870806937775;8849.469031858109;8871.379003469954;8904.73285801427;9123.27013838878;7564.092308922965;9598.232141428809;9698.175655069399;9776.071273229032;9829.361091529028;4832.44426890898;4931.605471562339;5216.295800066942;5320.787168513216;5667.5465962722055;9098.818023639622;9124;9269.304802139732;9273.814523709352;9277.62889484413 03:08:15 INFO - 2015-11-06 03:08:15,689 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1057.7091299892534;1558.906465612063;1608.268237951732;1629.3156874112872;1629.4459883639563;6252.593581417204;6744.258131605526;6797.966010169955;6865.176178858544;6899.896501552468;6764.864702705943;6920.273371296017;6932.72269109235;6955.791326260208;7033.964830175854;1937.4768812420602;1956.7651881774136;1956.9315073972343;1957.628050670368;1962.7939066398037;1984.8908310042941;1986.4040787763686;1988.0159321135986;2046.1201683276186;2052.7741948385665;1888.9556150024544;1905.3617038292189;1907.7424547686094;1919.8560107991957;1920.155131742036;1988.045738045739;1993.5215548268457;1997.510609900569;2008.4978755311172;2010.2963962613114;1964.0866996846391;1971.5169783403157;1995.600879824041;1995.7804641489424;2009.7688765791975;6194.783182588633;6341;6779.830504237384;6814.761483348059;6839.179298484214;4140.730852494578;4237.4491316129015;4241.3637954307105;4249.723767955073;4252.277112890816;2531.886065127074;2549.7450254974538;2562.8077894157827;2580.7290234525294;2591.7278685737915;767.244264399566;782.3936449251819;800.2517646001007;805.9355251579918;807.6204184033554;9065.68270110543;9092.318076144316;9134.90865091354;9178.31162662803;9202.217811486033;3859.4982652255026;3867.8452861885207;3916.3929590912885;3938.4289278055094;3966.3852102924093;7935.801604959806;7950.0857401398425;7966.362690984707;7973.401994850409;8114.837703245902;4325.589069038437;4338.60952514269;4338.696291259582;4340.891477713019;4369.75966321849;3933.3706606943324;3934.134490412162;3940.6059394060367;3942.270679924166;3948.0919388540224;3121.843907804601;3143.937121257608;3149.3228955774616;3171.7462602991704;3181.538676891838;959.1271942532262;965.7778710896392;967.4050458967824;979.5983646704817;983.9963237497712;1167.2762887009937;1169.789437901186;1174.2148367246864;1194.1223200947297;1199.5082016373244;6338.844578894681;6529.5102867284195;6539;6543.378379053982;6551.148350714472;382.2832189644417;384.5635204043375;385.8726620215322;387.51173521363285;388.41155649191495;5129.589632829365;5208.0365132450615;5215.113430716711;5224.346956630421;5342.171963345688;8032.759017229492;8248.628811703487;8253;8263.256306932404;8272;8057.395695322874;8145.389095817837;8166.020077590727;8188.631511581993;8232.464889782144;6516.413522782972;6609.1077704510235;6652.334766523309;6707.664616769142;6711.664416779142;6539.411452969255;6550.508711846535;6559.376859198369;6575.572587781779;6586.353411647088;7013.614251216232;7297.890531641923;7299;7299.708011679473;7326.267373262845;7301.63491825396;7687.154413014452;7715.382769378549;7743.419243556868;7767.689292428239;5854.619449735754;5859.091840764689;5917.408259174048;5953.434423729739;5974.22335096452;6603.702833372606;6633.701483433354;6649.434798042221;6655.134832471747;6696;6188.1027251049245;6216.222972128484;6311.526635502448;6333.461655759128;6370.936290637034;6073.119397687399;6146.846328841814;6159.168512250789;6250.906236406367;6317;6241.500679945502;6282.434580887742;6299.779507717391;6314.715837787402;6341.048842673636;5570.997220500187;5620.072688006597;5623.493885550321;5625.634333768292;5626.099824028136;5239.502247286502;5253.106971814725;5413.079776437936;5419.403865574863;5423.864403389789 03:08:15 INFO - 2015-11-06 03:08:15,691 DEBUG : BROWSER_OUTPUT: |4;prototype.html;284.7181290522383;291.1527455105643;293.76058512312466;296.34064207139113;298.1933868884667;5351.117065684162;5358.969520612568;5378.973105134479;5391.218273350361;5415.64798288111;5298.23175639532;5311.309529761135;5333.546648534879;5372.462753724625;5381.273528073719;4273.871783846482;4291;4304.225239456897;4331.436913201295;4361.040571074359;4089.427480152781;4169.187008533338;4169.812358443862;4199.874003779892;4203.7687927164;4143.834246630131;4175.728577642443;4176.68674849386;4202.096549241913;4233.703640745149;4066.9999999999704;4153.086321009373;4187.727797693171;4191.308434108369;4222.0922501662135;3649.4708267301094;3655.2872189922978;3657.3782456982112;3688;3691.8523259069607;5150.201718733602;5173.637845350827;5180;5180.870478238036;5262.947370526284;4607.953920460786;4666.95333046672;4671.672982891199;4681.391419115527;4699.989502257031;5478.369987451414;5554.0835762099205;5571.9442805572235;5588.050031494615;5665.688387138705;3935.212957408501;3938.862139825121;3947.644711975936;3955.5253369595835;3969.384745364473;5972.163897054415;5985.072313791369;5986.341502434729;6020.518358531307;6059.939400605982;3994.2610617035944;4002.6397624213378;4029.4157347185082;4032.717709760347;4072.6131017553284;4062.695297852673;4072.0430698785763;4072.4095006223934;4075.775832329191;4079.0822065035723;4443.400140980991;4511.684182107221;4517.412736344254;4518.8418405356315;4557.316402539579;5517.641353312022;5518.834434966958;5527.640703354269;5558.610897237155;5569.192467092249;1403.4456389726001;1407.0572716279912;1427.4861050021984;1427.9286035698174;1444.306732768277;837.5142417397894;910.9362344635812;926.4904302633524;930.4928813796497;944.7685317097355;5396.703181325065;5407.810726624549;5412.269343638637;5415.458454154632;5430.321209848769;5846.210761547137;5869.383714709894;5877.735501902424;5883.61756485827;5963.522918166536;5418.295621569249;5426.728663566806;5427.83716488506;5463.071277882769;5482.17767334903;3124.906252812419;3185.124090875028;3194.105650417887;3221.7261532769508;3248.171716212351;5927.762889484458;6000.909986350208;6009.729562169713;6010.669413182317;6022.277326720734;6003.099535069687;6005.819825405245;6037.400088976425;6060.787872424444;6074.757009719562;5789;5992.43071908168;6001.999999999913;6005.489533389711;6073.362296958756;5860.033094539353;5871;5939.227900372924;5960.046392577166;6023.969880150571;5808.332041815076;5819.476247137778;5845.444682755132;5914.763409463573;5929.970350148222;6100.23747031621;6109.358517355614;6123.2652081750475;6175.62946223228;6209.5032397409;3496.9475457867643;3748.94376584346;3767.6985841132096;3782.243551289698;3794.734368594172;5907.054871220584;5912.113183022581;5912.70436478183;5929.673867937305;5947;5749.051406517878;5759.683217423082;5763.827085187451;5788.884222315446;5811.970940145272;5626.803061892814;5745.482906538432;5775.797847075501;5776.451237132465;5786.1899334094105;5601;5607.214989901336;5621.634593751393;5648.265725455664;5715.685637289989;5736.110902810071;5752.453516915886;5755.165501002248;5766.365699773106;5849.5612829037145;5499.972500137634;5630.971845140748;5665.12190610456;5678.574106941914;5728.484436400744 03:08:15 INFO - 2015-11-06 03:08:15,693 DEBUG : BROWSER_OUTPUT: |5;yui.html;682.273378851523;684.2063206680252;689.7723751162117;704.2745971649201;733.0104359115195;12101.27392356458;12305.876941230585;12326.506939722423;12358.629241122759;12471.251724896501;11016.17378696599;11306.886931130686;11589;11733.647990560276;11981.940090299537;807.3581502705349;832.488019867783;838.8448137094626;847.5677404523676;848.898132224134;801.7113839017949;823.086374124721;826.1160558202725;829.2371018662815;836.2390224895346;855.8117214212863;874.6326542852017;876.6011464783509;877.3814460805149;883.9071897450772;830.0537387378394;859.7506723050308;871.7602659268689;872.2672954718004;872.5375550957939;630.8422894276431;632.629911501772;646.0632083478974;647.8250872264509;648.9415952564292;10918.945405272923;11016.724581885437;11209.663710088711;11275.154363422776;11282.605108821233;8394.034686011126;8730.912690873074;8808.251298639623;8894.199522043047;9333.806555459461;7394.075740532434;7469.626518674045;7470.962645186739;7640.73257435987;7642.7325043623205;2866.249981294043;2905.462489439439;2972.65814431341;2993.5958645582787;3077.415291094685;37480.25039499222;37512.437313440045;40538.39192412116;41920.37119443211;42237.577624223675;7901.407394445325;7950.4832185907735;8041.597920103972;8086.636101375452;8123.918760812435;17313.56716082108;17361.30554777795;17430.12849357527;17508.912455437643;17581.472555823344;5687.7156142192725;5711.114777209539;5717.428257174332;5754.913676294859;5828.562857785683;3377.3751855906735;3448.655134486531;3458.2563254407587;3503.089196808848;3537.9469307960403;2480.503899220163;2481.5905375613183;2492.0405643826894;2510.0963653084873;2511.6483692283095;373.1119934555794;373.85419686322354;378.6913665362721;382.77798876651474;382.8793929912069;416.4107787480681;423.9443784975451;500.13975961346426;529.5842763430688;544.9318835145607;7007.124109486314;7083.964580177066;7245.89131163033;7249.601271930094;7288.416926645856;421.9578042195817;432.68197874562173;453.9909201815945;457.0105721113818;476.2427739893517;3271.9836400817844;3337.4159522084024;3338.9332213355597;3356.16095976006;3388.288459423549;54133;54712;54946.175807362924;54987.175192372146;55208.17187742187;45361.319580205665;45534;45660.77169614131;45894.77052614716;46282.537174628495;34431.31137377238;41361.37957930633;41836.58163418327;41965.1606967865;42002.15995680069;7171.4621403395995;7208.783736487913;7269.41844652416;7430.851382972202;7629.961850190713;31350.52974205343;31382.058538243888;31969.36061278715;32102;32365.35269294648;43044.78477607592;43168;44050;44112.7794361039;44290.557094428645;5771.942280577308;5998.820035398945;6303.873922521616;6335.714892829741;6412.871742565029;10079.798404032024;10136.746581335525;10221.843341725906;10267.281290309906;10319.845202322122;9574.281928855504;9633.518324083627;9660.468674222986;9733.561989710339;9801.803963920824;9439.52802359893;9530.618775248913;9701.652715174952;9726.416415015121;9794.706158815246;9439.858402123837;9460.2904782143;9534.761630959281;9544.284178686488;9583.377080489747;8290;8445.493270403795;8451.366147539082;8736.170063843925;8780.429272097294;7880.211978802303;8207.876881846658;8463.830723385621;8527.914720852712;8718.564071796513 03:08:15 INFO - 2015-11-06 03:08:15,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:08:15 INFO - 2015-11-06 03:08:15,693 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:08:15 INFO - 2015-11-06 03:08:15,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: __startTimestamp1446808095678__endTimestamp 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,694 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4782.63 Median:4880.00 stddev:505.42 (10.4%) stddev-sans-first:482.06 03:08:15 INFO - 2015-11-06 03:08:15,696 DEBUG : BROWSER_OUTPUT: Values: 2784.8 2825.9 2851.0 2864.7 2873.8 4779.4 4804.0 4805.3 4813.3 4893.8 4696.4 4803.7 4821.0 4839.9 4849.7 4347.6 4454.6 4538.9 4574.0 4598.7 4437.0 4472.7 4569.0 4575.3 4592.4 4547.6 4566.3 4588.5 4590.5 4631.2 4597.9 4642.0 4643.7 4652.2 4676.9 4345.1 4385.8 4471.4 4518.8 4528.6 4807.9 4812.6 4843.1 4880.0 4887.9 5153.1 5171.6 5177.1 5195.7 5225.4 4821.2 4920.6 4937.5 5054.1 5177.8 4746.0 4771.2 4785.5 4813.4 4862.7 5231.8 5246.1 5282.7 5283.2 5301.9 4677.7 4868.4 4871.8 4912.1 5036.1 5021.4 5027.1 5027.7 5044.9 5046.1 4951.7 4996.9 4997.6 5001.7 5002.2 4778.8 4895.6 4899.0 4959.1 5050.8 3856.3 3895.5 3986.2 4003.7 4007.4 3582.4 3592.5 3601.5 3617.1 3632.8 4681.3 4776.3 4813.3 4816.7 4916.1 5132.0 5148.4 5152.9 5172.5 5190.6 4800.9 4817.7 4829.6 4840.1 4851.4 4296.6 4403.2 4426.6 4521.8 4523.5 5036.2 5139.5 5140.2 5151.1 5155.4 5234.2 5274.5 5292.9 5299.4 5357.2 4951.4 5393.4 5407.4 5419.4 5435.6 4997.7 5051.7 5072.5 5087.3 5116.0 5194.3 5239.3 5246.9 5265.3 5285.1 4827.7 5090.9 5113.4 5125.6 5133.9 4915.6 4965.7 4971.1 5018.8 5032.9 4966.4 4977.8 4990.8 4997.6 5008.8 5071.2 5113.2 5115.8 5134.1 5144.0 4716.3 4763.6 4810.0 4823.9 4865.1 03:08:15 INFO - 2015-11-06 03:08:15,696 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,696 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46436.46 Median:33533.16 stddev:85431.68 (254.8%) stddev-sans-first:85601.71 03:08:15 INFO - 2015-11-06 03:08:15,697 DEBUG : BROWSER_OUTPUT: Values: 497.7 502.8 506.8 517.4 528.5 29367.4 30811.5 36350.0 36805.9 37070.4 38683.0 40618.6 40619.4 40718.6 40887.4 7499.6 8167.2 8346.2 8367.7 8375.4 7706.9 9528.5 9789.9 9867.9 9888.9 9579.8 9687.9 9707.8 9741.6 9745.4 7754.9 8012.9 9572.3 9724.5 9929.4 9667.1 9696.5 9808.5 9809.2 9811.5 36589.6 37148.0 37213.1 37230.4 37387.0 2780.7 2793.2 2800.1 2801.7 2820.6 25361.9 25517.7 25815.1 25817.5 25863.2 2105.4 2133.5 2139.3 2151.7 2172.3 246384.0 246659.0 247611.0 249962.0 252740.0 50419.0 51646.7 58409.7 59015.1 62986.0 58295.0 58585.7 58757.7 59135.7 59167.4 14018.8 14142.9 14148.8 14181.6 14287.8 11860.2 12001.5 12083.6 12084.6 12106.6 18948.0 19051.5 19089.9 19095.3 19209.9 7217.0 7527.1 7552.3 7592.1 7602.9 801.2 861.4 882.7 892.9 986.4 25577.2 25981.4 26229.6 26280.3 26333.0 842.3 915.4 944.2 962.1 1067.7 9695.7 13318.8 14136.9 14822.9 15251.8 406919.0 424780.0 435943.0 451504.0 458314.0 49846.8 50461.5 50479.7 50520.2 51285.5 1205.8 1240.9 1281.3 1307.9 1323.0 24447.6 26677.3 26917.9 27355.7 28009.2 47225.3 47716.8 47732.8 48116.0 48438.5 243911.0 246105.0 247852.0 248978.0 249028.0 27867.6 27930.9 27995.2 28129.9 28157.0 38826.6 39310.6 39492.4 40008.6 40401.0 31764.8 32321.5 33285.2 33443.0 33623.3 31592.7 32056.7 32481.0 32554.0 32584.5 32399.4 32959.3 33120.8 33172.0 33303.2 26311.0 28270.7 28300.6 28485.4 28697.0 21802.6 22216.9 22411.3 22523.3 22563.5 03:08:15 INFO - 2015-11-06 03:08:15,697 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,697 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26198.32 Median:24845.23 stddev:91655.89 (368.9%) stddev-sans-first:91892.39 03:08:15 INFO - 2015-11-06 03:08:15,699 DEBUG : BROWSER_OUTPUT: Values: 305.6 311.2 311.2 314.5 319.9 13245.7 13526.9 15056.5 15484.6 15985.9 13930.2 15503.5 16105.5 16417.3 16441.5 4295.5 4399.1 4443.4 4730.5 4880.3 3213.4 3286.8 4257.0 4406.4 4426.2 4261.6 4290.4 4301.5 4313.0 4333.1 4182.1 4267.3 4293.6 4312.0 4321.5 3696.9 3699.9 3704.8 3720.3 3726.4 11636.1 12097.9 12245.0 12369.8 12399.9 1644.4 1721.5 1782.9 1793.9 1834.0 8576.2 8596.4 8664.4 8920.8 8947.8 1297.8 1305.1 1346.8 1352.7 1357.1 48602.8 50022.2 55366.7 56371.4 56785.4 5911.9 5999.7 6006.9 6106.5 6110.5 6923.7 6924.2 6935.7 6939.2 7039.7 5052.4 5064.0 5085.1 5143.4 5152.6 5481.3 5505.4 5530.3 5542.7 5551.0 2693.2 2725.0 2739.3 2747.8 2750.2 947.1 951.2 961.8 983.2 1006.2 333.5 378.8 390.7 391.9 402.2 9899.7 10542.6 10831.9 10873.2 11121.7 400.7 407.7 422.6 430.4 448.7 5684.2 6051.4 6056.5 6094.2 6095.9 551961.0 555610.0 558258.0 565758.0 568905.0 62679.7 64180.7 65000.3 65460.0 65621.3 479.5 485.0 486.6 487.3 489.0 9858.0 9998.0 10106.6 10162.0 10185.6 30516.4 30989.4 32242.2 33644.7 33968.3 43515.0 43593.6 43643.3 44386.8 44960.0 5582.6 5697.7 5726.6 5733.6 5748.2 10002.8 10582.5 10651.3 10681.7 10682.0 9107.4 9184.7 9329.4 9336.4 9347.2 8612.9 8849.5 8871.4 8904.7 9123.3 7564.1 9598.2 9698.2 9776.1 9829.4 4832.4 4931.6 5216.3 5320.8 5667.5 9098.8 9124.0 9269.3 9273.8 9277.6 03:08:15 INFO - 2015-11-06 03:08:15,699 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,700 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4795.89 Median:6109.98 stddev:2496.68 (40.9%) stddev-sans-first:2487.87 03:08:15 INFO - 2015-11-06 03:08:15,700 DEBUG : BROWSER_OUTPUT: Values: 1057.7 1558.9 1608.3 1629.3 1629.4 6252.6 6744.3 6798.0 6865.2 6899.9 6764.9 6920.3 6932.7 6955.8 7034.0 1937.5 1956.8 1956.9 1957.6 1962.8 1984.9 1986.4 1988.0 2046.1 2052.8 1889.0 1905.4 1907.7 1919.9 1920.2 1988.0 1993.5 1997.5 2008.5 2010.3 1964.1 1971.5 1995.6 1995.8 2009.8 6194.8 6341.0 6779.8 6814.8 6839.2 4140.7 4237.4 4241.4 4249.7 4252.3 2531.9 2549.7 2562.8 2580.7 2591.7 767.2 782.4 800.3 805.9 807.6 9065.7 9092.3 9134.9 9178.3 9202.2 3859.5 3867.8 3916.4 3938.4 3966.4 7935.8 7950.1 7966.4 7973.4 8114.8 4325.6 4338.6 4338.7 4340.9 4369.8 3933.4 3934.1 3940.6 3942.3 3948.1 3121.8 3143.9 3149.3 3171.7 3181.5 959.1 965.8 967.4 979.6 984.0 1167.3 1169.8 1174.2 1194.1 1199.5 6338.8 6529.5 6539.0 6543.4 6551.1 382.3 384.6 385.9 387.5 388.4 5129.6 5208.0 5215.1 5224.3 5342.2 8032.8 8248.6 8253.0 8263.3 8272.0 8057.4 8145.4 8166.0 8188.6 8232.5 6516.4 6609.1 6652.3 6707.7 6711.7 6539.4 6550.5 6559.4 6575.6 6586.4 7013.6 7297.9 7299.0 7299.7 7326.3 7301.6 7687.2 7715.4 7743.4 7767.7 5854.6 5859.1 5917.4 5953.4 5974.2 6603.7 6633.7 6649.4 6655.1 6696.0 6188.1 6216.2 6311.5 6333.5 6370.9 6073.1 6146.8 6159.2 6250.9 6317.0 6241.5 6282.4 6299.8 6314.7 6341.0 5571.0 5620.1 5623.5 5625.6 5626.1 5239.5 5253.1 5413.1 5419.4 5423.9 03:08:15 INFO - 2015-11-06 03:08:15,700 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,700 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4762.70 Median:5427.28 stddev:1443.70 (26.6%) stddev-sans-first:1408.08 03:08:15 INFO - 2015-11-06 03:08:15,702 DEBUG : BROWSER_OUTPUT: Values: 284.7 291.2 293.8 296.3 298.2 5351.1 5359.0 5379.0 5391.2 5415.6 5298.2 5311.3 5333.5 5372.5 5381.3 4273.9 4291.0 4304.2 4331.4 4361.0 4089.4 4169.2 4169.8 4199.9 4203.8 4143.8 4175.7 4176.7 4202.1 4233.7 4067.0 4153.1 4187.7 4191.3 4222.1 3649.5 3655.3 3657.4 3688.0 3691.9 5150.2 5173.6 5180.0 5180.9 5262.9 4608.0 4667.0 4671.7 4681.4 4700.0 5478.4 5554.1 5571.9 5588.1 5665.7 3935.2 3938.9 3947.6 3955.5 3969.4 5972.2 5985.1 5986.3 6020.5 6059.9 3994.3 4002.6 4029.4 4032.7 4072.6 4062.7 4072.0 4072.4 4075.8 4079.1 4443.4 4511.7 4517.4 4518.8 4557.3 5517.6 5518.8 5527.6 5558.6 5569.2 1403.4 1407.1 1427.5 1427.9 1444.3 837.5 910.9 926.5 930.5 944.8 5396.7 5407.8 5412.3 5415.5 5430.3 5846.2 5869.4 5877.7 5883.6 5963.5 5418.3 5426.7 5427.8 5463.1 5482.2 3124.9 3185.1 3194.1 3221.7 3248.2 5927.8 6000.9 6009.7 6010.7 6022.3 6003.1 6005.8 6037.4 6060.8 6074.8 5789.0 5992.4 6002.0 6005.5 6073.4 5860.0 5871.0 5939.2 5960.0 6024.0 5808.3 5819.5 5845.4 5914.8 5930.0 6100.2 6109.4 6123.3 6175.6 6209.5 3496.9 3748.9 3767.7 3782.2 3794.7 5907.1 5912.1 5912.7 5929.7 5947.0 5749.1 5759.7 5763.8 5788.9 5812.0 5626.8 5745.5 5775.8 5776.5 5786.2 5601.0 5607.2 5621.6 5648.3 5715.7 5736.1 5752.5 5755.2 5766.4 5849.6 5500.0 5631.0 5665.1 5678.6 5728.5 03:08:15 INFO - 2015-11-06 03:08:15,702 DEBUG : BROWSER_OUTPUT: 03:08:15 INFO - 2015-11-06 03:08:15,702 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12050.74 Median:5699.42 stddev:14649.55 (257.0%) stddev-sans-first:14665.77 03:08:15 INFO - 2015-11-06 03:08:15,704 DEBUG : BROWSER_OUTPUT: Values: 682.3 684.2 689.8 704.3 733.0 12101.3 12305.9 12326.5 12358.6 12471.3 11016.2 11306.9 11589.0 11733.6 11981.9 807.4 832.5 838.8 847.6 848.9 801.7 823.1 826.1 829.2 836.2 855.8 874.6 876.6 877.4 883.9 830.1 859.8 871.8 872.3 872.5 630.8 632.6 646.1 647.8 648.9 10918.9 11016.7 11209.7 11275.2 11282.6 8394.0 8730.9 8808.3 8894.2 9333.8 7394.1 7469.6 7471.0 7640.7 7642.7 2866.2 2905.5 2972.7 2993.6 3077.4 37480.3 37512.4 40538.4 41920.4 42237.6 7901.4 7950.5 8041.6 8086.6 8123.9 17313.6 17361.3 17430.1 17508.9 17581.5 5687.7 5711.1 5717.4 5754.9 5828.6 3377.4 3448.7 3458.3 3503.1 3537.9 2480.5 2481.6 2492.0 2510.1 2511.6 373.1 373.9 378.7 382.8 382.9 416.4 423.9 500.1 529.6 544.9 7007.1 7084.0 7245.9 7249.6 7288.4 422.0 432.7 454.0 457.0 476.2 3272.0 3337.4 3338.9 3356.2 3388.3 54133.0 54712.0 54946.2 54987.2 55208.2 45361.3 45534.0 45660.8 45894.8 46282.5 34431.3 41361.4 41836.6 41965.2 42002.2 7171.5 7208.8 7269.4 7430.9 7630.0 31350.5 31382.1 31969.4 32102.0 32365.4 43044.8 43168.0 44050.0 44112.8 44290.6 5771.9 5998.8 6303.9 6335.7 6412.9 10079.8 10136.7 10221.8 10267.3 10319.8 9574.3 9633.5 9660.5 9733.6 9801.8 9439.5 9530.6 9701.7 9726.4 9794.7 9439.9 9460.3 9534.8 9544.3 9583.4 8290.0 8445.5 8451.4 8736.2 8780.4 7880.2 8207.9 8463.8 8527.9 8718.6 03:08:15 INFO - 2015-11-06 03:08:15,704 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:08:15 INFO - 2015-11-06 03:08:15,704 DEBUG : BROWSER_OUTPUT: 03:08:16 INFO - 2015-11-06 03:08:16,355 INFO : Browser exited with error code: 0 03:08:16 INFO - 2015-11-06 03:08:16,386 INFO : Completed test dromaeo_css (00:18:35) 03:08:16 INFO - 2015-11-06 03:08:16,386 INFO : Starting test kraken 03:08:16 INFO - 2015-11-06 03:08:16,386 DEBUG : operating with platform_type : mac_ 03:08:16 INFO - 2015-11-06 03:08:16,386 INFO : Initialising browser for kraken test... 03:08:16 INFO - 2015-11-06 03:08:16,401 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpGDTOV8/profile http://localhost:49263/getInfo.html 03:08:18 INFO - 2015-11-06 03:08:18,877 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:08:18 INFO - 2015-11-06 03:08:18,878 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:08:18 INFO - 2015-11-06 03:08:18,878 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:08:18 INFO - 2015-11-06 03:08:18,878 DEBUG : BROWSER_OUTPUT: __metrics 03:08:18 INFO - 2015-11-06 03:08:18,894 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:19 INFO - 2015-11-06 03:08:19,196 DEBUG : BROWSER_OUTPUT: console.error: 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: Stack: 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 03:08:19 INFO - 2015-11-06 03:08:19,197 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 03:08:19 INFO - 2015-11-06 03:08:19,198 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 03:08:19 INFO - 2015-11-06 03:08:19,198 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 03:08:19 INFO - 2015-11-06 03:08:19,198 DEBUG : BROWSER_OUTPUT: 03:08:19 INFO - 2015-11-06 03:08:19,647 INFO : Browser initialized. 03:08:19 INFO - 2015-11-06 03:08:19,648 INFO : Running cycle 1/1 for kraken test... 03:08:19 INFO - 2015-11-06 03:08:19,648 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpGDTOV8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:08:31 INFO - 2015-11-06 03:08:31,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 199639040 03:08:31 INFO - 2015-11-06 03:08:31,673 DEBUG : BROWSER_OUTPUT: 03:08:34 INFO - 2015-11-06 03:08:34,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:35 INFO - 2015-11-06 03:08:35,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 266350592 03:08:35 INFO - 2015-11-06 03:08:35,099 DEBUG : BROWSER_OUTPUT: 03:08:38 INFO - 2015-11-06 03:08:38,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 03:08:38 INFO - 2015-11-06 03:08:38,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 280408064 03:08:38 INFO - 2015-11-06 03:08:38,604 DEBUG : BROWSER_OUTPUT: 03:08:41 INFO - 2015-11-06 03:08:41,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 03:08:42 INFO - 2015-11-06 03:08:42,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 268050432 03:08:42 INFO - 2015-11-06 03:08:42,318 DEBUG : BROWSER_OUTPUT: 03:08:44 INFO - 2015-11-06 03:08:44,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 03:08:45 INFO - 2015-11-06 03:08:45,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 270073856 03:08:45 INFO - 2015-11-06 03:08:45,147 DEBUG : BROWSER_OUTPUT: 03:08:47 INFO - 2015-11-06 03:08:47,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:48 INFO - 2015-11-06 03:08:48,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 269107200 03:08:48 INFO - 2015-11-06 03:08:48,153 DEBUG : BROWSER_OUTPUT: 03:08:51 INFO - 2015-11-06 03:08:51,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:52 INFO - 2015-11-06 03:08:52,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 268058624 03:08:52 INFO - 2015-11-06 03:08:52,135 DEBUG : BROWSER_OUTPUT: 03:08:55 INFO - 2015-11-06 03:08:55,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:56 INFO - 2015-11-06 03:08:56,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 266715136 03:08:56 INFO - 2015-11-06 03:08:56,209 DEBUG : BROWSER_OUTPUT: 03:08:59 INFO - 2015-11-06 03:08:59,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 03:08:59 INFO - 2015-11-06 03:08:59,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 268308480 03:08:59 INFO - 2015-11-06 03:08:59,980 DEBUG : BROWSER_OUTPUT: 03:09:01 INFO - 2015-11-06 03:09:01,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:09:02 INFO - 2015-11-06 03:09:02,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 301166592 03:09:02 INFO - 2015-11-06 03:09:02,288 DEBUG : BROWSER_OUTPUT: 03:09:04 INFO - 2015-11-06 03:09:04,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:09:04 INFO - 2015-11-06 03:09:04,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 302239744 03:09:04 INFO - 2015-11-06 03:09:04,874 DEBUG : BROWSER_OUTPUT: 03:09:07 INFO - 2015-11-06 03:09:07,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:09:07 INFO - 2015-11-06 03:09:07,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 308600832 03:09:07 INFO - 2015-11-06 03:09:07,715 DEBUG : BROWSER_OUTPUT: 03:09:10 INFO - 2015-11-06 03:09:10,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:11 INFO - 2015-11-06 03:09:11,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 310251520 03:09:11 INFO - 2015-11-06 03:09:11,148 DEBUG : BROWSER_OUTPUT: 03:09:13 INFO - 2015-11-06 03:09:13,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:14 INFO - 2015-11-06 03:09:14,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 309395456 03:09:14 INFO - 2015-11-06 03:09:14,551 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 03:09:16 INFO - 2015-11-06 03:09:16,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 368238592 03:09:16 INFO - 2015-11-06 03:09:16,692 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:09:16 INFO - 2015-11-06 03:09:16,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:09:16 INFO - 2015-11-06 03:09:16,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:09:16 INFO - 2015-11-06 03:09:16,693 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:09:16 INFO - 2015-11-06 03:09:16,693 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;121;125;124;125;124;126;127;126;125 03:09:16 INFO - 2015-11-06 03:09:16,693 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;153;186;175;148;171;146;182;170;148 03:09:16 INFO - 2015-11-06 03:09:16,693 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;190;189;188;179;180;189;188;186;181 03:09:16 INFO - 2015-11-06 03:09:16,693 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;87;99;141;78;81;83;82;138;76 03:09:16 INFO - 2015-11-06 03:09:16,694 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;107;108;157;104;104;107;146;103;101;146 03:09:16 INFO - 2015-11-06 03:09:16,694 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;141;142;132;129;142;135;140;129;141;142 03:09:16 INFO - 2015-11-06 03:09:16,694 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;140;146;148;146;141;147;147;147;144;140 03:09:16 INFO - 2015-11-06 03:09:16,694 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;116;115;118;118;118;119;118;119;118;116 03:09:16 INFO - 2015-11-06 03:09:16,694 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;70;69;72;73;72;72;82;67;68 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;72;72;76;75;77;77;77;77;74 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;95;96;96;95;94;94;96;96;100 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;140;151;142;138;153;154;140;150;144;140 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;172;169;167;170;159;161;167;167;167 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;77;77;80;82;81;81;81;80;82 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:09:16 INFO - 2015-11-06 03:09:16,695 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:09:16 INFO - 2015-11-06 03:09:16,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 03:09:16 INFO - 2015-11-06 03:09:16,696 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:09:16 INFO - 2015-11-06 03:09:16,696 DEBUG : BROWSER_OUTPUT: __startTimestamp1446808156688__endTimestamp 03:09:16 INFO - 2015-11-06 03:09:16,696 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,696 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:124.40 Median:125.00 stddev:2.01 (1.6%) stddev-sans-first:1.72 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: Values: 121.0 121.0 125.0 124.0 125.0 124.0 126.0 127.0 126.0 125.0 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:164.90 Median:170.50 stddev:14.90 (8.7%) stddev-sans-first:15.69 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: Values: 170.0 153.0 186.0 175.0 148.0 171.0 146.0 182.0 170.0 148.0 03:09:16 INFO - 2015-11-06 03:09:16,697 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,698 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:185.20 Median:188.00 stddev:4.24 (2.3%) stddev-sans-first:4.33 03:09:16 INFO - 2015-11-06 03:09:16,698 DEBUG : BROWSER_OUTPUT: Values: 182.0 190.0 189.0 188.0 179.0 180.0 189.0 188.0 186.0 181.0 03:09:16 INFO - 2015-11-06 03:09:16,698 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,698 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.30 Median:82.50 stddev:24.16 (29.3%) stddev-sans-first:25.48 03:09:16 INFO - 2015-11-06 03:09:16,698 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 99.0 141.0 78.0 81.0 83.0 82.0 138.0 76.0 03:09:16 INFO - 2015-11-06 03:09:16,698 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,700 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.30 Median:107.50 stddev:21.95 (20.4%) stddev-sans-first:22.90 03:09:16 INFO - 2015-11-06 03:09:16,700 DEBUG : BROWSER_OUTPUT: Values: 107.0 108.0 157.0 104.0 104.0 107.0 146.0 103.0 101.0 146.0 03:09:16 INFO - 2015-11-06 03:09:16,700 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,700 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.30 Median:141.00 stddev:5.50 (3.9%) stddev-sans-first:5.67 03:09:16 INFO - 2015-11-06 03:09:16,700 DEBUG : BROWSER_OUTPUT: Values: 141.0 142.0 132.0 129.0 142.0 135.0 140.0 129.0 141.0 142.0 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.60 Median:146.50 stddev:3.13 (2.1%) stddev-sans-first:2.85 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: Values: 140.0 146.0 148.0 146.0 141.0 147.0 147.0 147.0 144.0 140.0 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.50 Median:118.00 stddev:1.35 (1.1%) stddev-sans-first:1.32 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 118.0 118.0 118.0 119.0 118.0 119.0 118.0 116.0 03:09:16 INFO - 2015-11-06 03:09:16,701 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.50 Median:72.00 stddev:5.54 (7.7%) stddev-sans-first:4.39 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: Values: 60.0 70.0 69.0 72.0 73.0 72.0 72.0 82.0 67.0 68.0 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:76.50 stddev:2.39 (3.1%) stddev-sans-first:2.11 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 76.0 75.0 77.0 77.0 77.0 77.0 74.0 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:95.30 Median:95.50 stddev:2.26 (2.4%) stddev-sans-first:1.79 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 96.0 96.0 95.0 94.0 94.0 96.0 96.0 100.0 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:147.00 stddev:6.14 (4.2%) stddev-sans-first:6.22 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 142.0 138.0 153.0 154.0 140.0 150.0 144.0 140.0 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:167.00 stddev:4.41 (2.6%) stddev-sans-first:4.13 03:09:16 INFO - 2015-11-06 03:09:16,702 DEBUG : BROWSER_OUTPUT: Values: 160.0 172.0 169.0 167.0 170.0 159.0 161.0 167.0 167.0 167.0 03:09:16 INFO - 2015-11-06 03:09:16,703 DEBUG : BROWSER_OUTPUT: 03:09:16 INFO - 2015-11-06 03:09:16,703 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:81.00 stddev:2.88 (3.5%) stddev-sans-first:1.90 03:09:16 INFO - 2015-11-06 03:09:16,703 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 77.0 80.0 82.0 81.0 81.0 81.0 80.0 82.0 03:09:16 INFO - 2015-11-06 03:09:16,703 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:09:16 INFO - 2015-11-06 03:09:16,703 DEBUG : BROWSER_OUTPUT: 03:09:17 INFO - 2015-11-06 03:09:17,439 INFO : Browser exited with error code: 0 03:09:17 INFO - 2015-11-06 03:09:17,493 INFO : Completed test kraken (00:01:01) 03:09:17 INFO - 2015-11-06 03:09:17,493 INFO : Starting test v8_7 03:09:17 INFO - 2015-11-06 03:09:17,493 DEBUG : operating with platform_type : mac_ 03:09:17 INFO - 2015-11-06 03:09:17,493 INFO : Initialising browser for v8_7 test... 03:09:17 INFO - 2015-11-06 03:09:17,507 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpd8kOWq/profile http://localhost:49263/getInfo.html 03:09:19 INFO - 2015-11-06 03:09:19,862 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:19 INFO - 2015-11-06 03:09:19,863 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:19 INFO - 2015-11-06 03:09:19,863 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:09:19 INFO - 2015-11-06 03:09:19,863 DEBUG : BROWSER_OUTPUT: __metrics 03:09:19 INFO - 2015-11-06 03:09:19,884 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:09:20 INFO - 2015-11-06 03:09:20,698 INFO : Browser initialized. 03:09:20 INFO - 2015-11-06 03:09:20,698 INFO : Running cycle 1/1 for v8_7 test... 03:09:20 INFO - 2015-11-06 03:09:20,699 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpd8kOWq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:09:32 INFO - 2015-11-06 03:09:32,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 200089600 03:09:32 INFO - 2015-11-06 03:09:32,722 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html) 03:09:55 INFO - 2015-11-06 03:09:55,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 509349888 03:09:55 INFO - 2015-11-06 03:09:55,899 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: |0;Richards;187.44142455482663 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;217.58050478677112 03:09:55 INFO - 2015-11-06 03:09:55,900 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.794500723589 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6890.41095890411 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1156.0693641618498 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |6;Boyer;14013.888888888889 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |7;RegExp;33290.32258064516 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |8;Splay;663.7988087359365 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6611.8421052631575 03:09:55 INFO - 2015-11-06 03:09:55,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: __startTimestamp1446808195896__endTimestamp 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:187.44 Median:187.44 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: Values: 187.4 03:09:55 INFO - 2015-11-06 03:09:55,902 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:217.58 Median:217.58 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: Values: 217.6 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.79 Median:361.79 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: Values: 361.8 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6890.41 Median:6890.41 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,903 DEBUG : BROWSER_OUTPUT: Values: 6890.4 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1156.07 Median:1156.07 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: Values: 1156.1 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: Values: 788.6 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,904 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14013.89 Median:14013.89 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: Values: 14013.9 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33290.32 Median:33290.32 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: Values: 33290.3 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:663.80 Median:663.80 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: Values: 663.8 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6611.84 Median:6611.84 stddev:0.00 (0.0%) 03:09:55 INFO - 2015-11-06 03:09:55,905 DEBUG : BROWSER_OUTPUT: Values: 6611.8 03:09:55 INFO - 2015-11-06 03:09:55,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:09:55 INFO - 2015-11-06 03:09:55,906 DEBUG : BROWSER_OUTPUT: 03:09:56 INFO - 2015-11-06 03:09:56,608 INFO : Browser exited with error code: 0 03:09:56 INFO - 2015-11-06 03:09:56,631 INFO : Completed test v8_7 (00:00:39) 03:09:57 INFO - 2015-11-06 03:09:57,108 INFO : Completed test suite (00:20:16) 03:09:57 INFO - 2015-11-06 03:09:57,109 DEBUG : Working with test: dromaeo_css 03:09:57 INFO - 2015-11-06 03:09:57,109 DEBUG : Generating results file: dromaeo_css 03:09:57 INFO - 2015-11-06 03:09:57,109 DEBUG : Working with test: kraken 03:09:57 INFO - 2015-11-06 03:09:57,109 DEBUG : Generating results file: kraken 03:09:57 INFO - 2015-11-06 03:09:57,110 INFO : javascript benchmark 03:09:57 INFO - 2015-11-06 03:09:57,110 DEBUG : Working with test: v8_7 03:09:57 INFO - 2015-11-06 03:09:57,110 DEBUG : Generating results file: v8_7 03:09:57 INFO - 2015-11-06 03:09:57,110 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:57 INFO - 2015-11-06 03:09:57,162 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:09:57 INFO - 2015-11-06 03:09:57,162 DEBUG : process_Request line: dromaeo_css 5948.27 graph.html#tests=[[72,52,55]] 03:09:57 INFO - 2015-11-06 03:09:57,162 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:57 INFO - 2015-11-06 03:09:57,189 DEBUG : process_Request line: kraken 1718.60 graph.html#tests=[[232,52,55]] 03:09:57 INFO - 2015-11-06 03:09:57,189 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:57 INFO - 2015-11-06 03:09:57,217 DEBUG : process_Request line: v8_7 17870.90 graph.html#tests=[[230,52,55]] 03:09:57 INFO - 2015-11-06 03:09:57,218 INFO : javascript benchmark 03:09:57 INFO - 2015-11-06 03:09:57,220 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [305.6408719754288, 311.15521359508926, 311.18935173872063, 314.5439113285735, 319.8512691598407, 13245.668858278525, 13526.864731352684, 15056.548303550884, 15484.612884677874, 15985.920070399647, 13930.164190148598, 15503.457378991738, 16105.516834494954, 16417.261223244954, 16441.506754797374, 4295.52749197588, 4399.05420334628, 4443.422355093833, 4730.455997560273, 4880.267959806022, 3213.4055199788113, 3286.8356582170795, 4257.0, 4406.383106365111, 4426.2254105531565, 4261.573842615745, 4290.356446533029, 4301.548337424572, 4312.97843510782, 4333.133373325331, 4182.100848317596, 4267.253230684618, 4293.570642935712, 4311.9784401078105, 4321.481422229321, 3696.907577310562, 3699.9445008324897, 3704.833282502294, 3720.2931443025736, 3726.4224045273027, 11636.12729045325, 12097.850704183089, 12245.0, 12369.814452783216, 12399.876001239962, 1644.3751374477622, 1721.4577408116404, 1782.857371410297, 1793.8833975791663, 1834.0096347972078, 8576.228139467416, 8596.441231320006, 8664.350173736932, 8920.821583568293, 8947.821043579157, 1297.8247936528542, 1305.145129939891, 1346.7845144776788, 1352.7226918481688, 1357.0568454923832, 48602.756986215194, 50022.2496662554, 55366.72316638431, 56371.436285637436, 56785.43214567884, 5911.940880591139, 5999.730012149464, 6006.909896351558, 6106.511479081662, 6110.541709371726, 6923.723051077901, 6924.203716572659, 6935.653217339112, 6939.23668396476, 7039.718411263594, 5052.368453943257, 5063.974680126649, 5085.059264036166, 5143.434222235551, 5152.562032227303, 5481.287432633732, 5505.421930697299, 5530.2810634618045, 5542.722863856791, 5551.0, 2693.245891150481, 2724.986375068112, 2739.301478123106, 2747.7527022568065, 2750.188694335176, 947.0955237747934, 951.1534734086669, 961.7835986902891, 983.1986930651639, 1006.1799633298838, 333.4640109202404, 378.8105947026487, 390.7069697726705, 391.87851765952644, 402.22772277227796, 9899.7030089096, 10542.578296868192, 10831.945840270748, 10873.184511161695, 11121.666350009513, 400.73951931244926, 407.6983032555947, 422.64497821829195, 430.3802524364905, 448.73748856918417, 5684.175794509773, 6051.364606716319, 6056.515478761688, 6094.2077529920825, 6095.939040609537, 551961.0, 555610.0, 558258.0, 565758.0, 568905.0, 62679.686601566704, 64180.67909660422, 65000.34999650037, 65460.0, 65621.34378656153, 479.4989236248129, 484.95635392814813, 486.5839707050492, 487.32505479910577, 488.999995010205, 9857.95071024669, 9998.0, 10106.595736170471, 10161.98380161978, 10185.592576296865, 30516.389672206875, 30989.380212396078, 32242.193945151557, 33644.66355336415, 33968.32063358669, 43515.0, 43593.56406435895, 43643.34534982041, 44386.778066109466, 44960.0, 5582.609217354746, 5697.7151142443545, 5726.627769195155, 5733.569982251432, 5748.166515855094, 10002.8499572505, 10582.470876455993, 10651.30766500175, 10681.679549613524, 10682.0, 9107.408018478778, 9184.724458266262, 9329.393589416666, 9336.439813611205, 9347.205487533363, 8612.870806937775, 8849.469031858109, 8871.379003469954, 8904.73285801427, 9123.27013838878, 7564.092308922965, 9598.232141428809, 9698.175655069399, 9776.071273229032, 9829.361091529028, 4832.44426890898, 4931.605471562339, 5216.295800066942, 5320.787168513216, 5667.5465962722055, 9098.818023639622, 9124.0, 9269.304802139732, 9273.814523709352, 9277.62889484413], "dojo.html": [2784.8189867658602, 2825.901093461729, 2851.0306495791433, 2864.6562412510502, 2873.77009839213, 4779.3786807715, 4803.9519604803945, 4805.327254184417, 4813.253945638432, 4893.755312234392, 4696.412948381452, 4803.711777293356, 4821.0, 4839.903201935959, 4849.6847704899155, 4347.586979236968, 4454.599086082252, 4538.931916021263, 4574.0, 4598.678092533524, 4436.97781511092, 4472.731636101845, 4568.994821139344, 4575.29082992135, 4592.448906131269, 4547.567981041812, 4566.269396896497, 4588.495265520807, 4590.540945905416, 4631.235846085392, 4597.862064138081, 4641.9535804641855, 4643.674942754009, 4652.185867473178, 4676.883077923079, 4345.087531618364, 4385.8245670173155, 4471.35165401015, 4518.819247230107, 4528.569785870337, 4807.927881081787, 4812.5668689818085, 4843.128236917353, 4880.0, 4887.8778030549165, 5153.072446959546, 5171.612129090333, 5177.068127737006, 5195.688258704452, 5225.425203227642, 4821.180399332122, 4920.606351491872, 4937.506249375034, 5054.06499797535, 5177.8187763428095, 4746.027064451813, 4771.23660214364, 4785.473597904228, 4813.446453657804, 4862.708237505725, 5231.8168864089575, 5246.108161612535, 5282.735863206824, 5283.207518872123, 5301.920471192935, 4677.695949763254, 4868.391451068616, 4871.780769865364, 4912.091263116335, 5036.11867923112, 5021.397432308147, 5027.069992051483, 5027.698338099725, 5044.9495505045215, 5046.142155833517, 4951.7276549789385, 4996.90006199874, 4997.550220480174, 5001.699898006132, 5002.224655178453, 4778.761061946958, 4895.583875370562, 4898.951010489849, 4959.082569724613, 5050.84847454577, 3856.325143099946, 3895.474110995036, 3986.242613903349, 4003.7197396181987, 4007.3788562772816, 3582.444721068239, 3592.4611308303965, 3601.513795637555, 3617.0595645132457, 3632.818359082088, 4681.344611754357, 4776.259679749644, 4813.278008298783, 4816.686915350491, 4916.06594746997, 5131.974340128276, 5148.382194136728, 5152.948470515322, 5172.482751724798, 5190.55880250183, 4800.903981920342, 4817.7350245736825, 4829.589484893753, 4840.080384726891, 4851.442084160296, 4296.634786043159, 4403.207422663887, 4426.601605855489, 4521.796519156645, 4523.479799822997, 5036.244563315532, 5139.537441630271, 5140.177571588528, 5151.098557752453, 5155.381354237516, 5234.24103504982, 5274.472552744694, 5292.9206061908335, 5299.364076310867, 5357.19642053695, 4951.430585482715, 5393.433689462707, 5407.351117865881, 5419.403865574863, 5435.565154787687, 4997.700137991732, 5051.696898186121, 5072.467390924047, 5087.3386459759995, 5116.0, 5194.3247377840635, 5239.292695486213, 5246.868828279171, 5265.262863199078, 5285.127953887719, 4827.686200396963, 5090.949090509195, 5113.4375218726655, 5125.5899528036925, 5133.8716532087, 4915.6067514598035, 4965.702057876539, 4971.055499455092, 5018.774155162953, 5032.874178145576, 4966.379202599675, 4977.8257760978195, 4990.750462476789, 4997.600191984559, 5008.774605142705, 5071.163258062378, 5113.207452844815, 5115.769790359368, 5134.075866344094, 5143.974280128576, 4716.268978308368, 4763.618910487222, 4809.951900480951, 4823.903521929472, 4865.0756356292195], "mootools.html": [1057.7091299892534, 1558.906465612063, 1608.268237951732, 1629.3156874112872, 1629.4459883639563, 6252.593581417204, 6744.258131605526, 6797.966010169955, 6865.176178858544, 6899.896501552468, 6764.864702705943, 6920.273371296017, 6932.72269109235, 6955.791326260208, 7033.964830175854, 1937.4768812420602, 1956.7651881774136, 1956.9315073972343, 1957.628050670368, 1962.7939066398037, 1984.8908310042941, 1986.4040787763686, 1988.0159321135986, 2046.1201683276186, 2052.7741948385665, 1888.9556150024544, 1905.3617038292189, 1907.7424547686094, 1919.8560107991957, 1920.155131742036, 1988.045738045739, 1993.5215548268457, 1997.510609900569, 2008.4978755311172, 2010.2963962613114, 1964.0866996846391, 1971.5169783403157, 1995.600879824041, 1995.7804641489424, 2009.7688765791975, 6194.783182588633, 6341.0, 6779.830504237384, 6814.761483348059, 6839.179298484214, 4140.730852494578, 4237.4491316129015, 4241.3637954307105, 4249.723767955073, 4252.277112890816, 2531.886065127074, 2549.7450254974538, 2562.8077894157827, 2580.7290234525294, 2591.7278685737915, 767.244264399566, 782.3936449251819, 800.2517646001007, 805.9355251579918, 807.6204184033554, 9065.68270110543, 9092.318076144316, 9134.90865091354, 9178.31162662803, 9202.217811486033, 3859.4982652255026, 3867.8452861885207, 3916.3929590912885, 3938.4289278055094, 3966.3852102924093, 7935.801604959806, 7950.0857401398425, 7966.362690984707, 7973.401994850409, 8114.837703245902, 4325.589069038437, 4338.60952514269, 4338.696291259582, 4340.891477713019, 4369.75966321849, 3933.3706606943324, 3934.134490412162, 3940.6059394060367, 3942.270679924166, 3948.0919388540224, 3121.843907804601, 3143.937121257608, 3149.3228955774616, 3171.7462602991704, 3181.538676891838, 959.1271942532262, 965.7778710896392, 967.4050458967824, 979.5983646704817, 983.9963237497712, 1167.2762887009937, 1169.789437901186, 1174.2148367246864, 1194.1223200947297, 1199.5082016373244, 6338.844578894681, 6529.5102867284195, 6539.0, 6543.378379053982, 6551.148350714472, 382.2832189644417, 384.5635204043375, 385.8726620215322, 387.51173521363285, 388.41155649191495, 5129.589632829365, 5208.0365132450615, 5215.113430716711, 5224.346956630421, 5342.171963345688, 8032.759017229492, 8248.628811703487, 8253.0, 8263.256306932404, 8272.0, 8057.395695322874, 8145.389095817837, 8166.020077590727, 8188.631511581993, 8232.464889782144, 6516.413522782972, 6609.1077704510235, 6652.334766523309, 6707.664616769142, 6711.664416779142, 6539.411452969255, 6550.508711846535, 6559.376859198369, 6575.572587781779, 6586.353411647088, 7013.614251216232, 7297.890531641923, 7299.0, 7299.708011679473, 7326.267373262845, 7301.63491825396, 7687.154413014452, 7715.382769378549, 7743.419243556868, 7767.689292428239, 5854.619449735754, 5859.091840764689, 5917.408259174048, 5953.434423729739, 5974.22335096452, 6603.702833372606, 6633.701483433354, 6649.434798042221, 6655.134832471747, 6696.0, 6188.1027251049245, 6216.222972128484, 6311.526635502448, 6333.461655759128, 6370.936290637034, 6073.119397687399, 6146.846328841814, 6159.168512250789, 6250.906236406367, 6317.0, 6241.500679945502, 6282.434580887742, 6299.779507717391, 6314.715837787402, 6341.048842673636, 5570.997220500187, 5620.072688006597, 5623.493885550321, 5625.634333768292, 5626.099824028136, 5239.502247286502, 5253.106971814725, 5413.079776437936, 5419.403865574863, 5423.864403389789], "ext.html": [497.686457531755, 502.75616326081865, 506.799814073441, 517.3894804131126, 528.4636094364218, 29367.412651746978, 30811.537826932585, 36350.0, 36805.89582312535, 37070.44394334087, 38683.0, 40618.59381406185, 40619.390709139385, 40718.59281407185, 40887.38668919969, 7499.625018749068, 8167.224113709203, 8346.165383461635, 8367.665293388258, 8375.37184711146, 7706.884396734054, 9528.475933823636, 9789.902100979007, 9867.851982220272, 9888.901110988905, 9579.808403831954, 9687.854682179774, 9707.757306067335, 9741.610335586603, 9745.415275083482, 7754.922450775476, 8012.879806802903, 9572.28207884408, 9724.465154416468, 9929.3545919515, 9667.129958303716, 9696.46669433181, 9808.509574521246, 9809.21526277896, 9811.509424528746, 36589.634103658886, 37148.0, 37213.06967325811, 37230.44154337687, 37387.0, 2780.680221774481, 2793.1899749072745, 2800.0899707595113, 2801.677807052174, 2820.6192164057793, 25361.873190634113, 25517.744822551722, 25815.096471623405, 25817.483650327074, 25863.22410327693, 2105.3683894831643, 2133.541288622938, 2139.3474990128007, 2151.709519214902, 2172.3048624440185, 246384.0, 246658.9999999982, 247611.0, 249962.0, 252740.0, 50419.0, 51646.74176629093, 58409.70795145997, 59015.11477327844, 62986.0, 58295.0, 58585.70707146522, 58757.70621146952, 59135.704321478115, 59167.40832591705, 14018.789718154236, 14142.858571414154, 14148.787768183485, 14181.574552763434, 14287.78568321476, 11860.169788114921, 12001.459934302977, 12083.637490875288, 12084.577039803564, 12106.636800895987, 18948.0, 19051.523711907037, 19089.90455047716, 19095.331663391713, 19209.90395048016, 7217.0, 7527.134379546313, 7552.320291173821, 7592.126905405838, 7602.885956710654, 801.2188116586282, 861.401326078382, 882.7395918204145, 892.8973168085753, 986.4180133720996, 25577.232683019538, 25981.350466238116, 26229.606555901297, 26280.34299142537, 26333.0, 842.2756429470651, 915.3683958068912, 944.2210176604192, 962.138885697311, 1067.6636859389268, 9695.70912872615, 13318.800217996544, 14136.85863141376, 14822.925885370503, 15251.771223431657, 406919.0, 424780.0, 435943.0, 451504.0, 458314.0, 49846.75076624594, 50461.49538504568, 50479.747601261755, 50520.242196367086, 51285.48714512807, 1205.7588482303574, 1240.9379531023233, 1281.2760790153534, 1307.8626744191913, 1322.9603111906658, 24447.633285501088, 26677.333066673487, 26917.86541067282, 27355.72644273532, 28009.159725208276, 47225.29162062503, 47716.7614161927, 47732.7613361931, 48116.0, 48438.5156148434, 243911.0, 246105.0, 247852.0, 248978.0, 249028.0, 27867.581986269815, 27930.860345698955, 27995.160145195678, 28129.859350703115, 28157.0, 38826.6117338823, 39310.60689393069, 39492.40761388524, 40008.599914000486, 40401.0, 31764.841175793972, 32321.51517727189, 33285.20396692582, 33443.0, 33623.327533448704, 31592.684073158973, 32056.67943320537, 32481.0, 32554.0, 32584.51123233106, 32399.35201296008, 32959.340813184084, 33120.834395827864, 33172.0, 33303.167420813705, 26311.0, 28270.71729282681, 28300.575491368058, 28485.43029139447, 28697.0, 21802.563948721254, 22216.88891555532, 22411.32766017022, 22523.32430027102, 22563.548729025], "prototype.html": [284.7181290522383, 291.1527455105643, 293.76058512312466, 296.34064207139113, 298.1933868884667, 5351.117065684162, 5358.969520612568, 5378.973105134479, 5391.218273350361, 5415.64798288111, 5298.23175639532, 5311.309529761135, 5333.546648534879, 5372.462753724625, 5381.273528073719, 4273.871783846482, 4291.0, 4304.225239456897, 4331.436913201295, 4361.040571074359, 4089.427480152781, 4169.187008533338, 4169.812358443862, 4199.874003779892, 4203.7687927164, 4143.834246630131, 4175.728577642443, 4176.68674849386, 4202.096549241913, 4233.703640745149, 4066.9999999999704, 4153.086321009373, 4187.727797693171, 4191.308434108369, 4222.0922501662135, 3649.4708267301094, 3655.2872189922978, 3657.3782456982112, 3688.0, 3691.8523259069607, 5150.201718733602, 5173.637845350827, 5180.0, 5180.870478238036, 5262.947370526284, 4607.953920460786, 4666.95333046672, 4671.672982891199, 4681.391419115527, 4699.989502257031, 5478.369987451414, 5554.0835762099205, 5571.9442805572235, 5588.050031494615, 5665.688387138705, 3935.212957408501, 3938.862139825121, 3947.644711975936, 3955.5253369595835, 3969.384745364473, 5972.163897054415, 5985.072313791369, 5986.341502434729, 6020.518358531307, 6059.939400605982, 3994.2610617035944, 4002.6397624213378, 4029.4157347185082, 4032.717709760347, 4072.6131017553284, 4062.695297852673, 4072.0430698785763, 4072.4095006223934, 4075.775832329191, 4079.0822065035723, 4443.400140980991, 4511.684182107221, 4517.412736344254, 4518.8418405356315, 4557.316402539579, 5517.641353312022, 5518.834434966958, 5527.640703354269, 5558.610897237155, 5569.192467092249, 1403.4456389726001, 1407.0572716279912, 1427.4861050021984, 1427.9286035698174, 1444.306732768277, 837.5142417397894, 910.9362344635812, 926.4904302633524, 930.4928813796497, 944.7685317097355, 5396.703181325065, 5407.810726624549, 5412.269343638637, 5415.458454154632, 5430.321209848769, 5846.210761547137, 5869.383714709894, 5877.735501902424, 5883.61756485827, 5963.522918166536, 5418.295621569249, 5426.728663566806, 5427.83716488506, 5463.071277882769, 5482.17767334903, 3124.906252812419, 3185.124090875028, 3194.105650417887, 3221.7261532769508, 3248.171716212351, 5927.762889484458, 6000.909986350208, 6009.729562169713, 6010.669413182317, 6022.277326720734, 6003.099535069687, 6005.819825405245, 6037.400088976425, 6060.787872424444, 6074.757009719562, 5789.0, 5992.43071908168, 6001.999999999913, 6005.489533389711, 6073.362296958756, 5860.033094539353, 5871.0, 5939.227900372924, 5960.046392577166, 6023.969880150571, 5808.332041815076, 5819.476247137778, 5845.444682755132, 5914.763409463573, 5929.970350148222, 6100.23747031621, 6109.358517355614, 6123.2652081750475, 6175.62946223228, 6209.5032397409, 3496.9475457867643, 3748.94376584346, 3767.6985841132096, 3782.243551289698, 3794.734368594172, 5907.054871220584, 5912.113183022581, 5912.70436478183, 5929.673867937305, 5947.0, 5749.051406517878, 5759.683217423082, 5763.827085187451, 5788.884222315446, 5811.970940145272, 5626.803061892814, 5745.482906538432, 5775.797847075501, 5776.451237132465, 5786.1899334094105, 5601.0, 5607.214989901336, 5621.634593751393, 5648.265725455664, 5715.685637289989, 5736.110902810071, 5752.453516915886, 5755.165501002248, 5766.365699773106, 5849.5612829037145, 5499.972500137634, 5630.971845140748, 5665.12190610456, 5678.574106941914, 5728.484436400744], "yui.html": [682.273378851523, 684.2063206680252, 689.7723751162117, 704.2745971649201, 733.0104359115195, 12101.27392356458, 12305.876941230585, 12326.506939722423, 12358.629241122759, 12471.251724896501, 11016.17378696599, 11306.886931130686, 11589.0, 11733.647990560276, 11981.940090299537, 807.3581502705349, 832.488019867783, 838.8448137094626, 847.5677404523676, 848.898132224134, 801.7113839017949, 823.086374124721, 826.1160558202725, 829.2371018662815, 836.2390224895346, 855.8117214212863, 874.6326542852017, 876.6011464783509, 877.3814460805149, 883.9071897450772, 830.0537387378394, 859.7506723050308, 871.7602659268689, 872.2672954718004, 872.5375550957939, 630.8422894276431, 632.629911501772, 646.0632083478974, 647.8250872264509, 648.9415952564292, 10918.945405272923, 11016.724581885437, 11209.663710088711, 11275.154363422776, 11282.605108821233, 8394.034686011126, 8730.912690873074, 8808.251298639623, 8894.199522043047, 9333.806555459461, 7394.075740532434, 7469.626518674045, 7470.962645186739, 7640.73257435987, 7642.7325043623205, 2866.249981294043, 2905.462489439439, 2972.65814431341, 2993.5958645582787, 3077.415291094685, 37480.25039499222, 37512.437313440045, 40538.39192412116, 41920.37119443211, 42237.577624223675, 7901.407394445325, 7950.4832185907735, 8041.597920103972, 8086.636101375452, 8123.918760812435, 17313.56716082108, 17361.30554777795, 17430.12849357527, 17508.912455437643, 17581.472555823344, 5687.7156142192725, 5711.114777209539, 5717.428257174332, 5754.913676294859, 5828.562857785683, 3377.3751855906735, 3448.655134486531, 3458.2563254407587, 3503.089196808848, 3537.9469307960403, 2480.503899220163, 2481.5905375613183, 2492.0405643826894, 2510.0963653084873, 2511.6483692283095, 373.1119934555794, 373.85419686322354, 378.6913665362721, 382.77798876651474, 382.8793929912069, 416.4107787480681, 423.9443784975451, 500.13975961346426, 529.5842763430688, 544.9318835145607, 7007.124109486314, 7083.964580177066, 7245.89131163033, 7249.601271930094, 7288.416926645856, 421.9578042195817, 432.68197874562173, 453.9909201815945, 457.0105721113818, 476.2427739893517, 3271.9836400817844, 3337.4159522084024, 3338.9332213355597, 3356.16095976006, 3388.288459423549, 54133.0, 54712.0, 54946.175807362924, 54987.175192372146, 55208.17187742187, 45361.319580205665, 45534.0, 45660.77169614131, 45894.77052614716, 46282.537174628495, 34431.31137377238, 41361.37957930633, 41836.58163418327, 41965.1606967865, 42002.15995680069, 7171.4621403395995, 7208.783736487913, 7269.41844652416, 7430.851382972202, 7629.961850190713, 31350.52974205343, 31382.058538243888, 31969.36061278715, 32102.0, 32365.35269294648, 43044.78477607592, 43168.0, 44050.0, 44112.7794361039, 44290.557094428645, 5771.942280577308, 5998.820035398945, 6303.873922521616, 6335.714892829741, 6412.871742565029, 10079.798404032024, 10136.746581335525, 10221.843341725906, 10267.281290309906, 10319.845202322122, 9574.281928855504, 9633.518324083627, 9660.468674222986, 9733.561989710339, 9801.803963920824, 9439.52802359893, 9530.618775248913, 9701.652715174952, 9726.416415015121, 9794.706158815246, 9439.858402123837, 9460.2904782143, 9534.761630959281, 9544.284178686488, 9583.377080489747, 8290.0, 8445.493270403795, 8451.366147539082, 8736.170063843925, 8780.429272097294, 7880.211978802303, 8207.876881846658, 8463.830723385621, 8527.914720852712, 8718.564071796513]}, "summary": {"suite": 5948.2717362578705, "subtests": {"jquery.html": {"filtered": 6116.178715806978, "value": 6116.178715806978}, "dojo.html": {"filtered": 4751.031110183364, "value": 4751.031110183364}, "mootools.html": {"filtered": 3857.0076646427183, "value": 3857.0076646427183}, "ext.html": {"filtered": 17244.41940846624, "value": 17244.41940846624}, "prototype.html": {"filtered": 4285.2793973109465, "value": 4285.2793973109465}, "yui.html": {"filtered": 5347.537787373278, "value": 5347.537787373278}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1446806980, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151106004026", "branch": "Mozilla-Aurora", "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418"}}, {"talos_counters": {}, "results": {"audio-dft": [182.0, 190.0, 189.0, 188.0, 179.0, 180.0, 189.0, 188.0, 186.0, 181.0], "ai-astar": [121.0, 121.0, 125.0, 124.0, 125.0, 124.0, 126.0, 127.0, 126.0, 125.0], "imaging-gaussian-blur": [141.0, 142.0, 132.0, 129.0, 142.0, 135.0, 140.0, 129.0, 141.0, 142.0], "audio-beat-detection": [170.0, 153.0, 186.0, 175.0, 148.0, 171.0, 146.0, 182.0, 170.0, 148.0], "json-stringify-tinderbox": [71.0, 72.0, 72.0, 76.0, 75.0, 77.0, 77.0, 77.0, 77.0, 74.0], "stanford-crypto-pbkdf2": [160.0, 172.0, 169.0, 167.0, 170.0, 159.0, 161.0, 167.0, 167.0, 167.0], "json-parse-financial": [60.0, 70.0, 69.0, 72.0, 73.0, 72.0, 72.0, 82.0, 67.0, 68.0], "stanford-crypto-sha256-iterative": [73.0, 77.0, 77.0, 80.0, 82.0, 81.0, 81.0, 81.0, 80.0, 82.0], "audio-fft": [88.0, 87.0, 99.0, 141.0, 78.0, 81.0, 83.0, 82.0, 138.0, 76.0], "imaging-darkroom": [140.0, 146.0, 148.0, 146.0, 141.0, 147.0, 147.0, 147.0, 144.0, 140.0], "stanford-crypto-ccm": [140.0, 151.0, 142.0, 138.0, 153.0, 154.0, 140.0, 150.0, 144.0, 140.0], "audio-oscillator": [107.0, 108.0, 157.0, 104.0, 104.0, 107.0, 146.0, 103.0, 101.0, 146.0], "stanford-crypto-aes": [91.0, 95.0, 96.0, 96.0, 95.0, 94.0, 94.0, 96.0, 96.0, 100.0], "imaging-desaturate": [116.0, 115.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0, 118.0, 116.0]}, "summary": {"suite": 1718.6000000000001, "subtests": {"audio-fft": {"filtered": 95.3, "value": 95.3}, "stanford-crypto-pbkdf2": {"filtered": 165.9, "value": 165.9}, "audio-beat-detection": {"filtered": 164.9, "value": 164.9}, "stanford-crypto-ccm": {"filtered": 145.2, "value": 145.2}, "imaging-darkroom": {"filtered": 144.6, "value": 144.6}, "json-parse-financial": {"filtered": 70.5, "value": 70.5}, "audio-oscillator": {"filtered": 118.3, "value": 118.3}, "ai-astar": {"filtered": 124.4, "value": 124.4}, "audio-dft": {"filtered": 185.2, "value": 185.2}, "stanford-crypto-sha256-iterative": {"filtered": 79.4, "value": 79.4}, "json-stringify-tinderbox": {"filtered": 74.8, "value": 74.8}, "imaging-gaussian-blur": {"filtered": 137.3, "value": 137.3}, "stanford-crypto-aes": {"filtered": 95.3, "value": 95.3}, "imaging-desaturate": {"filtered": 117.5, "value": 117.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1446806980, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151106004026", "branch": "Mozilla-Aurora", "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418"}}, {"talos_counters": {}, "results": {"DeltaBlue": [217.58050478677112], "Encrypt": [361.794500723589], "NavierStokes": [6611.8421052631575], "Decrypt": [6890.41095890411], "Splay": [663.7988087359365], "Richards": [187.44142455482663], "RegExp": [33290.32258064516], "Earley": [788.6435331230284], "Boyer": [14013.888888888889], "RayTrace": [1156.0693641618498]}, "summary": {"suite": 17870.900437526114, "subtests": {"DeltaBlue": {"filtered": 303.87832800000007, "value": 303.87832800000007}, "Encrypt": {"filtered": 735.7242839999999, "value": 735.7242839999999}, "NavierStokes": {"filtered": 224.44577114427852, "value": 224.44577114427852}, "Decrypt": {"filtered": 38.63064214711727, "value": 38.63064214711727}, "Splay": {"filtered": 122.76460717846462, "value": 122.76460717846462}, "RegExp": {"filtered": 27.364859496124026, "value": 27.364859496124026}, "Richards": {"filtered": 188.33616999999992, "value": 188.33616999999992}, "Earley": {"filtered": 845.075084, "value": 845.075084}, "Boyer": {"filtered": 47.557320118929674, "value": 47.557320118929674}, "RayTrace": {"filtered": 640.0904850000001, "value": 640.0904850000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1446806980, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151106004026", "branch": "Mozilla-Aurora", "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418"}}] 03:09:57 INFO - RETURN: dromaeo_css: 5948.27 03:09:57 INFO - RETURN: kraken: 1718.60 03:09:57 INFO - RETURN: v8_7: 17870.90 03:09:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17870.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1718.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5948.27"}}} 03:09:57 INFO - Return code: 0 03:09:57 INFO - # TBPL SUCCESS # 03:09:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:57 INFO - 2015-11-06 03:09:57.327 screenresolution[1662:10094] starting screenresolution argv=screenresolution get 03:09:57 INFO - 2015-11-06 03:09:57.330 screenresolution[1662:10094] Display 0: 1600x1200x32@60 03:09:57 INFO - 2015-11-06 03:09:57.336 screenresolution[1663:10097] starting screenresolution argv=screenresolution list 03:09:57 INFO - Available Modes on Display 0 03:09:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:57 INFO - Intel HD Graphics 3000: 03:09:57 INFO - Chipset Model: Intel HD Graphics 3000 03:09:57 INFO - Type: GPU 03:09:57 INFO - Bus: Built-In 03:09:57 INFO - VRAM (Total): 512 MB 03:09:57 INFO - VRAM (Dynamic, Max): 10 03:09:57 INFO - Vendor: Intel (0x8086) 03:09:57 INFO - Device ID: 0x0116 03:09:57 INFO - Revision ID: 0x0009 03:09:57 INFO - Displays: 03:09:57 INFO - Display: 03:09:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:57 INFO - Display Serial Number: 1600x1200 60 03:09:57 INFO - Main Display: Yes 03:09:57 INFO - Mirror: Off 03:09:57 INFO - Online: Yes 03:09:57 INFO - Rotation: Supported 03:09:57 INFO - Return code: 0 03:09:57 INFO - Running post-action listener: _resource_record_post_action 03:09:57 INFO - Running post-run listener: _resource_record_post_run 03:09:58 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 37491712; Write bytes: 687199232; Read time: 4046; Write time: 67044 03:09:58 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 335530496; Write bytes: 333752320; Read time: 35264; Write time: 7742 03:09:58 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 36606976; Write bytes: 341971968; Read time: 3810; Write time: 58700 03:09:58 INFO - Running post-run listener: _upload_blobber_files 03:09:58 INFO - Blob upload gear active. 03:09:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:09:58 INFO - Copying logs to upload dir... 03:09:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1348.916575 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2015-11-06 03:09:58.761748) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 03:09:58.765834) ========= 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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010012 build_url: 'https://queue.taskcluster.net/v1/task/ovkziTzuQBSBkaGCLimstA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 03:09:58.792847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 03:09:58.793278) ========= 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.bbMRqlBUF6/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.ebBtlJUg6P/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.005518 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 03:09:58.843461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 03:09:58.843877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 03:09:58.844354) ========= ========= Total master_lag: 0.72 =========