builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0105 starttime: 1446766257.94 results: success (0) buildid: 20151105140759 builduid: 6dcd9a676e49421eacb42cbe957af806 revision: e2c16a69c24a6eb733663b7ac874bdac7b376418 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.941519) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.942056) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.942407) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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.006594 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.967808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.970441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.987145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:57.987575) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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.005618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.037922) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.038289) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.038703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.039012) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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-05 15:30:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-05 15:30:58 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188435 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.282804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.283153) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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.021880 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.321346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.321719) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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-05 15:30:58,399 truncating revision to first 12 chars 2015-11-05 15:30:58,400 Setting DEBUG logging. 2015-11-05 15:30:58,400 attempt 1/10 2015-11-05 15:30:58,400 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-05 15:30:58,705 unpacking tar archive at: mozilla-aurora-e2c16a69c24a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.915028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.915431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.931065) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.931540) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 15:30:58.932058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-11-05 15:30:58.932455) ========= /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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:30:59 INFO - MultiFileLogger online at 20151105 15:30:59 in /builds/slave/test 15:30:59 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 15:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:59 INFO - {'append_to_log': False, 15:30:59 INFO - 'base_work_dir': '/builds/slave/test', 15:30:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:59 INFO - 'branch': 'Mozilla-Aurora', 15:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:59 INFO - 'config_files': ('talos/mac_config.py',), 15:30:59 INFO - 'default_actions': ('clobber', 15:30:59 INFO - 'read-buildbot-config', 15:30:59 INFO - 'download-and-extract', 15:30:59 INFO - 'populate-webroot', 15:30:59 INFO - 'create-virtualenv', 15:30:59 INFO - 'install', 15:30:59 INFO - 'run-tests'), 15:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:59 INFO - 'download_minidump_stackwalk': True, 15:30:59 INFO - 'download_symbols': 'ondemand', 15:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:59 INFO - 'installer_path': 'installer.exe', 15:30:59 INFO - 'log_level': 'info', 15:30:59 INFO - 'log_name': 'talos', 15:30:59 INFO - 'log_to_console': True, 15:30:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:30:59 INFO - 'opt_config_files': (), 15:30:59 INFO - 'pip_index': False, 15:30:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:59 INFO - 'cmd': ('bash', 15:30:59 INFO - '-c', 15:30:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:59 INFO - 'enabled': True, 15:30:59 INFO - 'halt_on_failure': False, 15:30:59 INFO - 'name': 'check_screen_resolution'},), 15:30:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:59 INFO - 'cmd': ('bash', 15:30:59 INFO - '-c', 15:30:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:59 INFO - 'enabled': True, 15:30:59 INFO - 'halt_on_failure': False, 15:30:59 INFO - 'name': 'check_screen_resolution'},), 15:30:59 INFO - 'run_cmd_checks_enabled': True, 15:30:59 INFO - 'sps_profile': False, 15:30:59 INFO - 'sps_profile_interval': 0, 15:30:59 INFO - 'suite': 'dromaeojs', 15:30:59 INFO - 'system_bits': '64', 15:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:59 INFO - 'title': 't-yosemite-r5-0105', 15:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:59 INFO - 'use_talos_json': True, 15:30:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:59 INFO - 'work_dir': 'build'} 15:30:59 INFO - ##### 15:30:59 INFO - ##### Running clobber step. 15:30:59 INFO - ##### 15:30:59 INFO - Running pre-action listener: _resource_record_pre_action 15:30:59 INFO - Running main action method: clobber 15:30:59 INFO - rmtree: /builds/slave/test/build 15:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:01 INFO - Running post-action listener: _resource_record_post_action 15:31:01 INFO - ##### 15:31:01 INFO - ##### Running read-buildbot-config step. 15:31:01 INFO - ##### 15:31:01 INFO - Running pre-action listener: _resource_record_pre_action 15:31:01 INFO - Running main action method: read_buildbot_config 15:31:01 INFO - Using buildbot properties: 15:31:01 INFO - { 15:31:01 INFO - "properties": { 15:31:01 INFO - "buildnumber": 409, 15:31:01 INFO - "product": "firefox", 15:31:01 INFO - "script_repo_revision": "production", 15:31:01 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 15:31:01 INFO - "repository": "", 15:31:01 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 15:31:01 INFO - "buildid": "20151105140759", 15:31:01 INFO - "slavename": "t-yosemite-r5-0105", 15:31:01 INFO - "pgo_build": "False", 15:31:01 INFO - "basedir": "/builds/slave/test", 15:31:01 INFO - "project": "", 15:31:01 INFO - "platform": "yosemite", 15:31:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:31:01 INFO - "slavebuilddir": "test", 15:31:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:31:01 INFO - "branch": "mozilla-aurora", 15:31:01 INFO - "repo_path": "releases/mozilla-aurora", 15:31:01 INFO - "stage_platform": "macosx64", 15:31:01 INFO - "builduid": "6dcd9a676e49421eacb42cbe957af806", 15:31:01 INFO - "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418" 15:31:01 INFO - }, 15:31:01 INFO - "sourcestamp": { 15:31:01 INFO - "repository": "", 15:31:01 INFO - "hasPatch": false, 15:31:01 INFO - "project": "", 15:31:01 INFO - "branch": "mozilla-aurora-macosx64-talos", 15:31:01 INFO - "changes": [ 15:31:01 INFO - { 15:31:01 INFO - "category": null, 15:31:01 INFO - "files": [ 15:31:01 INFO - { 15:31:01 INFO - "url": null, 15:31:01 INFO - "name": "https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 15:31:01 INFO - } 15:31:01 INFO - ], 15:31:01 INFO - "repository": "", 15:31:01 INFO - "rev": "e2c16a69c24a6eb733663b7ac874bdac7b376418", 15:31:01 INFO - "who": "ryanvm@gmail.com", 15:31:01 INFO - "when": 1446766213, 15:31:01 INFO - "number": 6627255, 15:31:01 INFO - "comments": "No bug - Tweak assertion annotation for font-inflation-762332.html under e10s. a=test-only", 15:31:01 INFO - "project": "", 15:31:01 INFO - "at": "Thu 05 Nov 2015 15:30:13", 15:31:01 INFO - "branch": "mozilla-aurora-macosx64-talos", 15:31:01 INFO - "revlink": "", 15:31:01 INFO - "properties": [ 15:31:01 INFO - [ 15:31:01 INFO - "buildid", 15:31:01 INFO - "20151105140759", 15:31:01 INFO - "Change" 15:31:01 INFO - ], 15:31:01 INFO - [ 15:31:01 INFO - "builduid", 15:31:01 INFO - "6dcd9a676e49421eacb42cbe957af806", 15:31:01 INFO - "Change" 15:31:01 INFO - ], 15:31:01 INFO - [ 15:31:01 INFO - "pgo_build", 15:31:01 INFO - "False", 15:31:01 INFO - "Change" 15:31:01 INFO - ] 15:31:01 INFO - ], 15:31:01 INFO - "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418" 15:31:01 INFO - } 15:31:01 INFO - ], 15:31:01 INFO - "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418" 15:31:01 INFO - } 15:31:01 INFO - } 15:31:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 15:31:01 INFO - Running post-action listener: _resource_record_post_action 15:31:01 INFO - ##### 15:31:01 INFO - ##### Running download-and-extract step. 15:31:01 INFO - ##### 15:31:01 INFO - Running pre-action listener: _resource_record_pre_action 15:31:01 INFO - Running main action method: download_and_extract 15:31:01 INFO - mkdir: /builds/slave/test/build/tests 15:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:01 INFO - https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/test_packages.json 15:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/test_packages.json 15:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:31:02 INFO - Downloaded 1149 bytes. 15:31:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:31:02 INFO - Using the following test package requirements: 15:31:02 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:31:02 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 15:31:02 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'jsshell-mac.zip'], 15:31:02 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 15:31:02 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:31:02 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 15:31:02 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 15:31:02 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 15:31:02 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:31:02 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:31:02 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 15:31:02 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:02 INFO - https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:03 INFO - Downloaded 17445953 bytes. 15:31:03 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 15:31:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:31:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 15:31:09 INFO - Return code: 0 15:31:09 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 15:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:09 INFO - https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:10 INFO - Downloaded 17445953 bytes. 15:31:10 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 15:31:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:31:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 15:31:16 INFO - Return code: 0 15:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:16 INFO - https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 15:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 15:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:17 INFO - Downloaded 11131307 bytes. 15:31:17 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 15:31:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 15:31:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:31:17 INFO - Return code: 0 15:31:17 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')]} 15:31:17 INFO - https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 15:31:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:31:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:31:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 15:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:21 INFO - Downloaded 107721159 bytes. 15:31:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:31:21 INFO - mkdir: /builds/slave/test/properties 15:31:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:21 INFO - Contents: 15:31:21 INFO - build_url:https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:31:21 INFO - Running post-action listener: _resource_record_post_action 15:31:21 INFO - Running post-action listener: set_extra_try_arguments 15:31:21 INFO - ##### 15:31:21 INFO - ##### Running populate-webroot step. 15:31:21 INFO - ##### 15:31:21 INFO - Running pre-action listener: _resource_record_pre_action 15:31:21 INFO - Running main action method: populate_webroot 15:31:21 INFO - Guessing talos json url... 15:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:21 INFO - https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 15:31:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 15:31:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 15:31:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 15:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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 15:31:22 INFO - Downloaded 107 bytes. 15:31:22 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 15:31:22 INFO - Contents: 15:31:22 INFO - 20151105140759 15:31:22 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/e2c16a69c24a6eb733663b7ac874bdac7b376418 15:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:22 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2c16a69c2/testing/talos/talos.json 15:31:22 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2c16a69c2/testing/talos/talos.json to /builds/slave/test/build/talos.json 15:31:22 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 15:31:22 INFO - Downloaded 4264 bytes. 15:31:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:31:22 INFO - '../fennec_ids.txt'], 15:31:22 INFO - 'tests': ['tcheck2']}, 15:31:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:22 INFO - '--tppagecycles', 15:31:22 INFO - '7'], 15:31:22 INFO - 'tests': ['tsvgm']}}, 15:31:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:31:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:31:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:31:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'tests': ['damp', 'tps']}, 15:31:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['damp', 'tps']}, 15:31:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:31:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:22 INFO - 'other': {'tests': ['a11yr', 15:31:22 INFO - 'ts_paint', 15:31:22 INFO - 'tpaint', 15:31:22 INFO - 'sessionrestore', 15:31:22 INFO - 'sessionrestore_no_auto_restore']}, 15:31:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['a11yr', 15:31:22 INFO - 'ts_paint', 15:31:22 INFO - 'tpaint', 15:31:22 INFO - 'sessionrestore', 15:31:22 INFO - 'sessionrestore_no_auto_restore']}, 15:31:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['a11yr', 15:31:22 INFO - 'ts_paint', 15:31:22 INFO - 'tpaint', 15:31:22 INFO - 'sessionrestore', 15:31:22 INFO - 'sessionrestore_no_auto_restore']}, 15:31:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['a11yr', 15:31:22 INFO - 'ts_paint', 15:31:22 INFO - 'tpaint', 15:31:22 INFO - 'sessionrestore', 15:31:22 INFO - 'sessionrestore_no_auto_restore']}, 15:31:22 INFO - 'other_l64': {'tests': ['a11yr', 15:31:22 INFO - 'ts_paint', 15:31:22 INFO - 'tpaint', 15:31:22 INFO - 'sessionrestore', 15:31:22 INFO - 'sessionrestore_no_auto_restore']}, 15:31:22 INFO - 'other_nol64': {'tests': ['a11yr', 15:31:22 INFO - 'ts_paint', 15:31:22 INFO - 'tpaint', 15:31:22 INFO - 'sessionrestore', 15:31:22 INFO - 'sessionrestore_no_auto_restore']}, 15:31:22 INFO - 'svgr': {'tests': ['tsvgx', 15:31:22 INFO - 'tsvgr_opacity', 15:31:22 INFO - 'tart', 15:31:22 INFO - 'tscrollx', 15:31:22 INFO - 'cart']}, 15:31:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['tsvgx', 15:31:22 INFO - 'tsvgr_opacity', 15:31:22 INFO - 'tart', 15:31:22 INFO - 'tscrollx', 15:31:22 INFO - 'cart']}, 15:31:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'tests': ['tp5o']}, 15:31:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'talos_options': ['--e10s'], 15:31:22 INFO - 'tests': ['tp5o']}, 15:31:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'talos_options': ['--xperf_path', 15:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:22 INFO - 'tests': ['tp5n']}, 15:31:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:22 INFO - 'talos_options': ['--e10s', 15:31:22 INFO - '--xperf_path', 15:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 15:31:22 INFO - 'C:/slave/talos-data/talos/xperf.config'], 15:31:22 INFO - 'tests': ['tp5n']}}, 15:31:22 INFO - 'talos.zip': {'path': '', 15:31:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - ##### 15:31:22 INFO - ##### Running create-virtualenv step. 15:31:22 INFO - ##### 15:31:22 INFO - Running pre-action listener: _resource_record_pre_action 15:31:22 INFO - Running main action method: create_virtualenv 15:31:22 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:22 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 15:31:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:22 INFO - Using real prefix '/tools/python27' 15:31:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:27 INFO - Installing pip.................done. 15:31:27 INFO - Return code: 0 15:31:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:27 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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:27 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 15:31:27 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 15:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:27 INFO - 'HOME': '/Users/cltbld', 15:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:27 INFO - 'LOGNAME': 'cltbld', 15:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:27 INFO - 'MOZ_NO_REMOTE': '1', 15:31:27 INFO - 'NO_EM_RESTART': '1', 15:31:27 INFO - 'PAGER': '/bin/cat', 15:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:27 INFO - 'PWD': '/builds/slave/test', 15:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:27 INFO - 'SHELL': '/bin/bash', 15:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:27 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:27 INFO - 'USER': 'cltbld', 15:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:27 INFO - 'XPC_FLAGS': '0x0', 15:31:27 INFO - 'XPC_SERVICE_NAME': '0', 15:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:27 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 15:31:27 INFO - Cleaning up... 15:31:27 INFO - Return code: 0 15:31:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:27 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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:27 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 15:31:27 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 15:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:27 INFO - 'HOME': '/Users/cltbld', 15:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:27 INFO - 'LOGNAME': 'cltbld', 15:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:27 INFO - 'MOZ_NO_REMOTE': '1', 15:31:27 INFO - 'NO_EM_RESTART': '1', 15:31:27 INFO - 'PAGER': '/bin/cat', 15:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:27 INFO - 'PWD': '/builds/slave/test', 15:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:27 INFO - 'SHELL': '/bin/bash', 15:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:27 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:27 INFO - 'USER': 'cltbld', 15:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:27 INFO - 'XPC_FLAGS': '0x0', 15:31:27 INFO - 'XPC_SERVICE_NAME': '0', 15:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:27 INFO - Downloading/unpacking psutil>=0.7.1 15:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:31:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:30 INFO - Installing collected packages: psutil 15:31:30 INFO - Running setup.py install for psutil 15:31:30 INFO - building 'psutil._psutil_osx' extension 15:31:30 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 15:31:31 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 15:31:31 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 15:31:31 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 15:31:31 INFO - building 'psutil._psutil_posix' extension 15:31:31 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 15:31:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:31:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:31:31 INFO - ^ 15:31:31 INFO - 1 warning generated. 15:31:31 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 15:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:31 INFO - Successfully installed psutil 15:31:31 INFO - Cleaning up... 15:31:31 INFO - Return code: 0 15:31:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:31:31 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')]} 15:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:31 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')]} 15:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:31 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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:31 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 15:31:31 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 15:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:31 INFO - 'HOME': '/Users/cltbld', 15:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:31 INFO - 'LOGNAME': 'cltbld', 15:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:31 INFO - 'MOZ_NO_REMOTE': '1', 15:31:31 INFO - 'NO_EM_RESTART': '1', 15:31:31 INFO - 'PAGER': '/bin/cat', 15:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:31 INFO - 'PWD': '/builds/slave/test', 15:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:31 INFO - 'SHELL': '/bin/bash', 15:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:31 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:31 INFO - 'USER': 'cltbld', 15:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:31 INFO - 'XPC_FLAGS': '0x0', 15:31:31 INFO - 'XPC_SERVICE_NAME': '0', 15:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:31:32 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 15:31:32 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 15:31:32 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 15:31:32 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 15:31:32 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 15:31:32 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 15:31:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:31:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:31:35 INFO - Installing collected packages: mozsystemmonitor 15:31:35 INFO - Running setup.py install for mozsystemmonitor 15:31:35 INFO - Successfully installed mozsystemmonitor 15:31:35 INFO - Cleaning up... 15:31:35 INFO - Return code: 0 15:31:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:35 INFO - 'HOME': '/Users/cltbld', 15:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:35 INFO - 'LOGNAME': 'cltbld', 15:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:35 INFO - 'MOZ_NO_REMOTE': '1', 15:31:35 INFO - 'NO_EM_RESTART': '1', 15:31:35 INFO - 'PAGER': '/bin/cat', 15:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:35 INFO - 'PWD': '/builds/slave/test', 15:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:35 INFO - 'SHELL': '/bin/bash', 15:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:35 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:35 INFO - 'USER': 'cltbld', 15:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:35 INFO - 'XPC_FLAGS': '0x0', 15:31:35 INFO - 'XPC_SERVICE_NAME': '0', 15:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 INFO - Downloading docopt-0.6.1.tar.gz 15:31:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:39 INFO - Running setup.py install for blobuploader 15:31:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:39 INFO - Running setup.py install for requests 15:31:40 INFO - Running setup.py install for docopt 15:31:40 INFO - Successfully installed blobuploader requests docopt 15:31:40 INFO - Cleaning up... 15:31:40 INFO - Return code: 0 15:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:40 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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:40 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 15:31:40 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 15:31:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:40 INFO - 'HOME': '/Users/cltbld', 15:31:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:40 INFO - 'LOGNAME': 'cltbld', 15:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:40 INFO - 'MOZ_NO_REMOTE': '1', 15:31:40 INFO - 'NO_EM_RESTART': '1', 15:31:40 INFO - 'PAGER': '/bin/cat', 15:31:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:40 INFO - 'PWD': '/builds/slave/test', 15:31:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:40 INFO - 'SHELL': '/bin/bash', 15:31:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:40 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:40 INFO - 'USER': 'cltbld', 15:31:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:40 INFO - 'XPC_FLAGS': '0x0', 15:31:40 INFO - 'XPC_SERVICE_NAME': '0', 15:31:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-PhZjZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-HfplQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-VPUJuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-iYkioq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-qwBAhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-YTcASZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:41 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-0IT56u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-fl8ZjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-zZp68T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-sHCwGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Wmk6QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-WD3ygO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-HD3R3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:42 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-6p11jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:43 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-okl05_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:43 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-JVCuk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:43 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-NAz9iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:43 INFO - Running setup.py install for manifestparser 15:31:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozcrash 15:31:43 INFO - Running setup.py install for mozdebug 15:31:44 INFO - Running setup.py install for mozdevice 15:31:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozfile 15:31:44 INFO - Running setup.py install for mozhttpd 15:31:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozinfo 15:31:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozInstall 15:31:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozleak 15:31:45 INFO - Running setup.py install for mozlog 15:31:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Running setup.py install for moznetwork 15:31:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Running setup.py install for mozprocess 15:31:45 INFO - Running setup.py install for mozprofile 15:31:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Running setup.py install for mozrunner 15:31:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:46 INFO - Running setup.py install for mozscreenshot 15:31:46 INFO - Running setup.py install for moztest 15:31:46 INFO - Running setup.py install for mozversion 15:31:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:46 INFO - Cleaning up... 15:31:46 INFO - Return code: 0 15:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:46 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 15:31:46 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 15:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:46 INFO - 'HOME': '/Users/cltbld', 15:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:46 INFO - 'LOGNAME': 'cltbld', 15:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:46 INFO - 'MOZ_NO_REMOTE': '1', 15:31:46 INFO - 'NO_EM_RESTART': '1', 15:31:46 INFO - 'PAGER': '/bin/cat', 15:31:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:46 INFO - 'PWD': '/builds/slave/test', 15:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:46 INFO - 'SHELL': '/bin/bash', 15:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:46 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:46 INFO - 'USER': 'cltbld', 15:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:46 INFO - 'XPC_FLAGS': '0x0', 15:31:46 INFO - 'XPC_SERVICE_NAME': '0', 15:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-eld7L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-hzdbrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-hHdBTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-xJIejr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-CrpmqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-R3UOTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:47 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-NXy3kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-SR4TSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-JRdSlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-iQ8MXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-NRl5z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Up8HrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-vhq9m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:48 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)) 15:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:48 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-l3E6pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:49 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)) 15:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Q72tz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:49 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)) 15:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-8DDTUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:49 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)) 15:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:49 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-UPTHLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:49 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)) 15:31:49 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)) 15:31:49 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)) 15:31:49 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)) 15:31:49 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)) 15:31:49 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)) 15:31:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:49 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 15:31:49 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 15:31:49 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 15:31:49 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 15:31:49 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 15:31:49 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 15:31:52 INFO - Downloading blessings-1.5.1.tar.gz 15:31:52 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 15:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:52 INFO - Installing collected packages: blessings 15:31:52 INFO - Running setup.py install for blessings 15:31:52 INFO - Successfully installed blessings 15:31:52 INFO - Cleaning up... 15:31:52 INFO - Return code: 0 15:31:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:52 INFO - Reading from file tmpfile_stdout 15:31:52 INFO - Current package versions: 15:31:52 INFO - blessings == 1.5.1 15:31:52 INFO - blobuploader == 1.2.4 15:31:52 INFO - docopt == 0.6.1 15:31:52 INFO - manifestparser == 1.1 15:31:52 INFO - mozInstall == 1.12 15:31:52 INFO - mozcrash == 0.16 15:31:52 INFO - mozdebug == 0.1 15:31:52 INFO - mozdevice == 0.46 15:31:52 INFO - mozfile == 1.2 15:31:52 INFO - mozhttpd == 0.7 15:31:52 INFO - mozinfo == 0.8 15:31:52 INFO - mozleak == 0.1 15:31:52 INFO - mozlog == 3.0 15:31:52 INFO - moznetwork == 0.27 15:31:52 INFO - mozprocess == 0.22 15:31:52 INFO - mozprofile == 0.27 15:31:52 INFO - mozrunner == 6.11 15:31:52 INFO - mozscreenshot == 0.1 15:31:52 INFO - mozsystemmonitor == 0.0 15:31:52 INFO - moztest == 0.7 15:31:52 INFO - mozversion == 1.4 15:31:52 INFO - psutil == 3.1.1 15:31:52 INFO - requests == 1.2.3 15:31:52 INFO - wsgiref == 0.1.2 15:31:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:52 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')]} 15:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:52 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')]} 15:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:52 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 0x10d7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d83f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d2a760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, '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.sWSyQBNiZ2/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.5e9ZsthKct/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 15:31:52 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 15:31:52 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 15:31:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:31:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:52 INFO - 'HOME': '/Users/cltbld', 15:31:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:52 INFO - 'LOGNAME': 'cltbld', 15:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:52 INFO - 'MOZ_NO_REMOTE': '1', 15:31:52 INFO - 'NO_EM_RESTART': '1', 15:31:52 INFO - 'PAGER': '/bin/cat', 15:31:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:52 INFO - 'PWD': '/builds/slave/test', 15:31:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:52 INFO - 'SHELL': '/bin/bash', 15:31:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:31:52 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:31:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:52 INFO - 'USER': 'cltbld', 15:31:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:52 INFO - 'XPC_FLAGS': '0x0', 15:31:52 INFO - 'XPC_SERVICE_NAME': '0', 15:31:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 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)) 15:31:53 INFO - Cleaning up... 15:31:53 INFO - Return code: 0 15:31:53 INFO - Running post-action listener: _resource_record_post_action 15:31:53 INFO - Running post-action listener: _start_resource_monitoring 15:31:53 INFO - Starting resource monitoring. 15:31:53 INFO - ##### 15:31:53 INFO - ##### Running install step. 15:31:53 INFO - ##### 15:31:53 INFO - Running pre-action listener: _resource_record_pre_action 15:31:53 INFO - Running main action method: install 15:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:53 INFO - Reading from file tmpfile_stdout 15:31:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:53 INFO - Reading from file tmpfile_stdout 15:31:53 INFO - Output received: 15:31:53 INFO - Usage: mozinstall [options] installer 15:31:53 INFO - Options: 15:31:53 INFO - -h, --help show this help message and exit 15:31:53 INFO - -d DEST, --destination=DEST 15:31:53 INFO - Directory to install application into. [default: 15:31:53 INFO - "/builds/slave/test"] 15:31:53 INFO - --app=APP Application being installed. [default: firefox] 15:31:53 INFO - mkdir: /builds/slave/test/build/application 15:31:53 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'] 15:31:53 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 15:32:34 INFO - Reading from file tmpfile_stdout 15:32:34 INFO - Output received: 15:32:34 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:32:34 INFO - Running post-action listener: _resource_record_post_action 15:32:34 INFO - ##### 15:32:34 INFO - ##### Running run-tests step. 15:32:34 INFO - ##### 15:32:34 INFO - Running pre-action listener: _resource_record_pre_action 15:32:34 INFO - Running main action method: run_tests 15:32:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:32:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:32:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:32:34 INFO - 2015-11-05 15:32:34.842 screenresolution[2193:13789] starting screenresolution argv=screenresolution get 15:32:34 INFO - 2015-11-05 15:32:34.846 screenresolution[2193:13789] Display 0: 1600x1200x32@60 15:32:34 INFO - 2015-11-05 15:32:34.853 screenresolution[2194:13791] starting screenresolution argv=screenresolution list 15:32:34 INFO - Available Modes on Display 0 15:32:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:32:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:32:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:32:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:32:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:32:35 INFO - Intel HD Graphics 3000: 15:32:35 INFO - Chipset Model: Intel HD Graphics 3000 15:32:35 INFO - Type: GPU 15:32:35 INFO - Bus: Built-In 15:32:35 INFO - VRAM (Total): 512 MB 15:32:35 INFO - VRAM (Dynamic, Max): 10 15:32:35 INFO - Vendor: Intel (0x8086) 15:32:35 INFO - Device ID: 0x0116 15:32:35 INFO - Revision ID: 0x0009 15:32:35 INFO - Displays: 15:32:35 INFO - Display: 15:32:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:32:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:32:35 INFO - Display Serial Number: 1600x1200 60 15:32:35 INFO - Main Display: Yes 15:32:35 INFO - Mirror: Off 15:32:35 INFO - Online: Yes 15:32:35 INFO - Rotation: Supported 15:32:35 INFO - Return code: 0 15:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:35 INFO - Python 2.7.3 15:32:35 INFO - Return code: 0 15:32:35 INFO - grabbing minidump binary from tooltool 15:32: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')]} 15:32:35 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 0x10d7879f0>, '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 0x10d4e6cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d751990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:35 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 15:32:35 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 15:32:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:35 INFO - Return code: 0 15:32:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:32:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:32:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:35 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/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0105', '--webServer', 'localhost'] in /builds/slave/test/build 15:32:35 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/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0105 --webServer localhost 15:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWSyQBNiZ2/Render', 15:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:35 INFO - 'HOME': '/Users/cltbld', 15:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:35 INFO - 'LOGNAME': 'cltbld', 15:32:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:35 INFO - 'MOZ_NO_REMOTE': '1', 15:32:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:35 INFO - 'NO_EM_RESTART': '1', 15:32:35 INFO - 'PAGER': '/bin/cat', 15:32:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:35 INFO - 'PWD': '/builds/slave/test', 15:32:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:35 INFO - 'SHELL': '/bin/bash', 15:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e9ZsthKct/Listeners', 15:32:35 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:35 INFO - 'USER': 'cltbld', 15:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:35 INFO - 'XPC_FLAGS': '0x0', 15:32:35 INFO - 'XPC_SERVICE_NAME': '0', 15:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:32:35 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/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0105', '--webServer', 'localhost'] with output_timeout 3600 15:32:35 INFO - mozversion INFO | application_buildid: 20151105140759 15:32:35 INFO - mozversion INFO | application_changeset: e2c16a69c24a6eb733663b7ac874bdac7b376418 15:32:35 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 15:32:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:35 INFO - mozversion INFO | application_name: Firefox 15:32:35 INFO - mozversion INFO | application_remotingname: firefox-dev 15:32:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:32:35 INFO - mozversion INFO | application_vendor: Mozilla 15:32:35 INFO - mozversion INFO | application_version: 44.0a2 15:32:35 INFO - mozversion INFO | platform_buildid: 20151105140759 15:32:35 INFO - mozversion INFO | platform_changeset: e2c16a69c24a6eb733663b7ac874bdac7b376418 15:32:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:32:35 INFO - mozversion INFO | platform_version: 44.0a2 15:32:35 INFO - 2015-11-05 15:32:35,514 DEBUG : using testdate: 1446766355 15:32:35 INFO - 2015-11-05 15:32:35,514 DEBUG : actual date: 1446766355 15:32:35 INFO - 2015-11-05 15:32:35,563 INFO : starting webserver on 'localhost:49755' 15:32:35 INFO - 2015-11-05 15:32:35,564 INFO : Starting test suite t-yosemite-r5-0105 15:32:35 INFO - 2015-11-05 15:32:35,564 INFO : Starting test dromaeo_css 15:32:35 INFO - 2015-11-05 15:32:35,564 DEBUG : operating with platform_type : mac_ 15:32:35 INFO - 2015-11-05 15:32:35,565 INFO : Initialising browser for dromaeo_css test... 15:32:35 INFO - 2015-11-05 15:32:35,589 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpIpCDA7/profile http://localhost:49755/getInfo.html 15:32:38 INFO - 2015-11-05 15:32:38,126 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:32:38 INFO - 2015-11-05 15:32:38,127 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:32:38 INFO - 2015-11-05 15:32:38,127 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:32:38 INFO - 2015-11-05 15:32:38,127 DEBUG : BROWSER_OUTPUT: __metrics 15:32:38 INFO - 2015-11-05 15:32:38,143 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:32:38 INFO - 2015-11-05 15:32:38,938 INFO : Browser initialized. 15:32:38 INFO - 2015-11-05 15:32:38,938 INFO : Running cycle 1/1 for dromaeo_css test... 15:32:38 INFO - 2015-11-05 15:32:38,938 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpIpCDA7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:32:51 INFO - 2015-11-05 15:32:51,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 199999488 15:32:51 INFO - 2015-11-05 15:32:51,044 DEBUG : BROWSER_OUTPUT: 15:33:42 INFO - 2015-11-05 15:33:42,711 DEBUG : BROWSER_OUTPUT: 1446766422702 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] 15:35:53 INFO - 2015-11-05 15:35:53,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49755/tests/dromaeo/cssquery-ext.html) 15:35:54 INFO - 2015-11-05 15:35:54,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 318656512 15:35:54 INFO - 2015-11-05 15:35:54,826 DEBUG : BROWSER_OUTPUT: 15:38:57 INFO - 2015-11-05 15:38:57,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-ext.html (next: http://localhost:49755/tests/dromaeo/cssquery-jquery.html) 15:38:58 INFO - 2015-11-05 15:38:58,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 341647360 15:38:58 INFO - 2015-11-05 15:38:58,260 DEBUG : BROWSER_OUTPUT: 15:42:00 INFO - 2015-11-05 15:42:00,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49755/tests/dromaeo/cssquery-mootools.html) 15:42:01 INFO - 2015-11-05 15:42:01,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 305541120 15:42:01 INFO - 2015-11-05 15:42:01,107 DEBUG : BROWSER_OUTPUT: 15:45:03 INFO - 2015-11-05 15:45:03,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49755/tests/dromaeo/cssquery-prototype.html) 15:45:03 INFO - 2015-11-05 15:45:03,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 300822528 15:45:03 INFO - 2015-11-05 15:45:03,739 DEBUG : BROWSER_OUTPUT: 15:48:06 INFO - 2015-11-05 15:48:06,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49755/tests/dromaeo/cssquery-yui.html) 15:48:07 INFO - 2015-11-05 15:48:07,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 301760512 15:48:07 INFO - 2015-11-05 15:48:07,421 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/dromaeo/cssquery-yui.html (next: http://localhost:49755/tests/dromaeo/cssquery-dojo.html) 15:51:09 INFO - 2015-11-05 15:51:09,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 348303360 15:51:09 INFO - 2015-11-05 15:51:09,962 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,962 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:51:09 INFO - 2015-11-05 15:51:09,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:51:09 INFO - 2015-11-05 15:51:09,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:51:09 INFO - 2015-11-05 15:51:09,963 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:51:09 INFO - 2015-11-05 15:51:09,966 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2701.58125490549;2795.3430943728226;2796.888124475021;2833.1783782703005;2837.0637689562445;4648.860534183976;4772.6181905447565;4780.784864681089;4790.520947905207;4885.022995400921;4761.357216775734;4771.093492236472;4790.161721698706;4791.305260737191;4838.443578988417;4295.806688699016;4433.866983990485;4473.575010374009;4485.282354823229;4530.546945305476;4399.318105693606;4519.887002824923;4531.297648864432;4535.614472769818;4552.430946131733;4396.934045989313;4414.514403415622;4476.731396116227;4553.248713962209;4582.9541704583025;4469.016816300409;4545.227311357077;4571.085782843411;4574.771261436915;4608.585227329523;4242.109157077018;4373.300271956472;4480.932786008212;4500.167469018209;4527.592516673515;4337.298051218493;4572.5656062674325;4663.836765713218;4677.508861569554;4685.390899183119;5022.221555658879;5073.949260507385;5076.111680455905;5089.440161582223;5130.358705161855;5128.1794912813775;5134.7689353978785;5159.2003239497935;5169.638125331228;5179.689218646856;4598.793054312564;4693.6949098308505;4715.95284047162;4772.02173554424;4833.202521583935;5211.140161873324;5338.46615338463;5344.839654810362;5357.142857142839;5359.14253719403;5010.67430617016;5061.4179369373;5074.822381216713;5091.898162036812;5128.461511541234;4983.476734942851;5084.923726144111;5111.361079865017;5174.24973378858;5194.168932970707;5018.774155163026;5046.924296135561;5129.79480820763;5139.897202055938;5141.974290128525;5076.263941728503;5076.517730815566;5092.159793634009;5111.846644600593;5134.614903882149;3747.4940882980995;3809.466674665549;3839.481669974518;3974.940375894364;4072.6741860651077;3464.6535346465657;3541.752077354612;3570.0360902556686;3599.3161299353565;3602;4760.785764640599;4866.172750632401;4873.074115917964;4877.926831097537;4897.951020489821;4935.358403407606;5073.543381095719;5075.11185542536;5192.584593232532;5204.9739751301;4646.4888862225125;4740.905181896343;4752.904941901143;4793.472718001017;4816.494268101869;4476.7090139140855;4481.529439408815;4533.478649955231;4535.705179163409;4540.8637740867825;4892.510748925079;4918.065567542156;4995.175795993766;5200;5249.790008399621;5054.620903432184;5098.566621837185;5151.871203219949;5172.301739265151;5219.739013049409;5222.321098257202;5272.44639312882;5300.1519756838725;5314.5216930476445;5350.545203657733;4885.413750349981;5001.699898006132;5016.573591244639;5075.467075956972;5101.591872650253;5005.324281221989;5097.6941383517105;5107.565856902205;5111.182210846247;5135.127028405105;4999.125153098121;5038.496150384932;5061.8734531637;5113.82004645309;5136.0755064087325;4812.1578723722505;4906.190478571139;4927.704337739747;5085.186370180753;5089.745512724275;4771.093492236464;4828.830990915301;4855.684380515397;4887.60899128076;4962.156433406401;4835.58897493717;5063.5695965843315;5070.782373517439;5090.821821236239;5104.566111880532;4649.395578574764;4757.072370887644;4771.95228047715;4904.950950490449;5010.073136469765 15:51:09 INFO - 2015-11-05 15:51:09,966 DEBUG : BROWSER_OUTPUT: |1;ext.html;490.1202341796475;490.34538890581075;501.9759690231925;509.8452006205944;530.0538538708406;28376.290592735193;29672.10983670488;33075.99999999997;33783.493247601305;33921.49117763229;37289.440658390144;37942.999999999935;38012.61987380125;38466;38566.42150367747;7359.411247100219;7975.680972761083;8099.190080991883;8175.896254005693;8200.42597018209;7445.106587209515;9477.526123693822;9775.902240977606;9803.2157427406;9905.603775848993;9486.43081415114;9503.762405939873;9531.857022144673;9551.522423878812;9625.855612165824;7700.345470635003;7771.184025677336;9533.14201721845;9595.088466595662;9657.806843863083;9366.906330936672;9500.952495237549;9565.426074435487;9574.329796914219;9665.130138287588;35635.465468018;35708;35729.46405803915;36214;36307.81846090779;2622.8688565571647;2783.4154827486254;2955.2611847038243;3008.443437963984;3161.96838031619;21680.783192168034;21885.12459501618;21904.561908761894;22331.55336893269;23093.307200784002;1947.4547126804518;2007.2372498450495;2043.4993426610577;2050.1082029317295;2089.958200835975;233037;233776;233945;234776;235625;49103.75448122736;49374.753126234136;54981.175282370794;56231.15653265204;57213.14180287299;50541.747291264044;51422.22866657003;52496.73751631294;52836.73581632067;52913.47086529162;14783.63040923964;14913.403463861541;15065.924670376797;15124.168170750494;15131.167785771668;11286.830697539543;11475.426228688699;11565.710857228469;11582.76834463306;11622.593209237637;18454.26182952694;18481.7227741584;18514.629707405777;18689.53276168107;18747.81252187488;7257.34683878443;7409.184989651134;7497.400207983348;7511.9624401877645;7555.433342499225;767.2212704105337;796.8366484870587;814.450246083891;843.2158092973593;924.1590152960907;23629;23753;23978.640320395207;23987;24065;802.2298593350449;851.2594043182347;914.6021480655936;1028.3932479836933;1077;10029.398236105857;13544.187348759106;14125.587441255791;14331.136952196357;14612.415503379745;272012;276578;277222;278256;280074;43530;43617.56382436198;49909;50031.24953125706;50923.49076509262;1251.5119103549623;1255.2656695832857;1260.2690439545042;1261.8864302212844;1280.6286177008749;23867.164649237195;24445.65548894828;24978.125765598117;25025;25323.620145698198;38856;41249.381259281734;41519.377209342485;46381;46885;177794;178374;181134;181725;181835;24359.75640243575;24487.38781530476;25003.249902502954;25305;25343.74656253414;36833.44749828701;37154.8142259287;38145;38414.615853841104;39173;30706;31925.68074319227;34141;34969.475457867644;35446.291074177854;31456.370872581963;31544.211394715316;31562;31790.841045794623;32227.677723222467;32332.35335293328;32368.439471657628;32380.676193237767;32476.350472989936;32880;25612.48775024452;26139.346516337242;26428.867855661367;26609.201723948314;27122.864385677945;20502.359811215367;20600.793992059887;20767.169313227907;20782.896085519475;20789.688154677995 15:51:09 INFO - 2015-11-05 15:51:09,971 DEBUG : BROWSER_OUTPUT: |2;jquery.html;301.96225471816024;306.1779123054598;311.54825503020624;311.7583872498813;314.9212696825794;12843.229406235632;13378.866211337883;15780.447684331051;16394.344226230936;16719.66560668786;10928.617498387557;11100.833487497674;11128.49921753521;14063.859361406383;16144.596385090379;3886.378179491282;3954.7231693781446;3968.0278331808604;3993.7204395692315;4018.618231268025;3107.9533806992913;3221.32352206037;4097.09863829957;4109.506859176903;4290.099079193373;4240.5547417521175;4245.469316335458;4262.318029115342;4272.829086836538;4333.068390296085;4117.773522456264;4242.490901091858;4247.384129301265;4275.7862106894845;4308.80610372534;3657.359962006665;3664.157243833933;3667.449882517644;3676.0809797550614;3710.7216958728204;11941.462634181482;12006.819897701542;12174.634760957186;12221.511139554406;12286.262824230485;1544.8686861616777;1612.8790340724493;1613.6691978144452;1630.6738652269594;1715.9313627454887;8470.618822153017;8478.66085356585;8614.612342444605;8638.17937295956;8663.35024873137;1332.6601716562311;1386.3830595385057;1403.922784246866;1428.5071650280636;1452.03439712591;46482.76758616219;47914.281285780744;48250;48299.5170048302;48513.272300915516;6034.577579569388;6035.30593981689;6069.241344831896;6080.969595152084;6083.9391606084255;6872.553284036521;6878.037074809531;6881.518293719391;6885.483588730765;6930.410915072174;4999.800007999712;5003.674761140514;5028.19548872186;5030.170021946411;5031.144705400017;5258.447862974409;5321.8935621287355;5375.650582712111;5379.704116273642;5385.084535628953;2698.0287096645193;2700.6489156409934;2713.9592906106423;2727.4545090981883;2742.287005378616;922.3405265235389;942.3309450290234;983.2527279267808;985.408754747146;1019.918406527476;372.7167352811883;386.2892278208054;388.1964333828947;400.3454352134223;409.9036726369301;10279.383237005804;10294.794104118026;10805.459727013618;10928.508217130247;11087.667369978913;378.87875879718223;412.91328820947336;421.9620234178939;422.82452782095083;427.9144171165779;5400.297961265011;5721.685307308055;5733.111367738007;5735.713214339266;5907.8227653169615;498604;499817;518136;521818;536153;65339.673301633185;69735.30264697288;69879.65060174666;70723.58552828914;71788;442.9534898835576;443.23099422501934;449.23629829290337;449.57964303376446;451.8057235388814;9154.450732956044;9705.514724263618;9851.556679949563;10002.299839011199;10081;29447.411051778417;29600;30562.388752225277;31225.219369515944;32086.35827283488;41702.58297416987;45141.09717805691;45328.32007519956;45820.54179458163;46074;5520.171974203901;5701.372848986525;5717.742701578356;5761.5390768739235;5804.100364443518;10147.289689721649;10578.947105264424;10616.681499554717;10692.89307106919;10741.89258107409;9133.908660913306;9289;9379.718608441484;9410.38832475887;9613.471259080818;8804.515751633466;9089.181973622406;9299.256059515357;9370.203532699798;9377.718668439958;7834.451588388758;7991.920080799117;8931.821363572823;9585.616575336908;9594.088561586637;5618.943810561842;5694.772209111589;5713.143028545752;5737.655740655574;5808.564357673107;9082.137196966278;9199.218066464158;9385.671501497414;9482.28882833804;9620.855687164558 15:51:09 INFO - 2015-11-05 15:51:09,971 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1176.4176732517394;1458.496818597584;1528.946486872959;1576.605848537865;1607.879409044322;5747.367789543152;6039.5772295939305;6218.440340369366;6436.935630643692;6467.997460393646;6444.0656104864765;6446.355364463563;6489.415952564268;6575.868482630356;6583.111279977202;1882.8305452509305;1886.6321067391864;1892.0161516011735;1894.9526261843425;1903.5146037760421;1886.3963531669872;1895.5734959634042;1898.4779185723967;1908.0364415969984;1914.9617007659838;1883.9811601883944;1885.264746748769;1885.8397036251936;1886.9056547172586;1902.6765449873485;1835.1283140508285;1835.1925152932668;1846.2614954018434;1854.3231720422084;1868.9345872894519;1837.5865430278213;1854.3695143651223;1878.258088055224;1894.4979580411202;1902.657521646103;5691.260136182311;6382.840428989266;6439.066335381343;6517.087607734921;6537;3586.6413358664186;3822.503074600284;3976.70174736893;3981.920361592781;4010.418489319062;2350;2373.299876536426;2394.2099107294725;2415.987920060406;2429.0648100481267;682.8804959132132;686.4508393285352;696.7491702986921;700;703.9155301363869;8423.789405264917;8451.154884511561;8556.871646925301;8560.972683278047;8579.099194584542;3459.9481007784902;3553.182767963383;3554.2180720241504;3585.175409655794;3585.372559802024;7532.698692052366;7546;7548.735794247175;7574.734884279023;7659.463837531431;3971.1660551284554;3994.580569040267;3998.1603863188475;4008.2183974124764;4017.1563971565715;3614.0603443104983;3621.9818900905852;3627.800470974069;3670.22925185714;3671.2290419011774;2987.4771914915236;3012.307169351018;3014.9849250753605;3046.5277881928337;3071.0172744721476;934.6822080492665;949.8052899155656;953.713885834247;964.2093483343731;965.2663975378622;782.9921700782919;789.9802504937422;800.1158719614858;806.5443024691031;927.6428574998674;6012.338642749294;6034.1853849730605;6046.062860256668;6070.180525628984;6107.6640784757265;395.14845507930454;404.18153239689866;407.0718761224413;411.70768754184263;416.13028769871113;4745.691530050535;4847.75761211938;4863.367762190964;4875.975620121877;4881.389826271716;6797.2523022467485;6928.480363972722;7427.480076394709;7524.5861477619255;7586.279303466162;7452.403807695371;7494.587797671181;7522.699092036367;7538.585377804274;7642.579658118857;5649.12438572022;5916.23088998436;5951.077582974646;6006.579539432285;6057.57596968208;5724.570657200643;5829.941700583109;5831.7667293307795;5846.239988801429;5912.940870591239;6805.693743781443;6952.443804495527;6981.79054628362;7058.576485410892;7074.504784665024;6909.170899492093;7077.398421134056;7188.317109874553;7205.819854503679;7249.637518124178;5748.655080695172;5846.619969701956;5851.736671849862;5901.114832775118;5965.313988891333;6178.227721534809;6213.471854892385;6222.719977601109;6229.408206220402;6367.204099487564;5761.366249712612;5820.476157145878;5840.328362238397;5910.822675319747;5926.644401335933;5676.403977582459;5686.033374326457;5722;5769.451902069297;5840.94159058404;5816.447437493432;5829.329627092939;5848.385919478394;5869.090291004901;5893.322267939242;4946.678465899705;4965.677230979974;4976.104301225814;4980.676256043345;5024.045431368028;5118.232265160255;5153.175491921274;5169.405518365285;5183.50756678115;5190.091733946469 15:51:09 INFO - 2015-11-05 15:51:09,974 DEBUG : BROWSER_OUTPUT: |4;prototype.html;265.54326558319696;273.87949302307;278.708749356922;288.7011942639369;295.9230600043988;5119.360079990001;5220.373555173375;5227.764750586223;5244.501772331627;5256.7897284108685;5145.614078944075;5167.715775632339;5203.687778733279;5229.163333866582;5233.1103712368895;4121.9175616487655;4135.25565398229;4162.250794856925;4173.6661067114555;4178.582141785828;4103.630673239408;4148.730332528391;4161.979190104045;4165.770882601456;4178;4074.103697186614;4082.5713300103507;4133.503979522461;4136.152088821799;4146.8133933972895;4014.1369605534805;4087.3664581989838;4090.6727461802984;4160.583941605815;4161.687873409476;3546.6345456998984;3547.840347184383;3564.269324788412;3573.94639080414;3608.4767708682357;5081.974590127025;5093.847184584469;5107.412647545506;5124.052050370656;5143.5113664201845;4547.590716835501;4551.203539380628;4606.193916064675;4608.723476591415;4609.239475486541;5291.047611429941;5423.972880135613;5511.779528818843;5530.419305972855;5531.004419204542;3773.9998900291444;3795.335816232176;3822.9044273893096;3823.9426408603895;3854.3062248795204;5560.582956278255;5586.273784408041;5774.97112514439;5801.158831969341;5853.32686741026;3792.639699228624;3831.2912111259507;3845.288621605012;3859.980700096538;3888.7083468739957;3909.6481316681634;3910.3743401055694;3921.8823435296986;3938.428927805452;3967.5437324708028;4339.4792624884585;4347.739135651871;4415.271480205794;4481.5294394088805;4504.752238626841;5433.049216387117;5454.7272636368025;5464.207689884945;5473.151661492475;5497.367802702661;1385.3211926156312;1416.277698373816;1417.978730319046;1418.2979425184599;1437.9424823006962;919.1773362840221;939.3236869453982;942.0344147249125;958.1999030809213;959.7024922274118;5295.841124766263;5305.071612467803;5332.173513105475;5341.706206158621;5351.946480535223;5732.05421105513;5735.483806457439;5740.827775166752;5776.364599894008;5816.360200377955;5280.1815718563685;5303.840884773463;5338.492843179892;5363.865903352447;5372.516473517324;3054.587630669831;3091.1962889648853;3152.274976755359;3160.241542029896;3165.287810242677;5764.221830052889;5846.619969701956;5863.29640443141;5865.266841644794;5876.206712093898;5837.737301821343;5838.737256823369;5842.065269556851;5888.028475301528;5906.438888305604;5629.662220266797;5783.566232532577;5805.709714514342;5882.647041177543;5908.4091590841435;5706.144078388109;5779.219805326227;5794.507466865363;5804.506616937608;5829.8251052468495;5554.916676249779;5598.692071936082;5637.43625637433;5652.0674088774895;5663.235463212578;5797.681127538026;5803.245578074823;5867.383924687846;5897.11543268496;5932.970335148297;3762.9059273518383;3812.8856134316015;3842.116313247913;3949.111449923744;3959.148783011551;5488.670679759227;5659.518940890071;5675.148727690879;5733.254676891977;5741.770329186786;5342.439043900335;5433.945660543344;5495.038368285454;5509.5041446270025;5550.4449555044175;5460.208269800777;5483.670979741229;5528.364238112507;5529.944700553104;5545.112781954868;5235.898286238156;5352.84913743547;5358.866028349323;5377.408485066561;5396.595255355785;5515.172724091258;5541.972290138524;5570.2201691762375;5604.467575580314;5612.074007788669;5364.7049412282695;5463.699496527729;5470.64440811346;5475.425080366664;5476.726163691879 15:51:09 INFO - 2015-11-05 15:51:09,975 DEBUG : BROWSER_OUTPUT: |5;yui.html;587.1457030021317;652.3378770547897;669.327326037333;670.4066900792797;686.9793906182815;12120.090993175503;12165.391730413488;12167.878321216785;12308;12517.436715347809;11638.418079096033;11734.471948762304;11787.823182652246;11810.645680629574;11915.702107447318;641.0928536121382;643.5109316919152;771.5717776633966;776.7747353267574;786.9252421019994;796.9880451793227;800.3317230112863;809.4697972827778;809.5183365897311;809.6923169195727;831.6465502161587;833.0877688930611;841.381584535369;842.3976856547567;843.2495079379327;642.7814543055383;643.6106155775758;803.7628899474611;818.3902992270796;825.0099880143852;600.3726106219011;604.8246008657484;607.7234858139536;610.2189197826789;611.9388061193889;12046;12104.334261615608;12255.080868934776;12297;12299.56951506702;10270.691879243635;10295.897041029568;10545.947270263676;10762.515686794113;10805.351678899291;7598.126215485235;7620.61896905158;7626.923730762677;7683.30850223477;7704.6918123275;2836.9716302836914;2846.5018621741115;2846.985765071182;2931.4576803291247;2997.040946896994;41501.79249103765;41995;42214.36678449795;42856.357154642705;43054.78472607617;8040.758777236692;8145.755627331189;8228.30059444942;8237.876431853527;8263.628136733862;17067.573310667085;17072.82927170737;17198.592197092417;17276.04981725992;17296.827031729772;6293.96853015732;6326.272478665012;6445.967770161213;6621.039949207338;6627.1716035495565;3264.2329052672603;3266.2650903546987;3272.633653170149;3359.546461227752;3399.9490007649906;2511.472590755925;2537.9238622840976;2542.555052865741;2551.987240063788;2557.514072326252;353.7824238093554;361.5227899173119;368.70503597122195;371.251927366357;372.2239131410984;421.7090207756638;457.5675986193082;462.2373084410749;488.6310835319311;490.72028943502573;6491.642959637171;6561.3438656134;6601.504887133484;6620.933790662128;6641.468682505388;425.41930265188415;471.69104236725;483.35549953352034;490.5413438435075;505.2017811857257;3004.8798048077833;3097.2566584020124;3148.9842550787557;3161.8577164027674;3201.439748044083;55174;55185;55275.44724552703;55773.442265577636;56052;46855.76572117118;47650.285245721345;47765.761171193924;48372.51627483751;48425;43206.35190472146;43830.780846096204;43906.780466097465;44068.77965610151;44793.32810007853;6103.511719062553;6207.6275423474735;6260.686965651608;6301.495880329471;6319.96840015797;31275.53086703747;32425.837870810494;32622.184445389055;32644.34711305808;32863.178420539676;38116.809415952746;41666.58333416627;42471.3629295567;42592.78703606462;43114;7732;7954.007642144466;7994.360451163777;8070.515769053875;8630.027877339755;8492;8666.956665216634;8798.34012449056;8902.198802107841;9034.728958131267;7629.961850190713;7958.880616790869;8020.959895200486;8109.351251899716;8211.973503312085;8218.753437396888;8263.380246481658;8271.95864020676;8307.584620769057;8353.0811610724;7834.373250139861;8027.117017128228;8046.1149273578685;8100.392470564849;8256.009278886571;6679.432248258952;7142.285771422816;7237.384822290164;7390.371818395497;7597.962010189914;6993.615351155532;7154.534955228101;7213.482365665073;7293.161286451914;7341.522801017917 15:51:09 INFO - 2015-11-05 15:51:09,975 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:51:09 INFO - 2015-11-05 15:51:09,976 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:51:09 INFO - 2015-11-05 15:51:09,976 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 15:51:09 INFO - 2015-11-05 15:51:09,976 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:51:09 INFO - 2015-11-05 15:51:09,976 DEBUG : BROWSER_OUTPUT: __startTimestamp1446767469961__endTimestamp 15:51:09 INFO - 2015-11-05 15:51:09,976 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,976 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:51:09 INFO - 2015-11-05 15:51:09,977 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:51:09 INFO - 2015-11-05 15:51:09,977 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,977 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4757.94 Median:4885.41 stddev:518.22 (10.6%) stddev-sans-first:494.06 15:51:09 INFO - 2015-11-05 15:51:09,977 DEBUG : BROWSER_OUTPUT: Values: 2701.6 2795.3 2796.9 2833.2 2837.1 4648.9 4772.6 4780.8 4790.5 4885.0 4761.4 4771.1 4790.2 4791.3 4838.4 4295.8 4433.9 4473.6 4485.3 4530.5 4399.3 4519.9 4531.3 4535.6 4552.4 4396.9 4414.5 4476.7 4553.2 4583.0 4469.0 4545.2 4571.1 4574.8 4608.6 4242.1 4373.3 4480.9 4500.2 4527.6 4337.3 4572.6 4663.8 4677.5 4685.4 5022.2 5073.9 5076.1 5089.4 5130.4 5128.2 5134.8 5159.2 5169.6 5179.7 4598.8 4693.7 4716.0 4772.0 4833.2 5211.1 5338.5 5344.8 5357.1 5359.1 5010.7 5061.4 5074.8 5091.9 5128.5 4983.5 5084.9 5111.4 5174.2 5194.2 5018.8 5046.9 5129.8 5139.9 5142.0 5076.3 5076.5 5092.2 5111.8 5134.6 3747.5 3809.5 3839.5 3974.9 4072.7 3464.7 3541.8 3570.0 3599.3 3602.0 4760.8 4866.2 4873.1 4877.9 4898.0 4935.4 5073.5 5075.1 5192.6 5205.0 4646.5 4740.9 4752.9 4793.5 4816.5 4476.7 4481.5 4533.5 4535.7 4540.9 4892.5 4918.1 4995.2 5200.0 5249.8 5054.6 5098.6 5151.9 5172.3 5219.7 5222.3 5272.4 5300.2 5314.5 5350.5 4885.4 5001.7 5016.6 5075.5 5101.6 5005.3 5097.7 5107.6 5111.2 5135.1 4999.1 5038.5 5061.9 5113.8 5136.1 4812.2 4906.2 4927.7 5085.2 5089.7 4771.1 4828.8 4855.7 4887.6 4962.2 4835.6 5063.6 5070.8 5090.8 5104.6 4649.4 4757.1 4772.0 4905.0 5010.1 15:51:09 INFO - 2015-11-05 15:51:09,977 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,978 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38633.86 Median:32280.02 stddev:60975.50 (188.9%) stddev-sans-first:61079.29 15:51:09 INFO - 2015-11-05 15:51:09,982 DEBUG : BROWSER_OUTPUT: Values: 490.1 490.3 502.0 509.8 530.1 28376.3 29672.1 33076.0 33783.5 33921.5 37289.4 37943.0 38012.6 38466.0 38566.4 7359.4 7975.7 8099.2 8175.9 8200.4 7445.1 9477.5 9775.9 9803.2 9905.6 9486.4 9503.8 9531.9 9551.5 9625.9 7700.3 7771.2 9533.1 9595.1 9657.8 9366.9 9501.0 9565.4 9574.3 9665.1 35635.5 35708.0 35729.5 36214.0 36307.8 2622.9 2783.4 2955.3 3008.4 3162.0 21680.8 21885.1 21904.6 22331.6 23093.3 1947.5 2007.2 2043.5 2050.1 2090.0 233037.0 233776.0 233945.0 234776.0 235625.0 49103.8 49374.8 54981.2 56231.2 57213.1 50541.7 51422.2 52496.7 52836.7 52913.5 14783.6 14913.4 15065.9 15124.2 15131.2 11286.8 11475.4 11565.7 11582.8 11622.6 18454.3 18481.7 18514.6 18689.5 18747.8 7257.3 7409.2 7497.4 7512.0 7555.4 767.2 796.8 814.5 843.2 924.2 23629.0 23753.0 23978.6 23987.0 24065.0 802.2 851.3 914.6 1028.4 1077.0 10029.4 13544.2 14125.6 14331.1 14612.4 272012.0 276578.0 277222.0 278256.0 280074.0 43530.0 43617.6 49909.0 50031.2 50923.5 1251.5 1255.3 1260.3 1261.9 1280.6 23867.2 24445.7 24978.1 25025.0 25323.6 38856.0 41249.4 41519.4 46381.0 46885.0 177794.0 178374.0 181134.0 181725.0 181835.0 24359.8 24487.4 25003.2 25305.0 25343.7 36833.4 37154.8 38145.0 38414.6 39173.0 30706.0 31925.7 34141.0 34969.5 35446.3 31456.4 31544.2 31562.0 31790.8 32227.7 32332.4 32368.4 32380.7 32476.4 32880.0 25612.5 26139.3 26428.9 26609.2 27122.9 20502.4 20600.8 20767.2 20782.9 20789.7 15:51:09 INFO - 2015-11-05 15:51:09,982 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,982 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24788.55 Median:446.23 stddev:84378.14 (18909.0%) stddev-sans-first:84594.81 15:51:09 INFO - 2015-11-05 15:51:09,982 DEBUG : BROWSER_OUTPUT: Values: 302.0 306.2 311.5 311.8 314.9 12843.2 13378.9 15780.4 16394.3 16719.7 10928.6 11100.8 11128.5 14063.9 16144.6 3886.4 3954.7 3968.0 3993.7 4018.6 3108.0 3221.3 4097.1 4109.5 4290.1 4240.6 4245.5 4262.3 4272.8 4333.1 4117.8 4242.5 4247.4 4275.8 4308.8 3657.4 3664.2 3667.4 3676.1 3710.7 11941.5 12006.8 12174.6 12221.5 12286.3 1544.9 1612.9 1613.7 1630.7 1715.9 8470.6 8478.7 8614.6 8638.2 8663.4 1332.7 1386.4 1403.9 1428.5 1452.0 46482.8 47914.3 48250.0 48299.5 48513.3 6034.6 6035.3 6069.2 6081.0 6083.9 6872.6 6878.0 6881.5 6885.5 6930.4 4999.8 5003.7 5028.2 5030.2 5031.1 5258.4 5321.9 5375.7 5379.7 5385.1 2698.0 2700.6 2714.0 2727.5 2742.3 922.3 942.3 983.3 985.4 1019.9 372.7 386.3 388.2 400.3 409.9 10279.4 10294.8 10805.5 10928.5 11087.7 378.9 412.9 422.0 422.8 427.9 5400.3 5721.7 5733.1 5735.7 5907.8 498604.0 499817.0 518136.0 521818.0 536153.0 65339.7 69735.3 69879.7 70723.6 71788.0 443.0 443.2 449.2 449.6 451.8 9154.5 9705.5 9851.6 10002.3 10081.0 29447.4 29600.0 30562.4 31225.2 32086.4 41702.6 45141.1 45328.3 45820.5 46074.0 5520.2 5701.4 5717.7 5761.5 5804.1 10147.3 10578.9 10616.7 10692.9 10741.9 9133.9 9289.0 9379.7 9410.4 9613.5 8804.5 9089.2 9299.3 9370.2 9377.7 7834.5 7991.9 8931.8 9585.6 9594.1 5618.9 5694.8 5713.1 5737.7 5808.6 9082.1 9199.2 9385.7 9482.3 9620.9 15:51:09 INFO - 2015-11-05 15:51:09,983 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,983 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4459.28 Median:5818.46 stddev:2319.67 (39.9%) stddev-sans-first:2313.06 15:51:09 INFO - 2015-11-05 15:51:09,983 DEBUG : BROWSER_OUTPUT: Values: 1176.4 1458.5 1528.9 1576.6 1607.9 5747.4 6039.6 6218.4 6436.9 6468.0 6444.1 6446.4 6489.4 6575.9 6583.1 1882.8 1886.6 1892.0 1895.0 1903.5 1886.4 1895.6 1898.5 1908.0 1915.0 1884.0 1885.3 1885.8 1886.9 1902.7 1835.1 1835.2 1846.3 1854.3 1868.9 1837.6 1854.4 1878.3 1894.5 1902.7 5691.3 6382.8 6439.1 6517.1 6537.0 3586.6 3822.5 3976.7 3981.9 4010.4 2350.0 2373.3 2394.2 2416.0 2429.1 682.9 686.5 696.7 700.0 703.9 8423.8 8451.2 8556.9 8561.0 8579.1 3459.9 3553.2 3554.2 3585.2 3585.4 7532.7 7546.0 7548.7 7574.7 7659.5 3971.2 3994.6 3998.2 4008.2 4017.2 3614.1 3622.0 3627.8 3670.2 3671.2 2987.5 3012.3 3015.0 3046.5 3071.0 934.7 949.8 953.7 964.2 965.3 783.0 790.0 800.1 806.5 927.6 6012.3 6034.2 6046.1 6070.2 6107.7 395.1 404.2 407.1 411.7 416.1 4745.7 4847.8 4863.4 4876.0 4881.4 6797.3 6928.5 7427.5 7524.6 7586.3 7452.4 7494.6 7522.7 7538.6 7642.6 5649.1 5916.2 5951.1 6006.6 6057.6 5724.6 5829.9 5831.8 5846.2 5912.9 6805.7 6952.4 6981.8 7058.6 7074.5 6909.2 7077.4 7188.3 7205.8 7249.6 5748.7 5846.6 5851.7 5901.1 5965.3 6178.2 6213.5 6222.7 6229.4 6367.2 5761.4 5820.5 5840.3 5910.8 5926.6 5676.4 5686.0 5722.0 5769.5 5840.9 5816.4 5829.3 5848.4 5869.1 5893.3 4946.7 4965.7 4976.1 4980.7 5024.0 5118.2 5153.2 5169.4 5183.5 5190.1 15:51:09 INFO - 2015-11-05 15:51:09,983 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,983 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4629.32 Median:5318.62 stddev:1380.44 (26.0%) stddev-sans-first:1344.89 15:51:09 INFO - 2015-11-05 15:51:09,984 DEBUG : BROWSER_OUTPUT: Values: 265.5 273.9 278.7 288.7 295.9 5119.4 5220.4 5227.8 5244.5 5256.8 5145.6 5167.7 5203.7 5229.2 5233.1 4121.9 4135.3 4162.3 4173.7 4178.6 4103.6 4148.7 4162.0 4165.8 4178.0 4074.1 4082.6 4133.5 4136.2 4146.8 4014.1 4087.4 4090.7 4160.6 4161.7 3546.6 3547.8 3564.3 3573.9 3608.5 5082.0 5093.8 5107.4 5124.1 5143.5 4547.6 4551.2 4606.2 4608.7 4609.2 5291.0 5424.0 5511.8 5530.4 5531.0 3774.0 3795.3 3822.9 3823.9 3854.3 5560.6 5586.3 5775.0 5801.2 5853.3 3792.6 3831.3 3845.3 3860.0 3888.7 3909.6 3910.4 3921.9 3938.4 3967.5 4339.5 4347.7 4415.3 4481.5 4504.8 5433.0 5454.7 5464.2 5473.2 5497.4 1385.3 1416.3 1418.0 1418.3 1437.9 919.2 939.3 942.0 958.2 959.7 5295.8 5305.1 5332.2 5341.7 5351.9 5732.1 5735.5 5740.8 5776.4 5816.4 5280.2 5303.8 5338.5 5363.9 5372.5 3054.6 3091.2 3152.3 3160.2 3165.3 5764.2 5846.6 5863.3 5865.3 5876.2 5837.7 5838.7 5842.1 5888.0 5906.4 5629.7 5783.6 5805.7 5882.6 5908.4 5706.1 5779.2 5794.5 5804.5 5829.8 5554.9 5598.7 5637.4 5652.1 5663.2 5797.7 5803.2 5867.4 5897.1 5933.0 3762.9 3812.9 3842.1 3949.1 3959.1 5488.7 5659.5 5675.1 5733.3 5741.8 5342.4 5433.9 5495.0 5509.5 5550.4 5460.2 5483.7 5528.4 5529.9 5545.1 5235.9 5352.8 5358.9 5377.4 5396.6 5515.2 5542.0 5570.2 5604.5 5612.1 5364.7 5463.7 5470.6 5475.4 5476.7 15:51:09 INFO - 2015-11-05 15:51:09,984 DEBUG : BROWSER_OUTPUT: 15:51:09 INFO - 2015-11-05 15:51:09,984 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12104.16 Median:593.76 stddev:15110.19 (2544.8%) stddev-sans-first:15127.83 15:51:09 INFO - 2015-11-05 15:51:09,986 DEBUG : BROWSER_OUTPUT: Values: 587.1 652.3 669.3 670.4 687.0 12120.1 12165.4 12167.9 12308.0 12517.4 11638.4 11734.5 11787.8 11810.6 11915.7 641.1 643.5 771.6 776.8 786.9 797.0 800.3 809.5 809.5 809.7 831.6 833.1 841.4 842.4 843.2 642.8 643.6 803.8 818.4 825.0 600.4 604.8 607.7 610.2 611.9 12046.0 12104.3 12255.1 12297.0 12299.6 10270.7 10295.9 10545.9 10762.5 10805.4 7598.1 7620.6 7626.9 7683.3 7704.7 2837.0 2846.5 2847.0 2931.5 2997.0 41501.8 41995.0 42214.4 42856.4 43054.8 8040.8 8145.8 8228.3 8237.9 8263.6 17067.6 17072.8 17198.6 17276.0 17296.8 6294.0 6326.3 6446.0 6621.0 6627.2 3264.2 3266.3 3272.6 3359.5 3399.9 2511.5 2537.9 2542.6 2552.0 2557.5 353.8 361.5 368.7 371.3 372.2 421.7 457.6 462.2 488.6 490.7 6491.6 6561.3 6601.5 6620.9 6641.5 425.4 471.7 483.4 490.5 505.2 3004.9 3097.3 3149.0 3161.9 3201.4 55174.0 55185.0 55275.4 55773.4 56052.0 46855.8 47650.3 47765.8 48372.5 48425.0 43206.4 43830.8 43906.8 44068.8 44793.3 6103.5 6207.6 6260.7 6301.5 6320.0 31275.5 32425.8 32622.2 32644.3 32863.2 38116.8 41666.6 42471.4 42592.8 43114.0 7732.0 7954.0 7994.4 8070.5 8630.0 8492.0 8667.0 8798.3 8902.2 9034.7 7630.0 7958.9 8021.0 8109.4 8212.0 8218.8 8263.4 8272.0 8307.6 8353.1 7834.4 8027.1 8046.1 8100.4 8256.0 6679.4 7142.3 7237.4 7390.4 7598.0 6993.6 7154.5 7213.5 7293.2 7341.5 15:51:09 INFO - 2015-11-05 15:51:09,986 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:51:09 INFO - 2015-11-05 15:51:09,986 DEBUG : BROWSER_OUTPUT: 15:51:10 INFO - 2015-11-05 15:51:10,688 INFO : Browser exited with error code: 0 15:51:10 INFO - 2015-11-05 15:51:10,720 INFO : Completed test dromaeo_css (00:18:35) 15:51:10 INFO - 2015-11-05 15:51:10,721 INFO : Starting test kraken 15:51:10 INFO - 2015-11-05 15:51:10,721 DEBUG : operating with platform_type : mac_ 15:51:10 INFO - 2015-11-05 15:51:10,721 INFO : Initialising browser for kraken test... 15:51:10 INFO - 2015-11-05 15:51:10,736 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmprd864w/profile http://localhost:49755/getInfo.html 15:51:13 INFO - 2015-11-05 15:51:13,216 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:51:13 INFO - 2015-11-05 15:51:13,216 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:51:13 INFO - 2015-11-05 15:51:13,216 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:51:13 INFO - 2015-11-05 15:51:13,217 DEBUG : BROWSER_OUTPUT: __metrics 15:51:13 INFO - 2015-11-05 15:51:13,232 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:13 INFO - 2015-11-05 15:51:13,971 INFO : Browser initialized. 15:51:13 INFO - 2015-11-05 15:51:13,972 INFO : Running cycle 1/1 for kraken test... 15:51:13 INFO - 2015-11-05 15:51:13,972 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmprd864w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:51:26 INFO - 2015-11-05 15:51:26,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 200331264 15:51:26 INFO - 2015-11-05 15:51:26,001 DEBUG : BROWSER_OUTPUT: 15:51:28 INFO - 2015-11-05 15:51:28,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:29 INFO - 2015-11-05 15:51:29,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 264126464 15:51:29 INFO - 2015-11-05 15:51:29,468 DEBUG : BROWSER_OUTPUT: 15:51:32 INFO - 2015-11-05 15:51:32,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-dft) 15:51:33 INFO - 2015-11-05 15:51:33,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 277712896 15:51:33 INFO - 2015-11-05 15:51:33,025 DEBUG : BROWSER_OUTPUT: 15:51:36 INFO - 2015-11-05 15:51:36,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-fft) 15:51:36 INFO - 2015-11-05 15:51:36,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 265125888 15:51:36 INFO - 2015-11-05 15:51:36,809 DEBUG : BROWSER_OUTPUT: 15:51:39 INFO - 2015-11-05 15:51:39,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49755/tests/kraken/driver.html?testName=audio-oscillator) 15:51:39 INFO - 2015-11-05 15:51:39,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 267165696 15:51:39 INFO - 2015-11-05 15:51:39,662 DEBUG : BROWSER_OUTPUT: 15:51:42 INFO - 2015-11-05 15:51:42,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:42 INFO - 2015-11-05 15:51:42,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 266829824 15:51:42 INFO - 2015-11-05 15:51:42,669 DEBUG : BROWSER_OUTPUT: 15:51:46 INFO - 2015-11-05 15:51:46,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49755/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:46 INFO - 2015-11-05 15:51:46,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 265273344 15:51:46 INFO - 2015-11-05 15:51:46,710 DEBUG : BROWSER_OUTPUT: 15:51:50 INFO - 2015-11-05 15:51:50,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49755/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:50 INFO - 2015-11-05 15:51:50,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 263081984 15:51:50 INFO - 2015-11-05 15:51:50,846 DEBUG : BROWSER_OUTPUT: 15:51:54 INFO - 2015-11-05 15:51:54,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49755/tests/kraken/driver.html?testName=json-parse-financial) 15:51:54 INFO - 2015-11-05 15:51:54,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 265965568 15:51:54 INFO - 2015-11-05 15:51:54,716 DEBUG : BROWSER_OUTPUT: 15:51:56 INFO - 2015-11-05 15:51:56,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:57 INFO - 2015-11-05 15:51:57,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 296935424 15:51:57 INFO - 2015-11-05 15:51:57,025 DEBUG : BROWSER_OUTPUT: 15:51:59 INFO - 2015-11-05 15:51:59,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:59 INFO - 2015-11-05 15:51:59,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 298860544 15:51:59 INFO - 2015-11-05 15:51:59,659 DEBUG : BROWSER_OUTPUT: 15:52:01 INFO - 2015-11-05 15:52:01,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:02 INFO - 2015-11-05 15:52:02,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 306073600 15:52:02 INFO - 2015-11-05 15:52:02,530 DEBUG : BROWSER_OUTPUT: 15:52:05 INFO - 2015-11-05 15:52:05,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:06 INFO - 2015-11-05 15:52:06,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 308350976 15:52:06 INFO - 2015-11-05 15:52:06,003 DEBUG : BROWSER_OUTPUT: 15:52:08 INFO - 2015-11-05 15:52:08,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:09 INFO - 2015-11-05 15:52:09,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 306114560 15:52:09 INFO - 2015-11-05 15:52:09,446 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49755/tests/kraken/driver.html?testName=ai-astar) 15:52:11 INFO - 2015-11-05 15:52:11,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 366194688 15:52:11 INFO - 2015-11-05 15:52:11,602 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,602 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:52:11 INFO - 2015-11-05 15:52:11,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:52:11 INFO - 2015-11-05 15:52:11,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:52:11 INFO - 2015-11-05 15:52:11,602 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:52:11 INFO - 2015-11-05 15:52:11,602 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;132;122;128;129;130;116;126;127;117 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;179;149;191;184;148;172;146;188;182;152 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;186;189;188;189;188;189;189;189;190 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |3;audio-fft;92;93;96;143;80;85;84;82;140;77 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;112;115;162;103;104;106;151;108;103;146 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;142;136;135;141;142;143;135;135;142 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;152;151;147;147;147;147;147;147;146 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;124;121;118;118;124;122;118;119;124 15:52:11 INFO - 2015-11-05 15:52:11,603 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;70;73;73;73;73;72;82;66;70 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;76;77;81;80;79;79;79;78;79 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;97;100;101;101;96;96;97;97;101 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;139;158;155;146;153;139;140;149;143;146 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;170;169;170;172;169;157;177;174;169;159 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;78;80;80;80;79;81;83;84;83 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:52:11 INFO - 2015-11-05 15:52:11,604 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: __startTimestamp1446767531597__endTimestamp 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,605 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.00 Median:127.50 stddev:5.40 (4.2%) stddev-sans-first:5.67 15:52:11 INFO - 2015-11-05 15:52:11,606 DEBUG : BROWSER_OUTPUT: Values: 123.0 132.0 122.0 128.0 129.0 130.0 116.0 126.0 127.0 117.0 15:52:11 INFO - 2015-11-05 15:52:11,606 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,606 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:169.10 Median:180.50 stddev:18.28 (10.1%) stddev-sans-first:19.03 15:52:11 INFO - 2015-11-05 15:52:11,606 DEBUG : BROWSER_OUTPUT: Values: 179.0 149.0 191.0 184.0 148.0 172.0 146.0 188.0 182.0 152.0 15:52:11 INFO - 2015-11-05 15:52:11,606 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,606 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:188.30 Median:189.00 stddev:1.34 (0.7%) stddev-sans-first:1.13 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: Values: 186.0 186.0 189.0 188.0 189.0 188.0 189.0 189.0 189.0 190.0 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.20 Median:84.50 stddev:24.11 (28.5%) stddev-sans-first:25.50 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 96.0 143.0 80.0 85.0 84.0 82.0 140.0 77.0 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.00 Median:113.50 stddev:22.74 (20.0%) stddev-sans-first:23.89 15:52:11 INFO - 2015-11-05 15:52:11,607 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 162.0 103.0 104.0 106.0 151.0 108.0 103.0 146.0 15:52:11 INFO - 2015-11-05 15:52:11,608 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,608 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.30 Median:142.00 stddev:3.53 (2.5%) stddev-sans-first:3.61 15:52:11 INFO - 2015-11-05 15:52:11,608 DEBUG : BROWSER_OUTPUT: Values: 142.0 142.0 136.0 135.0 141.0 142.0 143.0 135.0 135.0 142.0 15:52:11 INFO - 2015-11-05 15:52:11,608 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.00 stddev:1.99 (1.4%) stddev-sans-first:2.09 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: Values: 147.0 152.0 151.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:120.70 Median:121.50 stddev:2.63 (2.2%) stddev-sans-first:2.71 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: Values: 119.0 124.0 121.0 118.0 118.0 124.0 122.0 118.0 119.0 124.0 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,610 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:73.00 stddev:5.21 (7.1%) stddev-sans-first:4.28 15:52:11 INFO - 2015-11-05 15:52:11,611 DEBUG : BROWSER_OUTPUT: Values: 62.0 70.0 73.0 73.0 73.0 73.0 72.0 82.0 66.0 70.0 15:52:11 INFO - 2015-11-05 15:52:11,611 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,611 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.20 Median:79.00 stddev:2.04 (2.6%) stddev-sans-first:1.50 15:52:11 INFO - 2015-11-05 15:52:11,611 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 77.0 81.0 80.0 79.0 79.0 79.0 78.0 79.0 15:52:11 INFO - 2015-11-05 15:52:11,611 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,611 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.70 Median:96.00 stddev:3.16 (3.3%) stddev-sans-first:2.24 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: Values: 91.0 97.0 100.0 101.0 101.0 96.0 96.0 97.0 97.0 101.0 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:147.50 stddev:6.83 (4.6%) stddev-sans-first:6.63 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: Values: 139.0 158.0 155.0 146.0 153.0 139.0 140.0 149.0 143.0 146.0 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:170.00 stddev:6.17 (3.6%) stddev-sans-first:6.52 15:52:11 INFO - 2015-11-05 15:52:11,612 DEBUG : BROWSER_OUTPUT: Values: 170.0 169.0 170.0 172.0 169.0 157.0 177.0 174.0 169.0 159.0 15:52:11 INFO - 2015-11-05 15:52:11,613 DEBUG : BROWSER_OUTPUT: 15:52:11 INFO - 2015-11-05 15:52:11,613 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.10 Median:80.50 stddev:3.14 (3.9%) stddev-sans-first:2.03 15:52:11 INFO - 2015-11-05 15:52:11,613 DEBUG : BROWSER_OUTPUT: Values: 73.0 78.0 80.0 80.0 80.0 79.0 81.0 83.0 84.0 83.0 15:52:11 INFO - 2015-11-05 15:52:11,613 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:52:11 INFO - 2015-11-05 15:52:11,613 DEBUG : BROWSER_OUTPUT: 15:52:12 INFO - 2015-11-05 15:52:12,314 INFO : Browser exited with error code: 0 15:52:12 INFO - 2015-11-05 15:52:12,369 INFO : Completed test kraken (00:01:01) 15:52:12 INFO - 2015-11-05 15:52:12,370 INFO : Starting test v8_7 15:52:12 INFO - 2015-11-05 15:52:12,370 DEBUG : operating with platform_type : mac_ 15:52:12 INFO - 2015-11-05 15:52:12,370 INFO : Initialising browser for v8_7 test... 15:52:12 INFO - 2015-11-05 15:52:12,385 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmptB4pGY/profile http://localhost:49755/getInfo.html 15:52:14 INFO - 2015-11-05 15:52:14,766 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:52:14 INFO - 2015-11-05 15:52:14,767 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:52:14 INFO - 2015-11-05 15:52:14,767 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:52:14 INFO - 2015-11-05 15:52:14,767 DEBUG : BROWSER_OUTPUT: __metrics 15:52:14 INFO - 2015-11-05 15:52:14,787 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:15 INFO - 2015-11-05 15:52:15,578 INFO : Browser initialized. 15:52:15 INFO - 2015-11-05 15:52:15,578 INFO : Running cycle 1/1 for v8_7 test... 15:52:15 INFO - 2015-11-05 15:52:15,579 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmptB4pGY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:52:27 INFO - 2015-11-05 15:52:27,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 200806400 15:52:27 INFO - 2015-11-05 15:52:27,642 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49755/tests/v8_7/run.html (next: http://localhost:49755/tests/v8_7/run.html) 15:52:50 INFO - 2015-11-05 15:52:50,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 516591616 15:52:50 INFO - 2015-11-05 15:52:50,803 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,803 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: |0;Richards;194.77989871445266 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;215.33161068044788 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: |2;Encrypt;372.5782414307005 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6903.448275862069 15:52:50 INFO - 2015-11-05 15:52:50,804 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1186.2396204033214 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: |6;Boyer;14225.352112676057 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: |7;RegExp;34116.666666666664 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: |8;Splay;659.1957811470006 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6649.0066225165565 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: __startTimestamp1446767570795__endTimestamp 15:52:50 INFO - 2015-11-05 15:52:50,805 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:194.78 Median:194.78 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: Values: 194.8 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,806 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:215.33 Median:215.33 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: Values: 215.3 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:372.58 Median:372.58 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: Values: 372.6 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6903.45 Median:6903.45 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: Values: 6903.4 15:52:50 INFO - 2015-11-05 15:52:50,807 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1186.24 Median:1186.24 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: Values: 1186.2 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: Values: 796.8 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,808 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14225.35 Median:14225.35 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: Values: 14225.4 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34116.67 Median:34116.67 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: Values: 34116.7 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:659.20 Median:659.20 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: Values: 659.2 15:52:50 INFO - 2015-11-05 15:52:50,809 DEBUG : BROWSER_OUTPUT: 15:52:50 INFO - 2015-11-05 15:52:50,810 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6649.01 Median:6649.01 stddev:0.00 (0.0%) 15:52:50 INFO - 2015-11-05 15:52:50,810 DEBUG : BROWSER_OUTPUT: Values: 6649.0 15:52:50 INFO - 2015-11-05 15:52:50,810 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:52:50 INFO - 2015-11-05 15:52:50,810 DEBUG : BROWSER_OUTPUT: 15:52:51 INFO - 2015-11-05 15:52:51,513 INFO : Browser exited with error code: 0 15:52:51 INFO - 2015-11-05 15:52:51,536 INFO : Completed test v8_7 (00:00:39) 15:52:52 INFO - 2015-11-05 15:52:52,000 INFO : Completed test suite (00:20:16) 15:52:52 INFO - 2015-11-05 15:52:52,000 DEBUG : Working with test: dromaeo_css 15:52:52 INFO - 2015-11-05 15:52:52,000 DEBUG : Generating results file: dromaeo_css 15:52:52 INFO - 2015-11-05 15:52:52,001 DEBUG : Working with test: kraken 15:52:52 INFO - 2015-11-05 15:52:52,001 DEBUG : Generating results file: kraken 15:52:52 INFO - 2015-11-05 15:52:52,001 INFO : javascript benchmark 15:52:52 INFO - 2015-11-05 15:52:52,001 DEBUG : Working with test: v8_7 15:52:52 INFO - 2015-11-05 15:52:52,001 DEBUG : Generating results file: v8_7 15:52:52 INFO - 2015-11-05 15:52:52,001 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:52:52 INFO - 2015-11-05 15:52:52,058 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 15:52:52 INFO - 2015-11-05 15:52:52,058 DEBUG : process_Request line: dromaeo_css 5742.07 graph.html#tests=[[72,52,55]] 15:52:52 INFO - 2015-11-05 15:52:52,058 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:52:52 INFO - 2015-11-05 15:52:52,085 DEBUG : process_Request line: kraken 1751.20 graph.html#tests=[[232,52,55]] 15:52:52 INFO - 2015-11-05 15:52:52,085 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:52:52 INFO - 2015-11-05 15:52:52,113 DEBUG : process_Request line: v8_7 17635.21 graph.html#tests=[[230,52,55]] 15:52:52 INFO - 2015-11-05 15:52:52,114 INFO : javascript benchmark 15:52:52 INFO - 2015-11-05 15:52:52,116 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [301.96225471816024, 306.1779123054598, 311.54825503020624, 311.7583872498813, 314.9212696825794, 12843.229406235632, 13378.866211337883, 15780.447684331051, 16394.344226230936, 16719.66560668786, 10928.617498387557, 11100.833487497674, 11128.49921753521, 14063.859361406383, 16144.596385090379, 3886.378179491282, 3954.7231693781446, 3968.0278331808604, 3993.7204395692315, 4018.618231268025, 3107.9533806992913, 3221.32352206037, 4097.09863829957, 4109.506859176903, 4290.099079193373, 4240.5547417521175, 4245.469316335458, 4262.318029115342, 4272.829086836538, 4333.068390296085, 4117.773522456264, 4242.490901091858, 4247.384129301265, 4275.7862106894845, 4308.80610372534, 3657.359962006665, 3664.157243833933, 3667.449882517644, 3676.0809797550614, 3710.7216958728204, 11941.462634181482, 12006.819897701542, 12174.634760957186, 12221.511139554406, 12286.262824230485, 1544.8686861616777, 1612.8790340724493, 1613.6691978144452, 1630.6738652269594, 1715.9313627454887, 8470.618822153017, 8478.66085356585, 8614.612342444605, 8638.17937295956, 8663.35024873137, 1332.6601716562311, 1386.3830595385057, 1403.922784246866, 1428.5071650280636, 1452.03439712591, 46482.76758616219, 47914.281285780744, 48250.0, 48299.5170048302, 48513.272300915516, 6034.577579569388, 6035.30593981689, 6069.241344831896, 6080.969595152084, 6083.9391606084255, 6872.553284036521, 6878.037074809531, 6881.518293719391, 6885.483588730765, 6930.410915072174, 4999.800007999712, 5003.674761140514, 5028.19548872186, 5030.170021946411, 5031.144705400017, 5258.447862974409, 5321.8935621287355, 5375.650582712111, 5379.704116273642, 5385.084535628953, 2698.0287096645193, 2700.6489156409934, 2713.9592906106423, 2727.4545090981883, 2742.287005378616, 922.3405265235389, 942.3309450290234, 983.2527279267808, 985.408754747146, 1019.918406527476, 372.7167352811883, 386.2892278208054, 388.1964333828947, 400.3454352134223, 409.9036726369301, 10279.383237005804, 10294.794104118026, 10805.459727013618, 10928.508217130247, 11087.667369978913, 378.87875879718223, 412.91328820947336, 421.9620234178939, 422.82452782095083, 427.9144171165779, 5400.297961265011, 5721.685307308055, 5733.111367738007, 5735.713214339266, 5907.8227653169615, 498604.0, 499817.0, 518136.0, 521818.0, 536153.0, 65339.673301633185, 69735.30264697288, 69879.65060174666, 70723.58552828914, 71788.0, 442.9534898835576, 443.23099422501934, 449.23629829290337, 449.57964303376446, 451.8057235388814, 9154.450732956044, 9705.514724263618, 9851.556679949563, 10002.299839011199, 10081.0, 29447.411051778417, 29600.0, 30562.388752225277, 31225.219369515944, 32086.35827283488, 41702.58297416987, 45141.09717805691, 45328.32007519956, 45820.54179458163, 46074.0, 5520.171974203901, 5701.372848986525, 5717.742701578356, 5761.5390768739235, 5804.100364443518, 10147.289689721649, 10578.947105264424, 10616.681499554717, 10692.89307106919, 10741.89258107409, 9133.908660913306, 9289.0, 9379.718608441484, 9410.38832475887, 9613.471259080818, 8804.515751633466, 9089.181973622406, 9299.256059515357, 9370.203532699798, 9377.718668439958, 7834.451588388758, 7991.920080799117, 8931.821363572823, 9585.616575336908, 9594.088561586637, 5618.943810561842, 5694.772209111589, 5713.143028545752, 5737.655740655574, 5808.564357673107, 9082.137196966278, 9199.218066464158, 9385.671501497414, 9482.28882833804, 9620.855687164558], "dojo.html": [2701.58125490549, 2795.3430943728226, 2796.888124475021, 2833.1783782703005, 2837.0637689562445, 4648.860534183976, 4772.6181905447565, 4780.784864681089, 4790.520947905207, 4885.022995400921, 4761.357216775734, 4771.093492236472, 4790.161721698706, 4791.305260737191, 4838.443578988417, 4295.806688699016, 4433.866983990485, 4473.575010374009, 4485.282354823229, 4530.546945305476, 4399.318105693606, 4519.887002824923, 4531.297648864432, 4535.614472769818, 4552.430946131733, 4396.934045989313, 4414.514403415622, 4476.731396116227, 4553.248713962209, 4582.9541704583025, 4469.016816300409, 4545.227311357077, 4571.085782843411, 4574.771261436915, 4608.585227329523, 4242.109157077018, 4373.300271956472, 4480.932786008212, 4500.167469018209, 4527.592516673515, 4337.298051218493, 4572.5656062674325, 4663.836765713218, 4677.508861569554, 4685.390899183119, 5022.221555658879, 5073.949260507385, 5076.111680455905, 5089.440161582223, 5130.358705161855, 5128.1794912813775, 5134.7689353978785, 5159.2003239497935, 5169.638125331228, 5179.689218646856, 4598.793054312564, 4693.6949098308505, 4715.95284047162, 4772.02173554424, 4833.202521583935, 5211.140161873324, 5338.46615338463, 5344.839654810362, 5357.142857142839, 5359.14253719403, 5010.67430617016, 5061.4179369373, 5074.822381216713, 5091.898162036812, 5128.461511541234, 4983.476734942851, 5084.923726144111, 5111.361079865017, 5174.24973378858, 5194.168932970707, 5018.774155163026, 5046.924296135561, 5129.79480820763, 5139.897202055938, 5141.974290128525, 5076.263941728503, 5076.517730815566, 5092.159793634009, 5111.846644600593, 5134.614903882149, 3747.4940882980995, 3809.466674665549, 3839.481669974518, 3974.940375894364, 4072.6741860651077, 3464.6535346465657, 3541.752077354612, 3570.0360902556686, 3599.3161299353565, 3602.0, 4760.785764640599, 4866.172750632401, 4873.074115917964, 4877.926831097537, 4897.951020489821, 4935.358403407606, 5073.543381095719, 5075.11185542536, 5192.584593232532, 5204.9739751301, 4646.4888862225125, 4740.905181896343, 4752.904941901143, 4793.472718001017, 4816.494268101869, 4476.7090139140855, 4481.529439408815, 4533.478649955231, 4535.705179163409, 4540.8637740867825, 4892.510748925079, 4918.065567542156, 4995.175795993766, 5200.0, 5249.790008399621, 5054.620903432184, 5098.566621837185, 5151.871203219949, 5172.301739265151, 5219.739013049409, 5222.321098257202, 5272.44639312882, 5300.1519756838725, 5314.5216930476445, 5350.545203657733, 4885.413750349981, 5001.699898006132, 5016.573591244639, 5075.467075956972, 5101.591872650253, 5005.324281221989, 5097.6941383517105, 5107.565856902205, 5111.182210846247, 5135.127028405105, 4999.125153098121, 5038.496150384932, 5061.8734531637, 5113.82004645309, 5136.0755064087325, 4812.1578723722505, 4906.190478571139, 4927.704337739747, 5085.186370180753, 5089.745512724275, 4771.093492236464, 4828.830990915301, 4855.684380515397, 4887.60899128076, 4962.156433406401, 4835.58897493717, 5063.5695965843315, 5070.782373517439, 5090.821821236239, 5104.566111880532, 4649.395578574764, 4757.072370887644, 4771.95228047715, 4904.950950490449, 5010.073136469765], "mootools.html": [1176.4176732517394, 1458.496818597584, 1528.946486872959, 1576.605848537865, 1607.879409044322, 5747.367789543152, 6039.5772295939305, 6218.440340369366, 6436.935630643692, 6467.997460393646, 6444.0656104864765, 6446.355364463563, 6489.415952564268, 6575.868482630356, 6583.111279977202, 1882.8305452509305, 1886.6321067391864, 1892.0161516011735, 1894.9526261843425, 1903.5146037760421, 1886.3963531669872, 1895.5734959634042, 1898.4779185723967, 1908.0364415969984, 1914.9617007659838, 1883.9811601883944, 1885.264746748769, 1885.8397036251936, 1886.9056547172586, 1902.6765449873485, 1835.1283140508285, 1835.1925152932668, 1846.2614954018434, 1854.3231720422084, 1868.9345872894519, 1837.5865430278213, 1854.3695143651223, 1878.258088055224, 1894.4979580411202, 1902.657521646103, 5691.260136182311, 6382.840428989266, 6439.066335381343, 6517.087607734921, 6537.0, 3586.6413358664186, 3822.503074600284, 3976.70174736893, 3981.920361592781, 4010.418489319062, 2350.0, 2373.299876536426, 2394.2099107294725, 2415.987920060406, 2429.0648100481267, 682.8804959132132, 686.4508393285352, 696.7491702986921, 700.0, 703.9155301363869, 8423.789405264917, 8451.154884511561, 8556.871646925301, 8560.972683278047, 8579.099194584542, 3459.9481007784902, 3553.182767963383, 3554.2180720241504, 3585.175409655794, 3585.372559802024, 7532.698692052366, 7546.0, 7548.735794247175, 7574.734884279023, 7659.463837531431, 3971.1660551284554, 3994.580569040267, 3998.1603863188475, 4008.2183974124764, 4017.1563971565715, 3614.0603443104983, 3621.9818900905852, 3627.800470974069, 3670.22925185714, 3671.2290419011774, 2987.4771914915236, 3012.307169351018, 3014.9849250753605, 3046.5277881928337, 3071.0172744721476, 934.6822080492665, 949.8052899155656, 953.713885834247, 964.2093483343731, 965.2663975378622, 782.9921700782919, 789.9802504937422, 800.1158719614858, 806.5443024691031, 927.6428574998674, 6012.338642749294, 6034.1853849730605, 6046.062860256668, 6070.180525628984, 6107.6640784757265, 395.14845507930454, 404.18153239689866, 407.0718761224413, 411.70768754184263, 416.13028769871113, 4745.691530050535, 4847.75761211938, 4863.367762190964, 4875.975620121877, 4881.389826271716, 6797.2523022467485, 6928.480363972722, 7427.480076394709, 7524.5861477619255, 7586.279303466162, 7452.403807695371, 7494.587797671181, 7522.699092036367, 7538.585377804274, 7642.579658118857, 5649.12438572022, 5916.23088998436, 5951.077582974646, 6006.579539432285, 6057.57596968208, 5724.570657200643, 5829.941700583109, 5831.7667293307795, 5846.239988801429, 5912.940870591239, 6805.693743781443, 6952.443804495527, 6981.79054628362, 7058.576485410892, 7074.504784665024, 6909.170899492093, 7077.398421134056, 7188.317109874553, 7205.819854503679, 7249.637518124178, 5748.655080695172, 5846.619969701956, 5851.736671849862, 5901.114832775118, 5965.313988891333, 6178.227721534809, 6213.471854892385, 6222.719977601109, 6229.408206220402, 6367.204099487564, 5761.366249712612, 5820.476157145878, 5840.328362238397, 5910.822675319747, 5926.644401335933, 5676.403977582459, 5686.033374326457, 5722.0, 5769.451902069297, 5840.94159058404, 5816.447437493432, 5829.329627092939, 5848.385919478394, 5869.090291004901, 5893.322267939242, 4946.678465899705, 4965.677230979974, 4976.104301225814, 4980.676256043345, 5024.045431368028, 5118.232265160255, 5153.175491921274, 5169.405518365285, 5183.50756678115, 5190.091733946469], "ext.html": [490.1202341796475, 490.34538890581075, 501.9759690231925, 509.8452006205944, 530.0538538708406, 28376.290592735193, 29672.10983670488, 33075.99999999997, 33783.493247601305, 33921.49117763229, 37289.440658390144, 37942.999999999935, 38012.61987380125, 38466.0, 38566.42150367747, 7359.411247100219, 7975.680972761083, 8099.190080991883, 8175.896254005693, 8200.42597018209, 7445.106587209515, 9477.526123693822, 9775.902240977606, 9803.2157427406, 9905.603775848993, 9486.43081415114, 9503.762405939873, 9531.857022144673, 9551.522423878812, 9625.855612165824, 7700.345470635003, 7771.184025677336, 9533.14201721845, 9595.088466595662, 9657.806843863083, 9366.906330936672, 9500.952495237549, 9565.426074435487, 9574.329796914219, 9665.130138287588, 35635.465468018, 35708.0, 35729.46405803915, 36214.0, 36307.81846090779, 2622.8688565571647, 2783.4154827486254, 2955.2611847038243, 3008.443437963984, 3161.96838031619, 21680.783192168034, 21885.12459501618, 21904.561908761894, 22331.55336893269, 23093.307200784002, 1947.4547126804518, 2007.2372498450495, 2043.4993426610577, 2050.1082029317295, 2089.958200835975, 233037.0, 233776.0, 233945.0, 234776.0, 235625.0, 49103.75448122736, 49374.753126234136, 54981.175282370794, 56231.15653265204, 57213.14180287299, 50541.747291264044, 51422.22866657003, 52496.73751631294, 52836.73581632067, 52913.47086529162, 14783.63040923964, 14913.403463861541, 15065.924670376797, 15124.168170750494, 15131.167785771668, 11286.830697539543, 11475.426228688699, 11565.710857228469, 11582.76834463306, 11622.593209237637, 18454.26182952694, 18481.7227741584, 18514.629707405777, 18689.53276168107, 18747.81252187488, 7257.34683878443, 7409.184989651134, 7497.400207983348, 7511.9624401877645, 7555.433342499225, 767.2212704105337, 796.8366484870587, 814.450246083891, 843.2158092973593, 924.1590152960907, 23629.0, 23753.0, 23978.640320395207, 23987.0, 24065.0, 802.2298593350449, 851.2594043182347, 914.6021480655936, 1028.3932479836933, 1077.0, 10029.398236105857, 13544.187348759106, 14125.587441255791, 14331.136952196357, 14612.415503379745, 272012.0, 276578.0, 277222.0, 278256.0, 280074.0, 43530.0, 43617.56382436198, 49909.0, 50031.24953125706, 50923.49076509262, 1251.5119103549623, 1255.2656695832857, 1260.2690439545042, 1261.8864302212844, 1280.6286177008749, 23867.164649237195, 24445.65548894828, 24978.125765598117, 25025.0, 25323.620145698198, 38856.0, 41249.381259281734, 41519.377209342485, 46381.0, 46885.0, 177794.0, 178374.0, 181134.0, 181725.0, 181835.0, 24359.75640243575, 24487.38781530476, 25003.249902502954, 25305.0, 25343.74656253414, 36833.44749828701, 37154.8142259287, 38145.0, 38414.615853841104, 39173.0, 30706.0, 31925.68074319227, 34141.0, 34969.475457867644, 35446.291074177854, 31456.370872581963, 31544.211394715316, 31562.0, 31790.841045794623, 32227.677723222467, 32332.35335293328, 32368.439471657628, 32380.676193237767, 32476.350472989936, 32880.0, 25612.48775024452, 26139.346516337242, 26428.867855661367, 26609.201723948314, 27122.864385677945, 20502.359811215367, 20600.793992059887, 20767.169313227907, 20782.896085519475, 20789.688154677995], "prototype.html": [265.54326558319696, 273.87949302307, 278.708749356922, 288.7011942639369, 295.9230600043988, 5119.360079990001, 5220.373555173375, 5227.764750586223, 5244.501772331627, 5256.7897284108685, 5145.614078944075, 5167.715775632339, 5203.687778733279, 5229.163333866582, 5233.1103712368895, 4121.9175616487655, 4135.25565398229, 4162.250794856925, 4173.6661067114555, 4178.582141785828, 4103.630673239408, 4148.730332528391, 4161.979190104045, 4165.770882601456, 4178.0, 4074.103697186614, 4082.5713300103507, 4133.503979522461, 4136.152088821799, 4146.8133933972895, 4014.1369605534805, 4087.3664581989838, 4090.6727461802984, 4160.583941605815, 4161.687873409476, 3546.6345456998984, 3547.840347184383, 3564.269324788412, 3573.94639080414, 3608.4767708682357, 5081.974590127025, 5093.847184584469, 5107.412647545506, 5124.052050370656, 5143.5113664201845, 4547.590716835501, 4551.203539380628, 4606.193916064675, 4608.723476591415, 4609.239475486541, 5291.047611429941, 5423.972880135613, 5511.779528818843, 5530.419305972855, 5531.004419204542, 3773.9998900291444, 3795.335816232176, 3822.9044273893096, 3823.9426408603895, 3854.3062248795204, 5560.582956278255, 5586.273784408041, 5774.97112514439, 5801.158831969341, 5853.32686741026, 3792.639699228624, 3831.2912111259507, 3845.288621605012, 3859.980700096538, 3888.7083468739957, 3909.6481316681634, 3910.3743401055694, 3921.8823435296986, 3938.428927805452, 3967.5437324708028, 4339.4792624884585, 4347.739135651871, 4415.271480205794, 4481.5294394088805, 4504.752238626841, 5433.049216387117, 5454.7272636368025, 5464.207689884945, 5473.151661492475, 5497.367802702661, 1385.3211926156312, 1416.277698373816, 1417.978730319046, 1418.2979425184599, 1437.9424823006962, 919.1773362840221, 939.3236869453982, 942.0344147249125, 958.1999030809213, 959.7024922274118, 5295.841124766263, 5305.071612467803, 5332.173513105475, 5341.706206158621, 5351.946480535223, 5732.05421105513, 5735.483806457439, 5740.827775166752, 5776.364599894008, 5816.360200377955, 5280.1815718563685, 5303.840884773463, 5338.492843179892, 5363.865903352447, 5372.516473517324, 3054.587630669831, 3091.1962889648853, 3152.274976755359, 3160.241542029896, 3165.287810242677, 5764.221830052889, 5846.619969701956, 5863.29640443141, 5865.266841644794, 5876.206712093898, 5837.737301821343, 5838.737256823369, 5842.065269556851, 5888.028475301528, 5906.438888305604, 5629.662220266797, 5783.566232532577, 5805.709714514342, 5882.647041177543, 5908.4091590841435, 5706.144078388109, 5779.219805326227, 5794.507466865363, 5804.506616937608, 5829.8251052468495, 5554.916676249779, 5598.692071936082, 5637.43625637433, 5652.0674088774895, 5663.235463212578, 5797.681127538026, 5803.245578074823, 5867.383924687846, 5897.11543268496, 5932.970335148297, 3762.9059273518383, 3812.8856134316015, 3842.116313247913, 3949.111449923744, 3959.148783011551, 5488.670679759227, 5659.518940890071, 5675.148727690879, 5733.254676891977, 5741.770329186786, 5342.439043900335, 5433.945660543344, 5495.038368285454, 5509.5041446270025, 5550.4449555044175, 5460.208269800777, 5483.670979741229, 5528.364238112507, 5529.944700553104, 5545.112781954868, 5235.898286238156, 5352.84913743547, 5358.866028349323, 5377.408485066561, 5396.595255355785, 5515.172724091258, 5541.972290138524, 5570.2201691762375, 5604.467575580314, 5612.074007788669, 5364.7049412282695, 5463.699496527729, 5470.64440811346, 5475.425080366664, 5476.726163691879], "yui.html": [587.1457030021317, 652.3378770547897, 669.327326037333, 670.4066900792797, 686.9793906182815, 12120.090993175503, 12165.391730413488, 12167.878321216785, 12308.0, 12517.436715347809, 11638.418079096033, 11734.471948762304, 11787.823182652246, 11810.645680629574, 11915.702107447318, 641.0928536121382, 643.5109316919152, 771.5717776633966, 776.7747353267574, 786.9252421019994, 796.9880451793227, 800.3317230112863, 809.4697972827778, 809.5183365897311, 809.6923169195727, 831.6465502161587, 833.0877688930611, 841.381584535369, 842.3976856547567, 843.2495079379327, 642.7814543055383, 643.6106155775758, 803.7628899474611, 818.3902992270796, 825.0099880143852, 600.3726106219011, 604.8246008657484, 607.7234858139536, 610.2189197826789, 611.9388061193889, 12046.0, 12104.334261615608, 12255.080868934776, 12297.0, 12299.56951506702, 10270.691879243635, 10295.897041029568, 10545.947270263676, 10762.515686794113, 10805.351678899291, 7598.126215485235, 7620.61896905158, 7626.923730762677, 7683.30850223477, 7704.6918123275, 2836.9716302836914, 2846.5018621741115, 2846.985765071182, 2931.4576803291247, 2997.040946896994, 41501.79249103765, 41995.0, 42214.36678449795, 42856.357154642705, 43054.78472607617, 8040.758777236692, 8145.755627331189, 8228.30059444942, 8237.876431853527, 8263.628136733862, 17067.573310667085, 17072.82927170737, 17198.592197092417, 17276.04981725992, 17296.827031729772, 6293.96853015732, 6326.272478665012, 6445.967770161213, 6621.039949207338, 6627.1716035495565, 3264.2329052672603, 3266.2650903546987, 3272.633653170149, 3359.546461227752, 3399.9490007649906, 2511.472590755925, 2537.9238622840976, 2542.555052865741, 2551.987240063788, 2557.514072326252, 353.7824238093554, 361.5227899173119, 368.70503597122195, 371.251927366357, 372.2239131410984, 421.7090207756638, 457.5675986193082, 462.2373084410749, 488.6310835319311, 490.72028943502573, 6491.642959637171, 6561.3438656134, 6601.504887133484, 6620.933790662128, 6641.468682505388, 425.41930265188415, 471.69104236725, 483.35549953352034, 490.5413438435075, 505.2017811857257, 3004.8798048077833, 3097.2566584020124, 3148.9842550787557, 3161.8577164027674, 3201.439748044083, 55174.0, 55185.0, 55275.44724552703, 55773.442265577636, 56052.0, 46855.76572117118, 47650.285245721345, 47765.761171193924, 48372.51627483751, 48425.0, 43206.35190472146, 43830.780846096204, 43906.780466097465, 44068.77965610151, 44793.32810007853, 6103.511719062553, 6207.6275423474735, 6260.686965651608, 6301.495880329471, 6319.96840015797, 31275.53086703747, 32425.837870810494, 32622.184445389055, 32644.34711305808, 32863.178420539676, 38116.809415952746, 41666.58333416627, 42471.3629295567, 42592.78703606462, 43114.0, 7732.0, 7954.007642144466, 7994.360451163777, 8070.515769053875, 8630.027877339755, 8492.0, 8666.956665216634, 8798.34012449056, 8902.198802107841, 9034.728958131267, 7629.961850190713, 7958.880616790869, 8020.959895200486, 8109.351251899716, 8211.973503312085, 8218.753437396888, 8263.380246481658, 8271.95864020676, 8307.584620769057, 8353.0811610724, 7834.373250139861, 8027.117017128228, 8046.1149273578685, 8100.392470564849, 8256.009278886571, 6679.432248258952, 7142.285771422816, 7237.384822290164, 7390.371818395497, 7597.962010189914, 6993.615351155532, 7154.534955228101, 7213.482365665073, 7293.161286451914, 7341.522801017917]}, "summary": {"suite": 5742.069930213734, "subtests": {"jquery.html": {"filtered": 5996.940609008009, "value": 5996.940609008009}, "dojo.html": {"filtered": 4724.622591432408, "value": 4724.622591432408}, "mootools.html": {"filtered": 3585.984084049879, "value": 3585.984084049879}, "ext.html": {"filtered": 16228.31587118106, "value": 16228.31587118106}, "prototype.html": {"filtered": 4175.915101286013, "value": 4175.915101286013}, "yui.html": {"filtered": 5205.1673119804445, "value": 5205.1673119804445}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1446766355, "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": "20151105140759", "branch": "Mozilla-Aurora", "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418"}}, {"talos_counters": {}, "results": {"audio-dft": [186.0, 186.0, 189.0, 188.0, 189.0, 188.0, 189.0, 189.0, 189.0, 190.0], "ai-astar": [123.0, 132.0, 122.0, 128.0, 129.0, 130.0, 116.0, 126.0, 127.0, 117.0], "imaging-gaussian-blur": [142.0, 142.0, 136.0, 135.0, 141.0, 142.0, 143.0, 135.0, 135.0, 142.0], "audio-beat-detection": [179.0, 149.0, 191.0, 184.0, 148.0, 172.0, 146.0, 188.0, 182.0, 152.0], "json-stringify-tinderbox": [74.0, 76.0, 77.0, 81.0, 80.0, 79.0, 79.0, 79.0, 78.0, 79.0], "stanford-crypto-pbkdf2": [170.0, 169.0, 170.0, 172.0, 169.0, 157.0, 177.0, 174.0, 169.0, 159.0], "json-parse-financial": [62.0, 70.0, 73.0, 73.0, 73.0, 73.0, 72.0, 82.0, 66.0, 70.0], "stanford-crypto-sha256-iterative": [73.0, 78.0, 80.0, 80.0, 80.0, 79.0, 81.0, 83.0, 84.0, 83.0], "audio-fft": [92.0, 93.0, 96.0, 143.0, 80.0, 85.0, 84.0, 82.0, 140.0, 77.0], "imaging-darkroom": [147.0, 152.0, 151.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "stanford-crypto-ccm": [139.0, 158.0, 155.0, 146.0, 153.0, 139.0, 140.0, 149.0, 143.0, 146.0], "audio-oscillator": [112.0, 115.0, 162.0, 103.0, 104.0, 106.0, 151.0, 108.0, 103.0, 146.0], "stanford-crypto-aes": [91.0, 97.0, 100.0, 101.0, 101.0, 96.0, 96.0, 97.0, 97.0, 101.0], "imaging-desaturate": [119.0, 124.0, 121.0, 118.0, 118.0, 124.0, 122.0, 118.0, 119.0, 124.0]}, "summary": {"suite": 1751.2, "subtests": {"audio-fft": {"filtered": 97.2, "value": 97.2}, "stanford-crypto-pbkdf2": {"filtered": 168.6, "value": 168.6}, "audio-beat-detection": {"filtered": 169.1, "value": 169.1}, "stanford-crypto-ccm": {"filtered": 146.8, "value": 146.8}, "imaging-darkroom": {"filtered": 147.8, "value": 147.8}, "json-parse-financial": {"filtered": 71.4, "value": 71.4}, "audio-oscillator": {"filtered": 121.0, "value": 121.0}, "ai-astar": {"filtered": 125.0, "value": 125.0}, "audio-dft": {"filtered": 188.3, "value": 188.3}, "stanford-crypto-sha256-iterative": {"filtered": 80.1, "value": 80.1}, "json-stringify-tinderbox": {"filtered": 78.2, "value": 78.2}, "imaging-gaussian-blur": {"filtered": 139.3, "value": 139.3}, "stanford-crypto-aes": {"filtered": 97.7, "value": 97.7}, "imaging-desaturate": {"filtered": 120.7, "value": 120.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1446766355, "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": "20151105140759", "branch": "Mozilla-Aurora", "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418"}}, {"talos_counters": {}, "results": {"DeltaBlue": [215.33161068044788], "Encrypt": [372.5782414307005], "NavierStokes": [6649.0066225165565], "Decrypt": [6903.448275862069], "Splay": [659.1957811470006], "Richards": [194.77989871445266], "RegExp": [34116.666666666664], "Earley": [796.8127490039841], "Boyer": [14225.352112676057], "RayTrace": [1186.2396204033214]}, "summary": {"suite": 17635.212566753635, "subtests": {"DeltaBlue": {"filtered": 307.051992, "value": 307.051992}, "Encrypt": {"filtered": 714.429804, "value": 714.429804}, "NavierStokes": {"filtered": 223.191235059761, "value": 223.191235059761}, "Decrypt": {"filtered": 38.55768731268734, "value": 38.55768731268734}, "Splay": {"filtered": 123.621847, "value": 123.621847}, "RegExp": {"filtered": 26.7020517830972, "value": 26.7020517830972}, "Richards": {"filtered": 181.24046799999994, "value": 181.24046799999994}, "Earley": {"filtered": 836.4110649999999, "value": 836.4110649999999}, "Boyer": {"filtered": 46.85036930693073, "value": 46.85036930693073}, "RayTrace": {"filtered": 623.8107269999999, "value": 623.8107269999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1446766355, "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": "20151105140759", "branch": "Mozilla-Aurora", "revision": "e2c16a69c24a6eb733663b7ac874bdac7b376418"}}] 15:52:52 INFO - RETURN: dromaeo_css: 5742.07 15:52:52 INFO - RETURN: kraken: 1751.20 15:52:52 INFO - RETURN: v8_7: 17635.21 15:52:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17635.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1751.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5742.07"}}} 15:52:52 INFO - Return code: 0 15:52:52 INFO - # TBPL SUCCESS # 15:52:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:52:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:52:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:52:52 INFO - 2015-11-05 15:52:52.198 screenresolution[2219:15915] starting screenresolution argv=screenresolution get 15:52:52 INFO - 2015-11-05 15:52:52.201 screenresolution[2219:15915] Display 0: 1600x1200x32@60 15:52:52 INFO - 2015-11-05 15:52:52.208 screenresolution[2220:15918] starting screenresolution argv=screenresolution list 15:52:52 INFO - Available Modes on Display 0 15:52:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:52:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:52:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:52:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:52:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:52:52 INFO - Intel HD Graphics 3000: 15:52:52 INFO - Chipset Model: Intel HD Graphics 3000 15:52:52 INFO - Type: GPU 15:52:52 INFO - Bus: Built-In 15:52:52 INFO - VRAM (Total): 512 MB 15:52:52 INFO - VRAM (Dynamic, Max): 10 15:52:52 INFO - Vendor: Intel (0x8086) 15:52:52 INFO - Device ID: 0x0116 15:52:52 INFO - Revision ID: 0x0009 15:52:52 INFO - Displays: 15:52:52 INFO - Display: 15:52:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:52:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:52:52 INFO - Display Serial Number: 1600x1200 60 15:52:52 INFO - Main Display: Yes 15:52:52 INFO - Mirror: Off 15:52:52 INFO - Online: Yes 15:52:52 INFO - Rotation: Supported 15:52:52 INFO - Return code: 0 15:52:52 INFO - Running post-action listener: _resource_record_post_action 15:52:52 INFO - Running post-run listener: _resource_record_post_run 15:52:53 INFO - Total resource usage - Wall time: 1259s; CPU: 30.0%; Read bytes: 643072; Write bytes: 685691904; Read time: 341; Write time: 41283 15:52:53 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 337527296; Write bytes: 334983168; Read time: 36090; Write time: 5103 15:52:53 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 643072; Write bytes: 339608576; Read time: 341; Write time: 35436 15:52:53 INFO - Running post-run listener: _upload_blobber_files 15:52:53 INFO - Blob upload gear active. 15:52:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:52:53 INFO - Copying logs to upload dir... 15:52:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.672275 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-11-05 15:52:53.640451) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 15:52:53.643820) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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/-wLLj2VcR3Crouj8l_PGpQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010892 build_url: 'https://queue.taskcluster.net/v1/task/-wLLj2VcR3Crouj8l_PGpQ/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-05 15:52:53.672870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:52:53.673332) ========= 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.sWSyQBNiZ2/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.5e9ZsthKct/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.005605 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 15:52:53.723830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 15:52:53.724209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 15:52:53.724710) ========= ========= Total master_lag: 0.25 =========