builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0002 starttime: 1448988033.86 results: success (0) buildid: 20151201072831 builduid: 4ace1663451c44c7929d86006c8d9005 revision: 77de40d65ca2359f1dfe7f23640e58866a654711 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:33.863537) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:33.863935) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:33.864228) ========= 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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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.005591 basedir: '/builds/slave/test' ========= master_lag: 0.30 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.168561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.168864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.198542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.198902) ========= 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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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.005206 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.247512) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.247795) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.248137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.248404) ========= 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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-12-01 08:40:34-- 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% 18.6M=0.001s 2015-12-01 08:40:34 (18.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.274623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.535762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.539105) ========= 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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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.160737 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:34.708923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-01 08:40:34.709245) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 77de40d65ca2359f1dfe7f23640e58866a654711 --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 77de40d65ca2359f1dfe7f23640e58866a654711 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-12-01 08:40:34,793 truncating revision to first 12 chars 2015-12-01 08:40:34,793 Setting DEBUG logging. 2015-12-01 08:40:34,793 attempt 1/10 2015-12-01 08:40:34,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/77de40d65ca2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-01 08:40:36,114 unpacking tar archive at: mozilla-aurora-77de40d65ca2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.818912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-01 08:40:36.540660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:36.541039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:36.549694) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:36.550035) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 08:40:36.550454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 5 secs) (at 2015-12-01 08:40:36.550732) ========= /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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:40:36 INFO - MultiFileLogger online at 20151201 08:40:36 in /builds/slave/test 08:40:36 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 08:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:36 INFO - {'append_to_log': False, 08:40:36 INFO - 'base_work_dir': '/builds/slave/test', 08:40:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:36 INFO - 'branch': 'Mozilla-Aurora', 08:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:36 INFO - 'config_files': ('talos/mac_config.py',), 08:40:36 INFO - 'default_actions': ('clobber', 08:40:36 INFO - 'read-buildbot-config', 08:40:36 INFO - 'download-and-extract', 08:40:36 INFO - 'populate-webroot', 08:40:36 INFO - 'create-virtualenv', 08:40:36 INFO - 'install', 08:40:36 INFO - 'run-tests'), 08:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:36 INFO - 'download_minidump_stackwalk': True, 08:40:36 INFO - 'download_symbols': 'ondemand', 08:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:36 INFO - 'installer_path': 'installer.exe', 08:40:36 INFO - 'log_level': 'info', 08:40:36 INFO - 'log_name': 'talos', 08:40:36 INFO - 'log_to_console': True, 08:40:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:36 INFO - 'opt_config_files': (), 08:40:36 INFO - 'pip_index': False, 08:40:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:36 INFO - 'cmd': ('bash', 08:40:36 INFO - '-c', 08:40:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:36 INFO - 'enabled': True, 08:40:36 INFO - 'halt_on_failure': False, 08:40:36 INFO - 'name': 'check_screen_resolution'},), 08:40:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:36 INFO - 'cmd': ('bash', 08:40:36 INFO - '-c', 08:40:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:36 INFO - 'enabled': True, 08:40:36 INFO - 'halt_on_failure': False, 08:40:36 INFO - 'name': 'check_screen_resolution'},), 08:40:36 INFO - 'run_cmd_checks_enabled': True, 08:40:36 INFO - 'sps_profile': False, 08:40:36 INFO - 'sps_profile_interval': 0, 08:40:36 INFO - 'suite': 'dromaeojs', 08:40:36 INFO - 'system_bits': '64', 08:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:36 INFO - 'title': 't-yosemite-r5-0002', 08:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:36 INFO - 'use_talos_json': True, 08:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:36 INFO - 'work_dir': 'build'} 08:40:36 INFO - ##### 08:40:36 INFO - ##### Running clobber step. 08:40:36 INFO - ##### 08:40:36 INFO - Running pre-action listener: _resource_record_pre_action 08:40:36 INFO - Running main action method: clobber 08:40:36 INFO - rmtree: /builds/slave/test/build 08:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:42 INFO - Running post-action listener: _resource_record_post_action 08:40:42 INFO - ##### 08:40:42 INFO - ##### Running read-buildbot-config step. 08:40:42 INFO - ##### 08:40:42 INFO - Running pre-action listener: _resource_record_pre_action 08:40:42 INFO - Running main action method: read_buildbot_config 08:40:42 INFO - Using buildbot properties: 08:40:42 INFO - { 08:40:42 INFO - "properties": { 08:40:42 INFO - "buildnumber": 286, 08:40:42 INFO - "product": "firefox", 08:40:42 INFO - "script_repo_revision": "production", 08:40:42 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 08:40:42 INFO - "repository": "", 08:40:42 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 08:40:42 INFO - "buildid": "20151201072831", 08:40:42 INFO - "slavename": "t-yosemite-r5-0002", 08:40:42 INFO - "pgo_build": "False", 08:40:42 INFO - "basedir": "/builds/slave/test", 08:40:42 INFO - "project": "", 08:40:42 INFO - "platform": "yosemite", 08:40:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:40:42 INFO - "slavebuilddir": "test", 08:40:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:40:42 INFO - "branch": "mozilla-aurora", 08:40:42 INFO - "repo_path": "releases/mozilla-aurora", 08:40:42 INFO - "stage_platform": "macosx64", 08:40:42 INFO - "builduid": "4ace1663451c44c7929d86006c8d9005", 08:40:42 INFO - "revision": "77de40d65ca2359f1dfe7f23640e58866a654711" 08:40:42 INFO - }, 08:40:42 INFO - "sourcestamp": { 08:40:42 INFO - "repository": "", 08:40:42 INFO - "hasPatch": false, 08:40:42 INFO - "project": "", 08:40:42 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:40:42 INFO - "changes": [ 08:40:42 INFO - { 08:40:42 INFO - "category": null, 08:40:42 INFO - "files": [ 08:40:42 INFO - { 08:40:42 INFO - "url": null, 08:40:42 INFO - "name": "https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 08:40:42 INFO - } 08:40:42 INFO - ], 08:40:42 INFO - "repository": "", 08:40:42 INFO - "rev": "77de40d65ca2359f1dfe7f23640e58866a654711", 08:40:42 INFO - "who": "cbook@mozilla.com", 08:40:42 INFO - "when": 1448988011, 08:40:42 INFO - "number": 6727977, 08:40:42 INFO - "comments": "Bug 1220021 (part 2) - Add four reftests. r=seth, a=lizzard", 08:40:42 INFO - "project": "", 08:40:42 INFO - "at": "Tue 01 Dec 2015 08:40:11", 08:40:42 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:40:42 INFO - "revlink": "", 08:40:42 INFO - "properties": [ 08:40:42 INFO - [ 08:40:42 INFO - "buildid", 08:40:42 INFO - "20151201072831", 08:40:42 INFO - "Change" 08:40:42 INFO - ], 08:40:42 INFO - [ 08:40:42 INFO - "builduid", 08:40:42 INFO - "4ace1663451c44c7929d86006c8d9005", 08:40:42 INFO - "Change" 08:40:42 INFO - ], 08:40:42 INFO - [ 08:40:42 INFO - "pgo_build", 08:40:42 INFO - "False", 08:40:42 INFO - "Change" 08:40:42 INFO - ] 08:40:42 INFO - ], 08:40:42 INFO - "revision": "77de40d65ca2359f1dfe7f23640e58866a654711" 08:40:42 INFO - } 08:40:42 INFO - ], 08:40:42 INFO - "revision": "77de40d65ca2359f1dfe7f23640e58866a654711" 08:40:42 INFO - } 08:40:42 INFO - } 08:40:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 08:40:42 INFO - Running post-action listener: _resource_record_post_action 08:40:42 INFO - ##### 08:40:42 INFO - ##### Running download-and-extract step. 08:40:42 INFO - ##### 08:40:42 INFO - Running pre-action listener: _resource_record_pre_action 08:40:42 INFO - Running main action method: download_and_extract 08:40:42 INFO - mkdir: /builds/slave/test/build/tests 08:40:42 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')]} 08:40:42 INFO - https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/test_packages.json 08:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/test_packages.json 08:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:40:43 INFO - Downloaded 1149 bytes. 08:40:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:40:43 INFO - Using the following test package requirements: 08:40:43 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:40:43 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 08:40:43 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'jsshell-mac.zip'], 08:40:43 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 08:40:43 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:40:43 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 08:40:43 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 08:40:43 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 08:40:43 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:40:43 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:40:43 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 08:40:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:40:43 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')]} 08:40:43 INFO - https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:40:44 INFO - Downloaded 17490085 bytes. 08:40:44 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 08:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:40:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:40:58 INFO - Return code: 0 08:40:58 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 08:40:58 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')]} 08:40:58 INFO - https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:40:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:40:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:40:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:41:04 INFO - Downloaded 17490085 bytes. 08:41:04 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 08:41:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:41:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:41:17 INFO - Return code: 0 08:41: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')]} 08:41:17 INFO - https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:41:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:41:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:41:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:41:18 INFO - Downloaded 11131307 bytes. 08:41:18 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 08:41:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:41:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:41:18 INFO - Return code: 0 08:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:18 INFO - https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:41:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:41:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:41:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 08:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:41:22 INFO - Downloaded 108649427 bytes. 08:41:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:41:22 INFO - mkdir: /builds/slave/test/properties 08:41:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:22 INFO - Contents: 08:41:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:41:22 INFO - Running post-action listener: _resource_record_post_action 08:41:22 INFO - Running post-action listener: set_extra_try_arguments 08:41:22 INFO - ##### 08:41:22 INFO - ##### Running populate-webroot step. 08:41:22 INFO - ##### 08:41:22 INFO - Running pre-action listener: _resource_record_pre_action 08:41:22 INFO - Running main action method: populate_webroot 08:41:22 INFO - Guessing talos json url... 08:41: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')]} 08:41:22 INFO - https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 08:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ellj15wkTsaXZ1ImWkZb8w/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 08:41:23 INFO - Downloaded 107 bytes. 08:41:23 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:41:23 INFO - Contents: 08:41:23 INFO - 20151201072831 08:41:23 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/77de40d65ca2359f1dfe7f23640e58866a654711 08:41:23 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')]} 08:41:23 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/77de40d65c/testing/talos/talos.json 08:41:23 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/77de40d65c/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:41:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/77de40d65c/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:41:23 INFO - Downloaded 4264 bytes. 08:41:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:23 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:41:23 INFO - '../fennec_ids.txt'], 08:41:23 INFO - 'tests': ['tcheck2']}, 08:41:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:23 INFO - '--tppagecycles', 08:41:23 INFO - '7'], 08:41:23 INFO - 'tests': ['tsvgm']}}, 08:41:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:41:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:41:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:41:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'tests': ['damp', 'tps']}, 08:41:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['damp', 'tps']}, 08:41:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:41:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:23 INFO - 'other': {'tests': ['a11yr', 08:41:23 INFO - 'ts_paint', 08:41:23 INFO - 'tpaint', 08:41:23 INFO - 'sessionrestore', 08:41:23 INFO - 'sessionrestore_no_auto_restore']}, 08:41:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['a11yr', 08:41:23 INFO - 'ts_paint', 08:41:23 INFO - 'tpaint', 08:41:23 INFO - 'sessionrestore', 08:41:23 INFO - 'sessionrestore_no_auto_restore']}, 08:41:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['a11yr', 08:41:23 INFO - 'ts_paint', 08:41:23 INFO - 'tpaint', 08:41:23 INFO - 'sessionrestore', 08:41:23 INFO - 'sessionrestore_no_auto_restore']}, 08:41:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['a11yr', 08:41:23 INFO - 'ts_paint', 08:41:23 INFO - 'tpaint', 08:41:23 INFO - 'sessionrestore', 08:41:23 INFO - 'sessionrestore_no_auto_restore']}, 08:41:23 INFO - 'other_l64': {'tests': ['a11yr', 08:41:23 INFO - 'ts_paint', 08:41:23 INFO - 'tpaint', 08:41:23 INFO - 'sessionrestore', 08:41:23 INFO - 'sessionrestore_no_auto_restore']}, 08:41:23 INFO - 'other_nol64': {'tests': ['a11yr', 08:41:23 INFO - 'ts_paint', 08:41:23 INFO - 'tpaint', 08:41:23 INFO - 'sessionrestore', 08:41:23 INFO - 'sessionrestore_no_auto_restore']}, 08:41:23 INFO - 'svgr': {'tests': ['tsvgx', 08:41:23 INFO - 'tsvgr_opacity', 08:41:23 INFO - 'tart', 08:41:23 INFO - 'tscrollx', 08:41:23 INFO - 'cart']}, 08:41:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['tsvgx', 08:41:23 INFO - 'tsvgr_opacity', 08:41:23 INFO - 'tart', 08:41:23 INFO - 'tscrollx', 08:41:23 INFO - 'cart']}, 08:41:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'tests': ['tp5o']}, 08:41:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'talos_options': ['--e10s'], 08:41:23 INFO - 'tests': ['tp5o']}, 08:41:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'talos_options': ['--xperf_path', 08:41:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:23 INFO - 'tests': ['tp5n']}, 08:41:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:23 INFO - 'talos_options': ['--e10s', 08:41:23 INFO - '--xperf_path', 08:41:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:41:23 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:41:23 INFO - 'tests': ['tp5n']}}, 08:41:23 INFO - 'talos.zip': {'path': '', 08:41:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:23 INFO - Running post-action listener: _resource_record_post_action 08:41:23 INFO - ##### 08:41:23 INFO - ##### Running create-virtualenv step. 08:41:23 INFO - ##### 08:41:23 INFO - Running pre-action listener: _resource_record_pre_action 08:41:23 INFO - Running main action method: create_virtualenv 08:41:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:23 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 08:41:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:24 INFO - Using real prefix '/tools/python27' 08:41:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:31 INFO - Installing pip.................done. 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41: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', 'pip>=1.5'] in /builds/slave/test/build 08:41: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 pip>=1.5 08:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:31 INFO - 'HOME': '/Users/cltbld', 08:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PAGER': '/bin/cat', 08:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:31 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - 'XPC_FLAGS': '0x0', 08:41:31 INFO - 'XPC_SERVICE_NAME': '0', 08:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 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 08:41:31 INFO - Cleaning up... 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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', '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 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08:41: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 psutil>=0.7.1 08:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:31 INFO - 'HOME': '/Users/cltbld', 08:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PAGER': '/bin/cat', 08:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:31 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - 'XPC_FLAGS': '0x0', 08:41:31 INFO - 'XPC_SERVICE_NAME': '0', 08:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Downloading/unpacking psutil>=0.7.1 08:41:31 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 08:41:31 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 08:41:31 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 08:41:31 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 08:41:31 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 08:41:31 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 08:41:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:41:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:34 INFO - Installing collected packages: psutil 08:41:34 INFO - Running setup.py install for psutil 08:41:34 INFO - building 'psutil._psutil_osx' extension 08:41:34 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 08:41:36 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 08:41:36 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 08:41:36 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 08:41:37 INFO - building 'psutil._psutil_posix' extension 08:41:37 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 08:41:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:41:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:41:37 INFO - ^ 08:41:37 INFO - 1 warning generated. 08:41:37 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 08:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:37 INFO - Successfully installed psutil 08:41:37 INFO - Cleaning up... 08:41:37 INFO - Return code: 0 08:41:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:41:37 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')]} 08:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:37 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')]} 08:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:37 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 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41:37 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 08:41:37 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 08:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:37 INFO - 'HOME': '/Users/cltbld', 08:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:37 INFO - 'LOGNAME': 'cltbld', 08:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:37 INFO - 'MOZ_NO_REMOTE': '1', 08:41:37 INFO - 'NO_EM_RESTART': '1', 08:41:37 INFO - 'PAGER': '/bin/cat', 08:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:37 INFO - 'PWD': '/builds/slave/test', 08:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:37 INFO - 'SHELL': '/bin/bash', 08:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:37 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:37 INFO - 'USER': 'cltbld', 08:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:37 INFO - 'XPC_FLAGS': '0x0', 08:41:37 INFO - 'XPC_SERVICE_NAME': '0', 08:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:41:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:41:40 INFO - Installing collected packages: mozsystemmonitor 08:41:40 INFO - Running setup.py install for mozsystemmonitor 08:41:40 INFO - Successfully installed mozsystemmonitor 08:41:40 INFO - Cleaning up... 08:41:40 INFO - Return code: 0 08:41:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:40 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 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41:40 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 08:41:40 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 08:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:40 INFO - 'HOME': '/Users/cltbld', 08:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:40 INFO - 'LOGNAME': 'cltbld', 08:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:40 INFO - 'MOZ_NO_REMOTE': '1', 08:41:40 INFO - 'NO_EM_RESTART': '1', 08:41:40 INFO - 'PAGER': '/bin/cat', 08:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:40 INFO - 'PWD': '/builds/slave/test', 08:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:40 INFO - 'SHELL': '/bin/bash', 08:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:40 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:40 INFO - 'USER': 'cltbld', 08:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:40 INFO - 'XPC_FLAGS': '0x0', 08:41:40 INFO - 'XPC_SERVICE_NAME': '0', 08:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:40 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 08:41:40 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 08:41:40 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 08:41:40 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 08:41:40 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 08:41:40 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 08:41:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:43 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 08:41:43 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 08:41:43 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 08:41:43 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 08:41:43 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 08:41:43 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 08:41:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:44 INFO - Downloading docopt-0.6.1.tar.gz 08:41:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:44 INFO - Running setup.py install for blobuploader 08:41:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:44 INFO - Running setup.py install for requests 08:41:45 INFO - Running setup.py install for docopt 08:41:45 INFO - Successfully installed blobuploader requests docopt 08:41:45 INFO - Cleaning up... 08:41:45 INFO - Return code: 0 08:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 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 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41:45 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 08:41:45 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 08:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:45 INFO - 'HOME': '/Users/cltbld', 08:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:45 INFO - 'LOGNAME': 'cltbld', 08:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:45 INFO - 'MOZ_NO_REMOTE': '1', 08:41:45 INFO - 'NO_EM_RESTART': '1', 08:41:45 INFO - 'PAGER': '/bin/cat', 08:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:45 INFO - 'PWD': '/builds/slave/test', 08:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:45 INFO - 'SHELL': '/bin/bash', 08:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:45 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:45 INFO - 'USER': 'cltbld', 08:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:45 INFO - 'XPC_FLAGS': '0x0', 08:41:45 INFO - 'XPC_SERVICE_NAME': '0', 08:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-mi2A3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-ygZzXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-9Q7Tga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-gX6zzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-4b2Sgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-7y1EWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-9YYCZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:46 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-XUnh1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-zcAqwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-WUOwD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-lxSPpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-uzhTze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-Tl66ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-6EmaIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-pG8FaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:47 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-ujy295-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:48 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-ukaFxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:48 INFO - Running setup.py install for manifestparser 08:41:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for mozcrash 08:41:48 INFO - Running setup.py install for mozdebug 08:41:48 INFO - Running setup.py install for mozdevice 08:41:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for mozfile 08:41:49 INFO - Running setup.py install for mozhttpd 08:41:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Running setup.py install for mozinfo 08:41:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Running setup.py install for mozInstall 08:41:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Running setup.py install for mozleak 08:41:49 INFO - Running setup.py install for mozlog 08:41:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:50 INFO - Running setup.py install for moznetwork 08:41:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:50 INFO - Running setup.py install for mozprocess 08:41:50 INFO - Running setup.py install for mozprofile 08:41:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:50 INFO - Running setup.py install for mozrunner 08:41:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:50 INFO - Running setup.py install for mozscreenshot 08:41:50 INFO - Running setup.py install for moztest 08:41:51 INFO - Running setup.py install for mozversion 08:41:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:51 INFO - Cleaning up... 08:41:51 INFO - Return code: 0 08:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:51 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 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41:51 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 08:41:51 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 08:41:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:51 INFO - 'HOME': '/Users/cltbld', 08:41:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:51 INFO - 'LOGNAME': 'cltbld', 08:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:51 INFO - 'MOZ_NO_REMOTE': '1', 08:41:51 INFO - 'NO_EM_RESTART': '1', 08:41:51 INFO - 'PAGER': '/bin/cat', 08:41:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:51 INFO - 'PWD': '/builds/slave/test', 08:41:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:51 INFO - 'SHELL': '/bin/bash', 08:41:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:51 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:51 INFO - 'USER': 'cltbld', 08:41:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:51 INFO - 'XPC_FLAGS': '0x0', 08:41:51 INFO - 'XPC_SERVICE_NAME': '0', 08:41:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:51 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-W7OU1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:51 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)) 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:51 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-zMGABD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:51 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)) 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:51 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-pzJCdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-iGvfY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-LoVrVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-PuM7Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-nq_FkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-vxRMwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-sCr5rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-vfYWp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:52 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)) 08:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:52 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-BsK2TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:53 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-f3Dj23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:53 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-y8sGBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:53 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-f9ZT1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:53 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-J7t_vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:53 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-fTTWzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:53 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)) 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:53 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-GSwGZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:53 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)) 08:41:53 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)) 08:41: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:53 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)) 08:41:53 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)) 08:41:53 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)) 08:41:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:56 INFO - Downloading blessings-1.5.1.tar.gz 08:41:56 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 08:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:56 INFO - Installing collected packages: blessings 08:41:56 INFO - Running setup.py install for blessings 08:41:56 INFO - Successfully installed blessings 08:41:56 INFO - Cleaning up... 08:41:56 INFO - Return code: 0 08:41:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:56 INFO - Reading from file tmpfile_stdout 08:41:56 INFO - Current package versions: 08:41:56 INFO - blessings == 1.5.1 08:41:56 INFO - blobuploader == 1.2.4 08:41:56 INFO - docopt == 0.6.1 08:41:56 INFO - manifestparser == 1.1 08:41:56 INFO - mozInstall == 1.12 08:41:56 INFO - mozcrash == 0.16 08:41:56 INFO - mozdebug == 0.1 08:41:56 INFO - mozdevice == 0.46 08:41:56 INFO - mozfile == 1.2 08:41:56 INFO - mozhttpd == 0.7 08:41:56 INFO - mozinfo == 0.8 08:41:56 INFO - mozleak == 0.1 08:41:56 INFO - mozlog == 3.0 08:41:56 INFO - moznetwork == 0.27 08:41:56 INFO - mozprocess == 0.22 08:41:56 INFO - mozprofile == 0.27 08:41:56 INFO - mozrunner == 6.11 08:41:56 INFO - mozscreenshot == 0.1 08:41:56 INFO - mozsystemmonitor == 0.0 08:41:56 INFO - moztest == 0.7 08:41:56 INFO - mozversion == 1.4 08:41:56 INFO - psutil == 3.1.1 08:41:56 INFO - requests == 1.2.3 08:41:56 INFO - wsgiref == 0.1.2 08:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b6dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b749228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb1f2cf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, '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.k32x0WxAwn/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.ArsCog6PRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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 08:41:56 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 08:41:56 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 08:41:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:41:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:56 INFO - 'HOME': '/Users/cltbld', 08:41:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:56 INFO - 'LOGNAME': 'cltbld', 08:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:56 INFO - 'MOZ_NO_REMOTE': '1', 08:41:56 INFO - 'NO_EM_RESTART': '1', 08:41:56 INFO - 'PAGER': '/bin/cat', 08:41:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:56 INFO - 'PWD': '/builds/slave/test', 08:41:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:56 INFO - 'SHELL': '/bin/bash', 08:41:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:41:56 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:41:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:56 INFO - 'USER': 'cltbld', 08:41:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:56 INFO - 'XPC_FLAGS': '0x0', 08:41:56 INFO - 'XPC_SERVICE_NAME': '0', 08:41:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 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)) 08:41:57 INFO - Cleaning up... 08:41:57 INFO - Return code: 0 08:41:57 INFO - Running post-action listener: _resource_record_post_action 08:41:57 INFO - Running post-action listener: _start_resource_monitoring 08:41:57 INFO - Starting resource monitoring. 08:41:57 INFO - ##### 08:41:57 INFO - ##### Running install step. 08:41:57 INFO - ##### 08:41:57 INFO - Running pre-action listener: _resource_record_pre_action 08:41:57 INFO - Running main action method: install 08:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:57 INFO - Reading from file tmpfile_stdout 08:41:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:57 INFO - Reading from file tmpfile_stdout 08:41:57 INFO - Output received: 08:41:57 INFO - Usage: mozinstall [options] installer 08:41:57 INFO - Options: 08:41:57 INFO - -h, --help show this help message and exit 08:41:57 INFO - -d DEST, --destination=DEST 08:41:57 INFO - Directory to install application into. [default: 08:41:57 INFO - "/builds/slave/test"] 08:41:57 INFO - --app=APP Application being installed. [default: firefox] 08:41:57 INFO - mkdir: /builds/slave/test/build/application 08:41:57 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'] 08:41:57 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 08:42:35 INFO - Reading from file tmpfile_stdout 08:42:35 INFO - Output received: 08:42:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:42:36 INFO - Running post-action listener: _resource_record_post_action 08:42:36 INFO - ##### 08:42:36 INFO - ##### Running run-tests step. 08:42:36 INFO - ##### 08:42:36 INFO - Running pre-action listener: _resource_record_pre_action 08:42:36 INFO - Running main action method: run_tests 08:42:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:42:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:42:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:42:36 INFO - 2015-12-01 08:42:36.016 screenresolution[1657:12760] starting screenresolution argv=screenresolution get 08:42:36 INFO - 2015-12-01 08:42:36.020 screenresolution[1657:12760] Display 0: 1600x1200x32@60 08:42:36 INFO - 2015-12-01 08:42:36.026 screenresolution[1658:12762] starting screenresolution argv=screenresolution list 08:42:36 INFO - Available Modes on Display 0 08:42:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:42:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:42:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:42:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:42:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:42:36 INFO - Intel HD Graphics 3000: 08:42:36 INFO - Chipset Model: Intel HD Graphics 3000 08:42:36 INFO - Type: GPU 08:42:36 INFO - Bus: Built-In 08:42:36 INFO - VRAM (Total): 512 MB 08:42:36 INFO - VRAM (Dynamic, Max): 10 08:42:36 INFO - Vendor: Intel (0x8086) 08:42:36 INFO - Device ID: 0x0116 08:42:36 INFO - Revision ID: 0x0009 08:42:36 INFO - Displays: 08:42:36 INFO - Display: 08:42:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:42:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:42:36 INFO - Display Serial Number: 1600x1200 60 08:42:36 INFO - Main Display: Yes 08:42:36 INFO - Mirror: Off 08:42:36 INFO - Online: Yes 08:42:36 INFO - Rotation: Supported 08:42:36 INFO - Return code: 0 08:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:36 INFO - Python 2.7.3 08:42:36 INFO - Return code: 0 08:42:36 INFO - grabbing minidump binary from tooltool 08:42:36 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')]} 08:42:36 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 0x10b6919f0>, '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 0x10b3f0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:36 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 08:42:36 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 08:42:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:36 INFO - Return code: 0 08:42:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:42:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:42:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:36 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/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0002', '--webServer', 'localhost'] in /builds/slave/test/build 08:42:36 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/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0002 --webServer localhost 08:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k32x0WxAwn/Render', 08:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:36 INFO - 'HOME': '/Users/cltbld', 08:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:36 INFO - 'LOGNAME': 'cltbld', 08:42:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:36 INFO - 'MOZ_NO_REMOTE': '1', 08:42:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:36 INFO - 'NO_EM_RESTART': '1', 08:42:36 INFO - 'PAGER': '/bin/cat', 08:42:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:36 INFO - 'PWD': '/builds/slave/test', 08:42:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:36 INFO - 'SHELL': '/bin/bash', 08:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ArsCog6PRg/Listeners', 08:42:36 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 08:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:36 INFO - 'USER': 'cltbld', 08:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:36 INFO - 'XPC_FLAGS': '0x0', 08:42:36 INFO - 'XPC_SERVICE_NAME': '0', 08:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:36 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/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0002', '--webServer', 'localhost'] with output_timeout 3600 08:42:36 INFO - mozversion INFO | application_buildid: 20151201072831 08:42:36 INFO - mozversion INFO | application_changeset: 77de40d65ca2359f1dfe7f23640e58866a654711 08:42:36 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:42:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:36 INFO - mozversion INFO | application_name: Firefox 08:42:36 INFO - mozversion INFO | application_remotingname: firefox-dev 08:42:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:42:36 INFO - mozversion INFO | application_vendor: Mozilla 08:42:36 INFO - mozversion INFO | application_version: 44.0a2 08:42:36 INFO - mozversion INFO | platform_buildid: 20151201072831 08:42:36 INFO - mozversion INFO | platform_changeset: 77de40d65ca2359f1dfe7f23640e58866a654711 08:42:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:42:36 INFO - mozversion INFO | platform_version: 44.0a2 08:42:36 INFO - 2015-12-01 08:42:36,791 DEBUG : using testdate: 1448988156 08:42:36 INFO - 2015-12-01 08:42:36,791 DEBUG : actual date: 1448988156 08:42:36 INFO - 2015-12-01 08:42:36,800 INFO : starting webserver on 'localhost:49270' 08:42:36 INFO - 2015-12-01 08:42:36,801 INFO : Starting test suite t-yosemite-r5-0002 08:42:36 INFO - 2015-12-01 08:42:36,801 INFO : Starting test dromaeo_css 08:42:36 INFO - 2015-12-01 08:42:36,801 DEBUG : operating with platform_type : mac_ 08:42:36 INFO - 2015-12-01 08:42:36,802 INFO : Initialising browser for dromaeo_css test... 08:42:36 INFO - 2015-12-01 08:42:36,829 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmp8nsufg/profile http://localhost:49270/getInfo.html 08:42:40 INFO - 2015-12-01 08:42:40,113 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:42:40 INFO - 2015-12-01 08:42:40,113 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:42:40 INFO - 2015-12-01 08:42:40,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:42:40 INFO - 2015-12-01 08:42:40,114 DEBUG : BROWSER_OUTPUT: __metrics 08:42:40 INFO - 2015-12-01 08:42:40,154 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:40 INFO - 2015-12-01 08:42:40,918 INFO : Browser initialized. 08:42:40 INFO - 2015-12-01 08:42:40,918 INFO : Running cycle 1/1 for dromaeo_css test... 08:42:40 INFO - 2015-12-01 08:42:40,918 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmp8nsufg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:42:52 INFO - 2015-12-01 08:42:52,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 198262784 08:42:52 INFO - 2015-12-01 08:42:52,756 DEBUG : BROWSER_OUTPUT: 08:43:44 INFO - 2015-12-01 08:43:44,243 DEBUG : BROWSER_OUTPUT: 1448988224241 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] 08:45:55 INFO - 2015-12-01 08:45:55,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:45:56 INFO - 2015-12-01 08:45:56,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 337625088 08:45:56 INFO - 2015-12-01 08:45:56,533 DEBUG : BROWSER_OUTPUT: 08:48:59 INFO - 2015-12-01 08:48:59,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:48:59 INFO - 2015-12-01 08:48:59,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 341213184 08:48:59 INFO - 2015-12-01 08:48:59,690 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-01 08:52:01,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:52:02 INFO - 2015-12-01 08:52:02,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 316100608 08:52:02 INFO - 2015-12-01 08:52:02,336 DEBUG : BROWSER_OUTPUT: 08:55:04 INFO - 2015-12-01 08:55:04,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:55:04 INFO - 2015-12-01 08:55:04,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 298934272 08:55:04 INFO - 2015-12-01 08:55:04,820 DEBUG : BROWSER_OUTPUT: 08:58:07 INFO - 2015-12-01 08:58:07,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 08:58:08 INFO - 2015-12-01 08:58:08,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 296833024 08:58:08 INFO - 2015-12-01 08:58:08,558 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:01:11 INFO - 2015-12-01 09:01:11,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 341282816 09:01:11 INFO - 2015-12-01 09:01:11,361 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,361 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:01:11 INFO - 2015-12-01 09:01:11,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:01:11 INFO - 2015-12-01 09:01:11,362 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:01:11 INFO - 2015-12-01 09:01:11,362 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:01:11 INFO - 2015-12-01 09:01:11,364 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3156.6685498022703;3226.3547290541896;3241.384137013967;3263.820489873057;3270.5094235864617;5441.29263195785;5444.6188766786345;5452.809151679692;5455.454454554542;5474.343078830536;5440.265564148839;5460.426655201206;5461.098918678414;5466.753996070176;5468.343798744147;4916.410030796292;4986.5761410280165;5020.648554601179;5046.97476512617;5068.493150684921;5069.163588007993;5090.9236361454605;5096.923546146811;5103.770330335144;5114.002769459957;4923.359963204796;5077.796888124471;5079.060373830835;5093.719845408519;5095.490450954912;5006.649534532584;5083.364579427572;5086.949130508721;5096.821611243588;5103.464136265694;5055.974720126413;5079.1365467870555;5103.719295438749;5133.486651334874;5165.328507294065;4948.208286674151;5206.9846379955925;5361.142217245222;5511.311086114236;5548.389677135512;5777;5789.681567513785;5849.38581448946;5857.297124345063;5860.912086318709;5844.503217226541;5883.794067207627;5912.733926973297;5925.614835035709;5928.555358348098;5409.891802163974;5449.591280653967;5521.751521181556;5521.861953451155;5534.308211473566;6045.183900173508;6049.715781824006;6055.909161362583;6061.181740465069;6063.151158837766;5768.307803063659;5814.912776308359;5815.389384114607;5852.15143804146;5853.209816674695;5726.312842458931;5731.312242530923;5844.12338149281;5872.500837428866;5991.910121348184;5835;5839.065749480063;5855.4730074292665;5857.121431785181;5865.208196893364;5838.153467747238;5843.678597677083;5858.033424484997;5863.296404431496;5871.765129394862;4427.158839820424;4468.642508599304;4512.458504979423;4561.384213131185;4623.329617205486;4185.9953611133715;4205.285101532686;4213.536510983789;4214.4099826024385;4222.176675548239;5460.180972854024;5469.15228139639;5481.643693160012;5488.368837583729;5516.806911758069;5723.8569035774435;5766.682832444172;5840.970795145997;5841.561882858802;5891.49922256613;5469.234307196995;5539.723013849291;5542.63972841764;5565.443455654483;5568.860778480571;5242.449542798027;5261.605379596545;5276.657017293864;5286.180642000496;5298.814541491107;5725.885482290331;5786.913196302143;5832.241808564944;5842.591018628826;5919.822405327847;5953.791617293374;6006.519478441627;6012.368701286477;6021.187139736079;6033.12519684652;6035.758569657341;6050.273967123973;6061.212042434456;6065.059915713072;6069.605475644069;5579.386267510489;5656.830295091154;5698.886022279614;5702.087665973424;5785.537157027344;5964.433378829004;5978.521718262616;5979.043353063489;5980.760769569342;5983.820485385445;5808.651480911159;5811.680357580373;5821.446962538552;5830;5834.124881267844;5526.640768350045;5645.068563686946;5661.235733175969;5664.971675141598;5720.771169153188;5641.351244606923;5661.405552417102;5669.744861481161;5679.346875109415;5699.8860022800145;5802.361740208658;5805.535557155333;5814.94185058144;5819.6508209507565;5847.035239185657;5446.101393270066;5563.666180029211;5564.749586268708;5574.749136288958;5665.433456654467 09:01:11 INFO - 2015-12-01 09:01:11,368 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.6709701488875;594.1562980567594;597.3488897102158;601.6450294326347;602.4668168670725;34072.82963585182;41817;42562.99999999996;42643.36034959478;42653.36019959703;45178;45748.085038299294;45823.31265031027;45942.7702861486;45956.08087838241;8729.34529910256;8958.059403762609;9348.392354496953;9535.046495350443;9581.473018983954;11258.718532036724;11468.942655286712;11489.885101148966;11490.36802975836;11514.42427878607;11234.831477527803;11330.886691133066;11336.716582085432;11366.71583210418;11378.260413073165;8979;9185.448873067571;11234.3259404436;11335;11394.373309467976;11023.669289921316;11176.832347514794;11194.216404851664;11197.552097916156;11201;42261.36607950883;42727.57272427267;42771.57228427707;42775.35836962448;42818.35772463385;3054.831984240866;3079.8922037728794;3204.6314673812344;3394.6096198937194;3494;27891.302717432023;28630.856845715847;28858.855705721548;28894.711052889623;29193.708062919522;2383.4398916254668;2389.175734371639;2416.6979127609047;2418.7460316666675;2424.478737071538;263947;264006;264500;264978.9999999981;265047;56167.43832561622;57977.42022579804;63749.68125159344;64365.678171608844;64829;58135.12797308044;58572.70713646404;58862.11706824401;58879;59029.704851475464;18062.36781712634;18446;18457;18468.261269549068;18475.81524184768;13878.306084695725;13946.372413241428;13955.092918960236;13958;13965.58103256904;20715.689264661043;20992.580148396948;21017.68473472899;21048.579028419652;21080.894595527232;8961.507117108491;9180.265578753817;9191;9211.309151813506;9253.676121335855;1000.3747657713928;1022.3814592171777;1056.7939251845817;1075.3171735947728;1094.0591091661165;30235.395292094036;30255.394892102035;30439.69560304413;30523.8473807634;30789.69210307913;1031.8297480915564;1082.1775450657399;1108.5177947592822;1183.0594677231622;1263.2231177825572;15570.221488925508;15766.527004189893;16168.919155404383;16294;16489.34042638305;343257;348824;349579;351286;351552;51348.22977655338;52195.21707174395;57360.13959790606;58479.70760146172;59181.40818591845;1445.7759047347467;1464.72170287645;1489.9180545069692;1499.4601943300404;1501;26231.868840655676;26612;28681.214750113344;29023.27441813887;30517.389652207276;47917;48280;48296.275555865985;48344.516554835405;48350.27474587954;283415;284106;284208;285151;285529;33183.50224746679;33698.66301337053;33800.66199337975;34044;34163;38586.22827543489;39743.602563975146;39841.80079099586;40827.38758918559;41167.588324116376;35374.82312588523;35674.28651427009;37022.19482120787;37027.8148609266;37493;35837.283254334245;36541.634583654886;36903;37297.81351093227;37376;34076.65923340735;35187.12032199215;35239;35275.64724352826;35337;28234.396520119004;32204.19489512781;32558.186045349055;32700.672993269764;32711.18222044468;24776.132835350676;25004.245796661537;25237.242882712813;26321;26683 09:01:11 INFO - 2015-12-01 09:01:11,368 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.2421933855187;357.7174032514314;359.5344029481821;359.7409864897274;360.3819449643861;15198.240087995611;15399.69200615987;17944.192511336987;18277.817221827794;18984;15675.60810979726;18215.27138914445;18513.444596662088;18946.90526547365;19007.61984760304;4736.076465089309;4855.805767769302;5256.421793602701;5409.513143817056;5422.83731488054;3599.226166374229;3679.337719210541;4783.378160839086;4844.709317440947;4879.975600121995;4774.785134668949;4825.059113472874;4827.300041493982;4828.2274836026245;4842.9031419371595;4691.179043667379;4787.521247875185;4820.975895120519;4826.396700412449;4835.2505361669;4039.63643272104;4044.6562042226446;4045.4538637283886;4045.797710114512;4050.0887300357476;13499.66250843727;13612.183269003892;13706.177629342172;13720.382582783699;13727.931360343235;1904.7047707605343;1911.44568075258;2026.9087891044937;2029.4520479470607;2052.7741948385665;9688.176504997084;9830.9508452458;9985.350952188157;10112.342697724624;10166;1513.4854149589194;1543.5678010157174;1584.4771225495558;1585.4054729476447;1599.2323684631442;57418.42581574173;57936.420635793525;61470.38529614736;63724.362756372306;63749;6557.278699343068;6626.271110177877;6628.436582890412;6634.86730265392;6686.4985126115735;7583.5070720403;7584.241575842371;7592.8481430371085;7594.202608726005;7595.962020189863;5701.2018317435595;5710.086386178192;5803.390643982406;5827.621204621686;5841.32824725162;6408.743650254031;6414;6428.550001499943;6451.612903225821;6451.806445806634;3062.846857657108;3078.4458797416232;3093.90718278452;3109.0672798160463;3109.3781243750886;1014.5028935821394;1029.1098200056897;1086.5925278020743;1102.8841971593029;1109.20691705431;391.30738592691347;415.55120469892444;423.25718364270506;429.56399254756445;441.66654176097484;10169.796604068026;10496.947515262527;10927.125829933586;11042;11176.720581985353;395.2608621877108;397.5845241722407;405.57414714549606;417.6637806565683;420.2225882118057;5900.881982360414;6019.097135429721;6326.46225070865;6345.682715864281;6372.235331760218;503747;557771;607147;608155;609334;76093.6195319031;76338;79074.60462697649;79197.60401197957;82747;436.53290978652535;446.2324801341752;446.5133005024539;447.02771472048164;447.3781443793195;10331.638392656221;10662.89337106619;10717.571297148026;11040.282381645167;11639.883601164218;36226;36566;37512.812435937645;37659.62340376561;37966.81016594899;48678.51321486881;48815.511844882516;48879.26681099715;49200;49282;6353.269374022047;6424.678766061585;6428.774992875227;6429.774957876639;6438.871222575429;12186.146969712036;12379.195352302071;12425.689357766129;12584.18202816814;12679.429425675682;10711.464426778786;10739.140868730326;10847.620333288613;11026.834597481205;11035.944820275847;10008.14930730867;10490.423026733602;10550.419726915094;10629.362238265729;10831.458427078456;8465.534395608054;8818.735437936615;8847.73456796297;10661.200409969439;10911.454427278763;6215.409536094064;6219.0982307566055;6224.408681175281;6344.206974128234;6345.90481142774;10578.15374770032;10732.624358147428;10944.562217511211;10958.616448424267;10960.835587466036 09:01:11 INFO - 2015-12-01 09:01:11,370 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1280.4686055287057;1720.7332863406173;1804.7202683584042;1821.5355084453467;1833.532449225448;6640.800775976722;6945.236024037352;7141.964290178548;7145.8928116078305;7156.677949492272;7111.466640002008;7286.6356682165815;7286.854262914739;7287.453440991921;7312.780616581498;2139.1336508713994;2160.5678864227216;2160.9783902160934;2162.372911855568;2164.480524674075;2156.4608847788054;2182.03990244292;2223.0885337011828;2223.3107736601623;2230.197129033547;2141.5288636499945;2163.4266919266406;2170;2174.2716190076344;2175.216921908112;2162.9242976495825;2173.576152650234;2174.923877664274;2175.575762726269;2176.7170267865154;2157.870527768339;2171.9022643981057;2173.152470536492;2177.161792709818;2177.5971445282676;6603.339666033358;6841.110655614738;7236.565806051653;7263.782086537412;7275.308845659654;4422.071365013351;4551.044280701057;4554.066416384633;4566.657500687462;4569.223232050559;2819.4361127774323;2851.244420228641;2891.8698658560415;2895.7683385329124;2919;848.5926755157559;860.7675927499603;860.9009963854112;864.0279685353977;881.7839629290864;9537.33238673293;9595.23238140947;9595.42427454355;9603.37578057424;9618.326717129734;3986.80065996699;3988.780617066031;4026.094128820992;4039.030632648202;4066;8504.659813607386;8513.14868513156;8519.914800852037;8524.232819046316;8529.95735021321;4613.515580864028;4631.282151266559;4632.652551058684;4634.142683603544;4645.187092258841;4231.894202644959;4246.787660616957;4248.851290204828;4252.31962885943;4256.382824490432;3406.386850366908;3426.9657303426648;3434.0556347004276;3446.7759595626203;3458.723302135823;1081.2053140941402;1094.4473041114186;1097.286763603648;1103.8178700514486;1104.6244276945877;1304.7586196553668;1311.1936159261986;1311.7048664050512;1313.8292022037074;1335.2122247873801;6999.615021173884;7028.437724981989;7067.187273463617;7076;7076.716931322792;423.7881059470265;433.3359897991727;449.07266494689014;453.4694407543182;453.6144277364214;5152.793888244429;5595.972020139873;5655.802046928337;5657.8019769307875;5659.066254068032;7815.374770018385;8251.669933202606;8377.6230069647;8383.11977242393;8406.075331713506;8183.71357002502;8271;8307.37694672902;8311.293540049164;8314.542700151429;6829.829254268584;6876;6879.277675844064;6881.346272104142;6906.689198986058;6670.699818508082;6679.6994135265;6680.265170831108;6682.164729408824;6694.430973367318;7392.741254056083;7568.659410326659;7574.772756817304;7597.962010189914;7601.809954751176;7388.335049845539;7520.511166774142;7538.396928245617;7546.094468663796;7550.7734767957045;6544.9672751635935;6562.048502967138;6621.801345959629;6638.369354911276;6641.634710090992;7052.118485189351;7084.539504932163;7088.929110709033;7097.112860892388;7116.039334689957;6554.80335589933;6653.933460665331;6699.09562209115;6739;6763.425108865801;6596.472282217315;6599.670016499252;6625.337466253336;6668.43318317929;6683.7660681875905;6669.899951500828;6759.932400675931;6792.286809885089;6803.047573339637;6815.89776153368;5894.469497745224;5943.257092863392;5946.851328716817;5947.464728174485;5957.463828255478;5893.086571581412;5939.316978547349;5955.344912059757;5963.314218864886;5964.075568286922 09:01:11 INFO - 2015-12-01 09:01:11,373 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.4767185916856;305.106039304837;306.51264489461755;313.85092081261405;316.22840269741835;6055.909161362583;6103.420175083365;6137.81586552403;6200.472959798417;6225.315215326316;5985.940140598593;6074.8481287967825;6098.603590766597;6112.6638034908065;6128.60164089335;4456.532064133252;4590.334401511787;4600.1029799189;4600.401947746788;4641.883952901171;4547.386102876102;4567.1550763108935;4613.838515651953;4629.166749985001;4638.814447422099;4541.250693635546;4546.681732278742;4553.453585569736;4568.908621827562;4589.2198326284615;4533.206688829442;4547.931781023271;4552.135094332067;4557.817687292504;4563.70335928167;3852.6917846572205;3869.7097717671286;3878.631530004673;3899.025243689078;3903.941440878389;5644.125160600072;5932.703364831741;5937.020391635375;5953.13679516472;5984.102384642295;5095.79616815327;5112.488751124895;5112.846614601568;5125.384953805567;5128.333316668846;6365.1725275714325;6366.840828979266;6368.363163683641;6369.426751592333;6376.234851817765;4110.527289361702;4202.054537729017;4204.1591681663485;4261.74429534229;4286.828526858922;6745.392914637657;6771.796846094625;6808.931910680879;6813.454923606099;6840.6921688523635;4335.978320108442;4349.630281426051;4355.08543205924;4356.803943822536;4368.978155109204;4356.346548017759;4363.127374525107;4390.341448782644;4391.099824535962;4409.36064270679;5040.823571174991;5158.484151584811;5158.896822063538;5212.869678258074;5224.52979231871;6395.904061439082;6410.61536307823;6422.100905873182;6442.613443193423;6464.095026696266;1553.30101454346;1569.0977687829543;1571.0573655806654;1572.3396173607111;1574.7637854321715;996.9750756231152;998.8851282102651;1013.422349260929;1016.9796604068025;1024.2727663359099;6174.25908890936;6176.69116544171;6180.196574445384;6187.381261873777;6189.381061893775;6494;6590.472762179014;6601.73593056282;6674.9666251669405;6689.096971908827;6070.150178974947;6103.328633850273;6104.4505994460715;6105;6135.969320153371;3692.9446058309145;3716.758410703296;3723.94414083789;3738.32710112177;3738.5700644425697;6552.475801935833;6743.426808721216;6756.662166891734;6760.864782704417;6771.593704377753;6936.306369363023;6939.93060069403;6945.2707465716385;6953.130858642669;6960.825979350557;6696.330366963265;6864.897026544606;6869.793906182823;6886.690098945459;6891.483138764613;6796.35434633709;6812.795616131524;6836.111305530249;6837.794866154023;6848.7260509579055;6598.406143447113;6634.4692424604955;6634.734610615715;6638.867222655424;6650.301718319507;6653.63405012729;6858.5199036067;6867.244603093556;6875.518713689994;6894.069300644349;4149.8340066397;4150.8547200847825;4181.038361176886;4184.895377615584;4187.036981494212;6772.5936443813525;6783.660816959231;6786.59280443175;6790.626515541692;6803.693833777591;6582.243042050034;6587.176602924635;6600.438962688226;6607.975763756625;6610.272869984202;6396.488280937607;6475.417212450902;6485.15692959931;6508.316626754123;6537.1174891389055;6329.683515824282;6333.841653958688;6352.237731472253;6352.491800656029;6376.234851817811;6303.338149494237;6483.059956306403;6493.123428337114;6500.154979852589;6504.837379065561;6144.631322120687;6228.4705800007505;6232.283287421823;6344.492440604648;6356.904646430215 09:01:11 INFO - 2015-12-01 09:01:11,375 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.3622593247605;792.4340467894478;792.5244853088147;797.2704974947923;805.2430715127778;13501;13999.790003149961;14018.789718154236;14050.08674436161;14051.578452646425;13151.210927344342;13317.334133293345;13344.933275333635;13365.331733413339;13372.732545349087;937.5218638494383;952.7094236257973;952.7713348796308;954.4511905654276;954.7326748510428;958.7363475044384;966.9613215471372;967.5355829201987;967.7435479597913;967.849983252597;1006.7130867702706;1011.7066050845283;1013.6401577440013;1014.137982714694;1014.9188064954786;1009.0615727373539;1009.4750729620592;1009.9040591143867;1010.5604062232952;1012.1093437774748;743.5650144665377;743.6542007966322;743.7434085240583;744.6128013433039;746.6229554075157;13828.654283642889;14013;14015;14055.718885622333;14075.929620351935;12034.33811140387;12086.818697719542;12324.198927069712;12469.376531173404;12511.687207819787;9179.403338782959;9331.626734930594;9639.614415423375;9841.655542055994;10096.394216347042;3338.7162091222276;3426.2119712466274;3442.9655703443145;3444.328355970587;3444.621091679913;42529.78735106336;42752.57247427548;48867;49693.75153124211;49868;9117.863232051524;9498.572564234626;9509.381890177116;9520;9689.370190937567;20293.18827246923;20460.181592736124;20572.588548228952;20576.074076666588;20591.176352946015;7229.09636295463;7512.286332798485;7556.319931206218;7558.357539609085;7704.6532906019365;3874.535055793323;3962.2471730371135;4022.2960981828064;4059.2084543513733;4072.9796351018053;3004.6244219472565;3032.3783624357393;3034.059441573075;3041.1636799879766;3045.6192975878016;421.6394982290159;430.3931456646114;438.160921834683;438.20684560944153;441.72833707269797;512.4772731813604;562.7298896529688;571.5113577890927;581.3866370978574;600.9128676341905;7075.150981882207;7136.536125151849;7282.599457029808;7317.341439270491;7331.74338898136;481.2900971067717;565.6549504802067;575.4590684756315;593.8040446652594;608.7473698415197;3605.7656252343513;3627.383344831385;3662.1027848176836;3664.670179683841;4097.651699605567;55370;55618;55782;61667.69166154141;62560.37439625546;50346.496535034916;50360.748196258784;50379;50537.24194137091;53575.73212133993;41594.79202604028;43699.56300436955;45601.315980260326;46021.76989115033;46242.07515849664;7785.260400261966;8394.45436046655;8411;8453.112423195476;8686.087960764282;30426.695733042387;35739.82130089333;36180.27639447144;36813.26373472569;36844.81577592095;46939.530604693515;47169.528304716514;47197.29204062011;50123.24815127849;50191.49808502015;7503.287187717158;7533.9246607535415;7543.849123017619;7562.281583249583;7660.463767536219;10957.397343146204;11076.169287303646;11202.83195752048;11949;12289.201201921847;10044.698659040241;10239.283250172715;10427.322224055411;10476.528556214836;10795.838062428913;10495.632652857113;10592.205584581341;10817.837732433862;10882;10942;10027.749306267402;10142.54358553852;10220.693379198636;10315;10361.430121343097;9084.682036128968;9370.812583748424;9395.483248421402;9690.37012594179;9916.355436896578;9339.112784285482;9386.906130938876;9393.217997206764;9407.341486095907;9578.137967582672 09:01:11 INFO - 2015-12-01 09:01:11,375 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:01:11 INFO - 2015-12-01 09:01:11,375 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:01:11 INFO - 2015-12-01 09:01:11,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1009 09:01:11 INFO - 2015-12-01 09:01:11,375 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:01:11 INFO - 2015-12-01 09:01:11,375 DEBUG : BROWSER_OUTPUT: __startTimestamp1448989271360__endTimestamp 09:01:11 INFO - 2015-12-01 09:01:11,376 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,376 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:01:11 INFO - 2015-12-01 09:01:11,376 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:01:11 INFO - 2015-12-01 09:01:11,376 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,376 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5464.30 Median:5645.07 stddev:584.19 (10.3%) stddev-sans-first:557.23 09:01:11 INFO - 2015-12-01 09:01:11,378 DEBUG : BROWSER_OUTPUT: Values: 3156.7 3226.4 3241.4 3263.8 3270.5 5441.3 5444.6 5452.8 5455.5 5474.3 5440.3 5460.4 5461.1 5466.8 5468.3 4916.4 4986.6 5020.6 5047.0 5068.5 5069.2 5090.9 5096.9 5103.8 5114.0 4923.4 5077.8 5079.1 5093.7 5095.5 5006.6 5083.4 5086.9 5096.8 5103.5 5056.0 5079.1 5103.7 5133.5 5165.3 4948.2 5207.0 5361.1 5511.3 5548.4 5777.0 5789.7 5849.4 5857.3 5860.9 5844.5 5883.8 5912.7 5925.6 5928.6 5409.9 5449.6 5521.8 5521.9 5534.3 6045.2 6049.7 6055.9 6061.2 6063.2 5768.3 5814.9 5815.4 5852.2 5853.2 5726.3 5731.3 5844.1 5872.5 5991.9 5835.0 5839.1 5855.5 5857.1 5865.2 5838.2 5843.7 5858.0 5863.3 5871.8 4427.2 4468.6 4512.5 4561.4 4623.3 4186.0 4205.3 4213.5 4214.4 4222.2 5460.2 5469.2 5481.6 5488.4 5516.8 5723.9 5766.7 5841.0 5841.6 5891.5 5469.2 5539.7 5542.6 5565.4 5568.9 5242.4 5261.6 5276.7 5286.2 5298.8 5725.9 5786.9 5832.2 5842.6 5919.8 5953.8 6006.5 6012.4 6021.2 6033.1 6035.8 6050.3 6061.2 6065.1 6069.6 5579.4 5656.8 5698.9 5702.1 5785.5 5964.4 5978.5 5979.0 5980.8 5983.8 5808.7 5811.7 5821.4 5830.0 5834.1 5526.6 5645.1 5661.2 5665.0 5720.8 5641.4 5661.4 5669.7 5679.3 5699.9 5802.4 5805.5 5814.9 5819.7 5847.0 5446.1 5563.7 5564.7 5574.7 5665.4 09:01:11 INFO - 2015-12-01 09:01:11,378 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,378 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47774.54 Median:3142.26 stddev:78659.16 (2503.3%) stddev-sans-first:78799.92 09:01:11 INFO - 2015-12-01 09:01:11,379 DEBUG : BROWSER_OUTPUT: Values: 556.7 594.2 597.3 601.6 602.5 34072.8 41817.0 42563.0 42643.4 42653.4 45178.0 45748.1 45823.3 45942.8 45956.1 8729.3 8958.1 9348.4 9535.0 9581.5 11258.7 11468.9 11489.9 11490.4 11514.4 11234.8 11330.9 11336.7 11366.7 11378.3 8979.0 9185.4 11234.3 11335.0 11394.4 11023.7 11176.8 11194.2 11197.6 11201.0 42261.4 42727.6 42771.6 42775.4 42818.4 3054.8 3079.9 3204.6 3394.6 3494.0 27891.3 28630.9 28858.9 28894.7 29193.7 2383.4 2389.2 2416.7 2418.7 2424.5 263947.0 264006.0 264500.0 264979.0 265047.0 56167.4 57977.4 63749.7 64365.7 64829.0 58135.1 58572.7 58862.1 58879.0 59029.7 18062.4 18446.0 18457.0 18468.3 18475.8 13878.3 13946.4 13955.1 13958.0 13965.6 20715.7 20992.6 21017.7 21048.6 21080.9 8961.5 9180.3 9191.0 9211.3 9253.7 1000.4 1022.4 1056.8 1075.3 1094.1 30235.4 30255.4 30439.7 30523.8 30789.7 1031.8 1082.2 1108.5 1183.1 1263.2 15570.2 15766.5 16168.9 16294.0 16489.3 343257.0 348824.0 349579.0 351286.0 351552.0 51348.2 52195.2 57360.1 58479.7 59181.4 1445.8 1464.7 1489.9 1499.5 1501.0 26231.9 26612.0 28681.2 29023.3 30517.4 47917.0 48280.0 48296.3 48344.5 48350.3 283415.0 284106.0 284208.0 285151.0 285529.0 33183.5 33698.7 33800.7 34044.0 34163.0 38586.2 39743.6 39841.8 40827.4 41167.6 35374.8 35674.3 37022.2 37027.8 37493.0 35837.3 36541.6 36903.0 37297.8 37376.0 34076.7 35187.1 35239.0 35275.6 35337.0 28234.4 32204.2 32558.2 32700.7 32711.2 24776.1 25004.2 25237.2 26321.0 26683.0 09:01:11 INFO - 2015-12-01 09:01:11,379 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,379 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28205.93 Median:416.61 stddev:94859.07 (22769.4%) stddev-sans-first:95102.11 09:01:11 INFO - 2015-12-01 09:01:11,380 DEBUG : BROWSER_OUTPUT: Values: 345.2 357.7 359.5 359.7 360.4 15198.2 15399.7 17944.2 18277.8 18984.0 15675.6 18215.3 18513.4 18946.9 19007.6 4736.1 4855.8 5256.4 5409.5 5422.8 3599.2 3679.3 4783.4 4844.7 4880.0 4774.8 4825.1 4827.3 4828.2 4842.9 4691.2 4787.5 4821.0 4826.4 4835.3 4039.6 4044.7 4045.5 4045.8 4050.1 13499.7 13612.2 13706.2 13720.4 13727.9 1904.7 1911.4 2026.9 2029.5 2052.8 9688.2 9831.0 9985.4 10112.3 10166.0 1513.5 1543.6 1584.5 1585.4 1599.2 57418.4 57936.4 61470.4 63724.4 63749.0 6557.3 6626.3 6628.4 6634.9 6686.5 7583.5 7584.2 7592.8 7594.2 7596.0 5701.2 5710.1 5803.4 5827.6 5841.3 6408.7 6414.0 6428.6 6451.6 6451.8 3062.8 3078.4 3093.9 3109.1 3109.4 1014.5 1029.1 1086.6 1102.9 1109.2 391.3 415.6 423.3 429.6 441.7 10169.8 10496.9 10927.1 11042.0 11176.7 395.3 397.6 405.6 417.7 420.2 5900.9 6019.1 6326.5 6345.7 6372.2 503747.0 557771.0 607147.0 608155.0 609334.0 76093.6 76338.0 79074.6 79197.6 82747.0 436.5 446.2 446.5 447.0 447.4 10331.6 10662.9 10717.6 11040.3 11639.9 36226.0 36566.0 37512.8 37659.6 37966.8 48678.5 48815.5 48879.3 49200.0 49282.0 6353.3 6424.7 6428.8 6429.8 6438.9 12186.1 12379.2 12425.7 12584.2 12679.4 10711.5 10739.1 10847.6 11026.8 11035.9 10008.1 10490.4 10550.4 10629.4 10831.5 8465.5 8818.7 8847.7 10661.2 10911.5 6215.4 6219.1 6224.4 6344.2 6345.9 10578.2 10732.6 10944.6 10958.6 10960.8 09:01:11 INFO - 2015-12-01 09:01:11,380 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,380 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5078.42 Median:6549.89 stddev:2564.54 (39.2%) stddev-sans-first:2555.84 09:01:11 INFO - 2015-12-01 09:01:11,381 DEBUG : BROWSER_OUTPUT: Values: 1280.5 1720.7 1804.7 1821.5 1833.5 6640.8 6945.2 7142.0 7145.9 7156.7 7111.5 7286.6 7286.9 7287.5 7312.8 2139.1 2160.6 2161.0 2162.4 2164.5 2156.5 2182.0 2223.1 2223.3 2230.2 2141.5 2163.4 2170.0 2174.3 2175.2 2162.9 2173.6 2174.9 2175.6 2176.7 2157.9 2171.9 2173.2 2177.2 2177.6 6603.3 6841.1 7236.6 7263.8 7275.3 4422.1 4551.0 4554.1 4566.7 4569.2 2819.4 2851.2 2891.9 2895.8 2919.0 848.6 860.8 860.9 864.0 881.8 9537.3 9595.2 9595.4 9603.4 9618.3 3986.8 3988.8 4026.1 4039.0 4066.0 8504.7 8513.1 8519.9 8524.2 8530.0 4613.5 4631.3 4632.7 4634.1 4645.2 4231.9 4246.8 4248.9 4252.3 4256.4 3406.4 3427.0 3434.1 3446.8 3458.7 1081.2 1094.4 1097.3 1103.8 1104.6 1304.8 1311.2 1311.7 1313.8 1335.2 6999.6 7028.4 7067.2 7076.0 7076.7 423.8 433.3 449.1 453.5 453.6 5152.8 5596.0 5655.8 5657.8 5659.1 7815.4 8251.7 8377.6 8383.1 8406.1 8183.7 8271.0 8307.4 8311.3 8314.5 6829.8 6876.0 6879.3 6881.3 6906.7 6670.7 6679.7 6680.3 6682.2 6694.4 7392.7 7568.7 7574.8 7598.0 7601.8 7388.3 7520.5 7538.4 7546.1 7550.8 6545.0 6562.0 6621.8 6638.4 6641.6 7052.1 7084.5 7088.9 7097.1 7116.0 6554.8 6653.9 6699.1 6739.0 6763.4 6596.5 6599.7 6625.3 6668.4 6683.8 6669.9 6759.9 6792.3 6803.0 6815.9 5894.5 5943.3 5946.9 5947.5 5957.5 5893.1 5939.3 5955.3 5963.3 5964.1 09:01:11 INFO - 2015-12-01 09:01:11,382 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,382 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5347.19 Median:6141.22 stddev:1669.51 (27.2%) stddev-sans-first:1630.58 09:01:11 INFO - 2015-12-01 09:01:11,383 DEBUG : BROWSER_OUTPUT: Values: 296.5 305.1 306.5 313.9 316.2 6055.9 6103.4 6137.8 6200.5 6225.3 5985.9 6074.8 6098.6 6112.7 6128.6 4456.5 4590.3 4600.1 4600.4 4641.9 4547.4 4567.2 4613.8 4629.2 4638.8 4541.3 4546.7 4553.5 4568.9 4589.2 4533.2 4547.9 4552.1 4557.8 4563.7 3852.7 3869.7 3878.6 3899.0 3903.9 5644.1 5932.7 5937.0 5953.1 5984.1 5095.8 5112.5 5112.8 5125.4 5128.3 6365.2 6366.8 6368.4 6369.4 6376.2 4110.5 4202.1 4204.2 4261.7 4286.8 6745.4 6771.8 6808.9 6813.5 6840.7 4336.0 4349.6 4355.1 4356.8 4369.0 4356.3 4363.1 4390.3 4391.1 4409.4 5040.8 5158.5 5158.9 5212.9 5224.5 6395.9 6410.6 6422.1 6442.6 6464.1 1553.3 1569.1 1571.1 1572.3 1574.8 997.0 998.9 1013.4 1017.0 1024.3 6174.3 6176.7 6180.2 6187.4 6189.4 6494.0 6590.5 6601.7 6675.0 6689.1 6070.2 6103.3 6104.5 6105.0 6136.0 3692.9 3716.8 3723.9 3738.3 3738.6 6552.5 6743.4 6756.7 6760.9 6771.6 6936.3 6939.9 6945.3 6953.1 6960.8 6696.3 6864.9 6869.8 6886.7 6891.5 6796.4 6812.8 6836.1 6837.8 6848.7 6598.4 6634.5 6634.7 6638.9 6650.3 6653.6 6858.5 6867.2 6875.5 6894.1 4149.8 4150.9 4181.0 4184.9 4187.0 6772.6 6783.7 6786.6 6790.6 6803.7 6582.2 6587.2 6600.4 6608.0 6610.3 6396.5 6475.4 6485.2 6508.3 6537.1 6329.7 6333.8 6352.2 6352.5 6376.2 6303.3 6483.1 6493.1 6500.2 6504.8 6144.6 6228.5 6232.3 6344.5 6356.9 09:01:11 INFO - 2015-12-01 09:01:11,383 DEBUG : BROWSER_OUTPUT: 09:01:11 INFO - 2015-12-01 09:01:11,383 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13635.29 Median:45811.54 stddev:16149.56 (35.3%) stddev-sans-first:16165.96 09:01:11 INFO - 2015-12-01 09:01:11,383 DEBUG : BROWSER_OUTPUT: Values: 768.4 792.4 792.5 797.3 805.2 13501.0 13999.8 14018.8 14050.1 14051.6 13151.2 13317.3 13344.9 13365.3 13372.7 937.5 952.7 952.8 954.5 954.7 958.7 967.0 967.5 967.7 967.8 1006.7 1011.7 1013.6 1014.1 1014.9 1009.1 1009.5 1009.9 1010.6 1012.1 743.6 743.7 743.7 744.6 746.6 13828.7 14013.0 14015.0 14055.7 14075.9 12034.3 12086.8 12324.2 12469.4 12511.7 9179.4 9331.6 9639.6 9841.7 10096.4 3338.7 3426.2 3443.0 3444.3 3444.6 42529.8 42752.6 48867.0 49693.8 49868.0 9117.9 9498.6 9509.4 9520.0 9689.4 20293.2 20460.2 20572.6 20576.1 20591.2 7229.1 7512.3 7556.3 7558.4 7704.7 3874.5 3962.2 4022.3 4059.2 4073.0 3004.6 3032.4 3034.1 3041.2 3045.6 421.6 430.4 438.2 438.2 441.7 512.5 562.7 571.5 581.4 600.9 7075.2 7136.5 7282.6 7317.3 7331.7 481.3 565.7 575.5 593.8 608.7 3605.8 3627.4 3662.1 3664.7 4097.7 55370.0 55618.0 55782.0 61667.7 62560.4 50346.5 50360.7 50379.0 50537.2 53575.7 41594.8 43699.6 45601.3 46021.8 46242.1 7785.3 8394.5 8411.0 8453.1 8686.1 30426.7 35739.8 36180.3 36813.3 36844.8 46939.5 47169.5 47197.3 50123.2 50191.5 7503.3 7533.9 7543.8 7562.3 7660.5 10957.4 11076.2 11202.8 11949.0 12289.2 10044.7 10239.3 10427.3 10476.5 10795.8 10495.6 10592.2 10817.8 10882.0 10942.0 10027.7 10142.5 10220.7 10315.0 10361.4 9084.7 9370.8 9395.5 9690.4 9916.4 9339.1 9386.9 9393.2 9407.3 9578.1 09:01:11 INFO - 2015-12-01 09:01:11,383 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:01:11 INFO - 2015-12-01 09:01:11,383 DEBUG : BROWSER_OUTPUT: 09:01:12 INFO - 2015-12-01 09:01:12,075 INFO : Browser exited with error code: 0 09:01:12 INFO - 2015-12-01 09:01:12,102 INFO : Completed test dromaeo_css (00:18:35) 09:01:12 INFO - 2015-12-01 09:01:12,102 INFO : Starting test kraken 09:01:12 INFO - 2015-12-01 09:01:12,103 DEBUG : operating with platform_type : mac_ 09:01:12 INFO - 2015-12-01 09:01:12,103 INFO : Initialising browser for kraken test... 09:01:12 INFO - 2015-12-01 09:01:12,115 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpkabKN3/profile http://localhost:49270/getInfo.html 09:01:14 INFO - 2015-12-01 09:01:14,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:01:14 INFO - 2015-12-01 09:01:14,761 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:01:14 INFO - 2015-12-01 09:01:14,761 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:01:14 INFO - 2015-12-01 09:01:14,761 DEBUG : BROWSER_OUTPUT: __metrics 09:01:14 INFO - 2015-12-01 09:01:14,798 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:15 INFO - 2015-12-01 09:01:15,520 INFO : Browser initialized. 09:01:15 INFO - 2015-12-01 09:01:15,520 INFO : Running cycle 1/1 for kraken test... 09:01:15 INFO - 2015-12-01 09:01:15,520 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpkabKN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:01:27 INFO - 2015-12-01 09:01:27,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 198090752 09:01:27 INFO - 2015-12-01 09:01:27,302 DEBUG : BROWSER_OUTPUT: 09:01:29 INFO - 2015-12-01 09:01:29,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:30 INFO - 2015-12-01 09:01:30,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 265371648 09:01:30 INFO - 2015-12-01 09:01:30,465 DEBUG : BROWSER_OUTPUT: 09:01:33 INFO - 2015-12-01 09:01:33,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:01:33 INFO - 2015-12-01 09:01:33,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 276611072 09:01:33 INFO - 2015-12-01 09:01:33,671 DEBUG : BROWSER_OUTPUT: 09:01:36 INFO - 2015-12-01 09:01:36,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:01:37 INFO - 2015-12-01 09:01:37,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 265519104 09:01:37 INFO - 2015-12-01 09:01:37,108 DEBUG : BROWSER_OUTPUT: 09:01:39 INFO - 2015-12-01 09:01:39,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:01:39 INFO - 2015-12-01 09:01:39,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 268406784 09:01:39 INFO - 2015-12-01 09:01:39,757 DEBUG : BROWSER_OUTPUT: 09:01:41 INFO - 2015-12-01 09:01:41,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:42 INFO - 2015-12-01 09:01:42,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 266813440 09:01:42 INFO - 2015-12-01 09:01:42,519 DEBUG : BROWSER_OUTPUT: 09:01:45 INFO - 2015-12-01 09:01:45,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:46 INFO - 2015-12-01 09:01:46,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 266514432 09:01:46 INFO - 2015-12-01 09:01:46,123 DEBUG : BROWSER_OUTPUT: 09:01:49 INFO - 2015-12-01 09:01:49,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:49 INFO - 2015-12-01 09:01:49,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 268103680 09:01:49 INFO - 2015-12-01 09:01:49,862 DEBUG : BROWSER_OUTPUT: 09:01:52 INFO - 2015-12-01 09:01:52,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:01:53 INFO - 2015-12-01 09:01:53,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 267059200 09:01:53 INFO - 2015-12-01 09:01:53,280 DEBUG : BROWSER_OUTPUT: 09:01:54 INFO - 2015-12-01 09:01:54,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:55 INFO - 2015-12-01 09:01:55,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 300195840 09:01:55 INFO - 2015-12-01 09:01:55,501 DEBUG : BROWSER_OUTPUT: 09:01:57 INFO - 2015-12-01 09:01:57,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:57 INFO - 2015-12-01 09:01:57,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 298840064 09:01:57 INFO - 2015-12-01 09:01:57,908 DEBUG : BROWSER_OUTPUT: 09:01:59 INFO - 2015-12-01 09:01:59,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:00 INFO - 2015-12-01 09:02:00,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 307167232 09:02:00 INFO - 2015-12-01 09:02:00,546 DEBUG : BROWSER_OUTPUT: 09:02:03 INFO - 2015-12-01 09:02:03,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:03 INFO - 2015-12-01 09:02:03,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 308428800 09:02:03 INFO - 2015-12-01 09:02:03,660 DEBUG : BROWSER_OUTPUT: 09:02:06 INFO - 2015-12-01 09:02:06,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:06 INFO - 2015-12-01 09:02:06,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 309268480 09:02:06 INFO - 2015-12-01 09:02:06,806 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:02:08 INFO - 2015-12-01 09:02:08,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 367206400 09:02:08 INFO - 2015-12-01 09:02:08,783 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,783 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:02:08 INFO - 2015-12-01 09:02:08,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;106;106;106;108;110;115;110;107;106 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;158;153;127;150;128;158;148;124 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;161;161;162;162;162;161;163 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;76;83;119;67;70;70;69;117;69 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;95;133;89;88;88;128;89;87;133 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;115;120;115;120;115;115;115;114;114 09:02:08 INFO - 2015-12-01 09:02:08,784 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;124;124;124;124;124;124;124;124;124 09:02:08 INFO - 2015-12-01 09:02:08,785 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;100;100;99;99;100;101;100;101;101 09:02:08 INFO - 2015-12-01 09:02:08,785 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;61;62;62;64;63;63;71;57;57 09:02:08 INFO - 2015-12-01 09:02:08,785 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;64;65;64;66;66;66;66;65 09:02:08 INFO - 2015-12-01 09:02:08,785 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;83;80;83;80;81;82;84;86 09:02:08 INFO - 2015-12-01 09:02:08,785 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;126;120;118;122;129;127;121;120;121 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;143;144;143;144;143;145;142;144;146 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;71;68;69;69;68;67;70;67;69 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:02:08 INFO - 2015-12-01 09:02:08,786 DEBUG : BROWSER_OUTPUT: __startTimestamp1448989328781__endTimestamp 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:108.00 stddev:2.86 (2.6%) stddev-sans-first:3.03 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: Values: 108.0 106.0 106.0 106.0 108.0 110.0 115.0 110.0 107.0 106.0 09:02:08 INFO - 2015-12-01 09:02:08,787 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,789 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:151.50 stddev:14.06 (9.3%) stddev-sans-first:14.14 09:02:08 INFO - 2015-12-01 09:02:08,789 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 158.0 153.0 127.0 150.0 128.0 158.0 148.0 124.0 09:02:08 INFO - 2015-12-01 09:02:08,789 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 163.0 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:70.00 stddev:19.68 (28.1%) stddev-sans-first:20.86 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: Values: 80.0 76.0 83.0 119.0 67.0 70.0 70.0 69.0 117.0 69.0 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,790 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:88.00 stddev:19.99 (22.7%) stddev-sans-first:21.17 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: Values: 100.0 95.0 133.0 89.0 88.0 88.0 128.0 89.0 87.0 133.0 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:115.00 stddev:2.76 (2.4%) stddev-sans-first:2.37 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: Values: 121.0 115.0 120.0 115.0 120.0 115.0 115.0 115.0 114.0 114.0 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.00 Median:124.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:02:08 INFO - 2015-12-01 09:02:08,791 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 09:02:08 INFO - 2015-12-01 09:02:08,792 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,792 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.10 Median:101.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 09:02:08 INFO - 2015-12-01 09:02:08,792 DEBUG : BROWSER_OUTPUT: Values: 100.0 100.0 100.0 99.0 99.0 100.0 101.0 100.0 101.0 101.0 09:02:08 INFO - 2015-12-01 09:02:08,792 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,792 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.50 stddev:4.13 (6.6%) stddev-sans-first:4.15 09:02:08 INFO - 2015-12-01 09:02:08,792 DEBUG : BROWSER_OUTPUT: Values: 58.0 61.0 62.0 62.0 64.0 63.0 63.0 71.0 57.0 57.0 09:02:08 INFO - 2015-12-01 09:02:08,793 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,793 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 09:02:08 INFO - 2015-12-01 09:02:08,793 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 64.0 65.0 64.0 66.0 66.0 66.0 66.0 65.0 09:02:08 INFO - 2015-12-01 09:02:08,793 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,793 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.87 (2.3%) stddev-sans-first:1.94 09:02:08 INFO - 2015-12-01 09:02:08,793 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 83.0 80.0 83.0 80.0 81.0 82.0 84.0 86.0 09:02:08 INFO - 2015-12-01 09:02:08,794 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,794 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:124.00 stddev:3.78 (3.1%) stddev-sans-first:3.74 09:02:08 INFO - 2015-12-01 09:02:08,794 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 120.0 118.0 122.0 129.0 127.0 121.0 120.0 121.0 09:02:08 INFO - 2015-12-01 09:02:08,794 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,794 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:144.00 stddev:3.43 (2.4%) stddev-sans-first:1.20 09:02:08 INFO - 2015-12-01 09:02:08,794 DEBUG : BROWSER_OUTPUT: Values: 154.0 143.0 144.0 143.0 144.0 143.0 145.0 142.0 144.0 146.0 09:02:08 INFO - 2015-12-01 09:02:08,795 DEBUG : BROWSER_OUTPUT: 09:02:08 INFO - 2015-12-01 09:02:08,795 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 09:02:08 INFO - 2015-12-01 09:02:08,795 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 68.0 69.0 69.0 68.0 67.0 70.0 67.0 69.0 09:02:08 INFO - 2015-12-01 09:02:08,797 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:02:08 INFO - 2015-12-01 09:02:08,797 DEBUG : BROWSER_OUTPUT: 09:02:09 INFO - 2015-12-01 09:02:09,462 INFO : Browser exited with error code: 0 09:02:09 INFO - 2015-12-01 09:02:09,510 INFO : Completed test kraken (00:00:57) 09:02:09 INFO - 2015-12-01 09:02:09,510 INFO : Starting test v8_7 09:02:09 INFO - 2015-12-01 09:02:09,510 DEBUG : operating with platform_type : mac_ 09:02:09 INFO - 2015-12-01 09:02:09,510 INFO : Initialising browser for v8_7 test... 09:02:09 INFO - 2015-12-01 09:02:09,523 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpCvJRQr/profile http://localhost:49270/getInfo.html 09:02:12 INFO - 2015-12-01 09:02:12,044 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:02:12 INFO - 2015-12-01 09:02:12,045 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:02:12 INFO - 2015-12-01 09:02:12,045 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:02:12 INFO - 2015-12-01 09:02:12,045 DEBUG : BROWSER_OUTPUT: __metrics 09:02:12 INFO - 2015-12-01 09:02:12,101 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:12 INFO - 2015-12-01 09:02:12,828 INFO : Browser initialized. 09:02:12 INFO - 2015-12-01 09:02:12,828 INFO : Running cycle 1/1 for v8_7 test... 09:02:12 INFO - 2015-12-01 09:02:12,828 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpCvJRQr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:02:24 INFO - 2015-12-01 09:02:24,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 198066176 09:02:24 INFO - 2015-12-01 09:02:24,606 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 09:02:46 INFO - 2015-12-01 09:02:46,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 516001792 09:02:46 INFO - 2015-12-01 09:02:46,332 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: |0;Richards;166.16816218012627 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.8761213972132 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.94524119947846 09:02:46 INFO - 2015-12-01 09:02:46,333 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1021.4504596527069 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: |5;Earley;663.1299734748011 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: |7;RegExp;29285.714285714286 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: |8;Splay;577.7007510109763 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5791.907514450867 09:02:46 INFO - 2015-12-01 09:02:46,334 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: __startTimestamp1448989366324__endTimestamp 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: Values: 166.2 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,335 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: Values: 190.9 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.95 Median:325.95 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: Values: 325.9 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: Values: 5758.6 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,336 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1021.45 Median:1021.45 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: Values: 1021.5 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:663.13 Median:663.13 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: Values: 663.1 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: Values: 12132.5 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,337 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29285.71 Median:29285.71 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: Values: 29285.7 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:577.70 Median:577.70 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: Values: 577.7 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5791.91 Median:5791.91 stddev:0.00 (0.0%) 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: Values: 5791.9 09:02:46 INFO - 2015-12-01 09:02:46,338 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:02:46 INFO - 2015-12-01 09:02:46,339 DEBUG : BROWSER_OUTPUT: 09:02:46 INFO - 2015-12-01 09:02:46,991 INFO : Browser exited with error code: 0 09:02:47 INFO - 2015-12-01 09:02:47,010 INFO : Completed test v8_7 (00:00:37) 09:02:47 INFO - 2015-12-01 09:02:47,502 INFO : Completed test suite (00:20:10) 09:02:47 INFO - 2015-12-01 09:02:47,502 DEBUG : Working with test: dromaeo_css 09:02:47 INFO - 2015-12-01 09:02:47,502 DEBUG : Generating results file: dromaeo_css 09:02:47 INFO - 2015-12-01 09:02:47,503 DEBUG : Working with test: kraken 09:02:47 INFO - 2015-12-01 09:02:47,503 DEBUG : Generating results file: kraken 09:02:47 INFO - 2015-12-01 09:02:47,503 INFO : javascript benchmark 09:02:47 INFO - 2015-12-01 09:02:47,503 DEBUG : Working with test: v8_7 09:02:47 INFO - 2015-12-01 09:02:47,503 DEBUG : Generating results file: v8_7 09:02:47 INFO - 2015-12-01 09:02:47,503 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:02:47 INFO - 2015-12-01 09:02:47,567 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:02:47 INFO - 2015-12-01 09:02:47,567 DEBUG : process_Request line: dromaeo_css 6668.19 graph.html#tests=[[72,52,55]] 09:02:47 INFO - 2015-12-01 09:02:47,567 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:02:47 INFO - 2015-12-01 09:02:47,597 DEBUG : process_Request line: kraken 1484.20 graph.html#tests=[[232,52,55]] 09:02:47 INFO - 2015-12-01 09:02:47,597 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:02:47 INFO - 2015-12-01 09:02:47,627 DEBUG : process_Request line: v8_7 20492.45 graph.html#tests=[[230,52,55]] 09:02:47 INFO - 2015-12-01 09:02:47,628 INFO : javascript benchmark 09:02:47 INFO - 2015-12-01 09:02:47,630 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [345.2421933855187, 357.7174032514314, 359.5344029481821, 359.7409864897274, 360.3819449643861, 15198.240087995611, 15399.69200615987, 17944.192511336987, 18277.817221827794, 18984.0, 15675.60810979726, 18215.27138914445, 18513.444596662088, 18946.90526547365, 19007.61984760304, 4736.076465089309, 4855.805767769302, 5256.421793602701, 5409.513143817056, 5422.83731488054, 3599.226166374229, 3679.337719210541, 4783.378160839086, 4844.709317440947, 4879.975600121995, 4774.785134668949, 4825.059113472874, 4827.300041493982, 4828.2274836026245, 4842.9031419371595, 4691.179043667379, 4787.521247875185, 4820.975895120519, 4826.396700412449, 4835.2505361669, 4039.63643272104, 4044.6562042226446, 4045.4538637283886, 4045.797710114512, 4050.0887300357476, 13499.66250843727, 13612.183269003892, 13706.177629342172, 13720.382582783699, 13727.931360343235, 1904.7047707605343, 1911.44568075258, 2026.9087891044937, 2029.4520479470607, 2052.7741948385665, 9688.176504997084, 9830.9508452458, 9985.350952188157, 10112.342697724624, 10166.0, 1513.4854149589194, 1543.5678010157174, 1584.4771225495558, 1585.4054729476447, 1599.2323684631442, 57418.42581574173, 57936.420635793525, 61470.38529614736, 63724.362756372306, 63749.0, 6557.278699343068, 6626.271110177877, 6628.436582890412, 6634.86730265392, 6686.4985126115735, 7583.5070720403, 7584.241575842371, 7592.8481430371085, 7594.202608726005, 7595.962020189863, 5701.2018317435595, 5710.086386178192, 5803.390643982406, 5827.621204621686, 5841.32824725162, 6408.743650254031, 6414.0, 6428.550001499943, 6451.612903225821, 6451.806445806634, 3062.846857657108, 3078.4458797416232, 3093.90718278452, 3109.0672798160463, 3109.3781243750886, 1014.5028935821394, 1029.1098200056897, 1086.5925278020743, 1102.8841971593029, 1109.20691705431, 391.30738592691347, 415.55120469892444, 423.25718364270506, 429.56399254756445, 441.66654176097484, 10169.796604068026, 10496.947515262527, 10927.125829933586, 11042.0, 11176.720581985353, 395.2608621877108, 397.5845241722407, 405.57414714549606, 417.6637806565683, 420.2225882118057, 5900.881982360414, 6019.097135429721, 6326.46225070865, 6345.682715864281, 6372.235331760218, 503747.0, 557771.0, 607147.0, 608155.0, 609334.0, 76093.6195319031, 76338.0, 79074.60462697649, 79197.60401197957, 82747.0, 436.53290978652535, 446.2324801341752, 446.5133005024539, 447.02771472048164, 447.3781443793195, 10331.638392656221, 10662.89337106619, 10717.571297148026, 11040.282381645167, 11639.883601164218, 36226.0, 36566.0, 37512.812435937645, 37659.62340376561, 37966.81016594899, 48678.51321486881, 48815.511844882516, 48879.26681099715, 49200.0, 49282.0, 6353.269374022047, 6424.678766061585, 6428.774992875227, 6429.774957876639, 6438.871222575429, 12186.146969712036, 12379.195352302071, 12425.689357766129, 12584.18202816814, 12679.429425675682, 10711.464426778786, 10739.140868730326, 10847.620333288613, 11026.834597481205, 11035.944820275847, 10008.14930730867, 10490.423026733602, 10550.419726915094, 10629.362238265729, 10831.458427078456, 8465.534395608054, 8818.735437936615, 8847.73456796297, 10661.200409969439, 10911.454427278763, 6215.409536094064, 6219.0982307566055, 6224.408681175281, 6344.206974128234, 6345.90481142774, 10578.15374770032, 10732.624358147428, 10944.562217511211, 10958.616448424267, 10960.835587466036], "dojo.html": [3156.6685498022703, 3226.3547290541896, 3241.384137013967, 3263.820489873057, 3270.5094235864617, 5441.29263195785, 5444.6188766786345, 5452.809151679692, 5455.454454554542, 5474.343078830536, 5440.265564148839, 5460.426655201206, 5461.098918678414, 5466.753996070176, 5468.343798744147, 4916.410030796292, 4986.5761410280165, 5020.648554601179, 5046.97476512617, 5068.493150684921, 5069.163588007993, 5090.9236361454605, 5096.923546146811, 5103.770330335144, 5114.002769459957, 4923.359963204796, 5077.796888124471, 5079.060373830835, 5093.719845408519, 5095.490450954912, 5006.649534532584, 5083.364579427572, 5086.949130508721, 5096.821611243588, 5103.464136265694, 5055.974720126413, 5079.1365467870555, 5103.719295438749, 5133.486651334874, 5165.328507294065, 4948.208286674151, 5206.9846379955925, 5361.142217245222, 5511.311086114236, 5548.389677135512, 5777.0, 5789.681567513785, 5849.38581448946, 5857.297124345063, 5860.912086318709, 5844.503217226541, 5883.794067207627, 5912.733926973297, 5925.614835035709, 5928.555358348098, 5409.891802163974, 5449.591280653967, 5521.751521181556, 5521.861953451155, 5534.308211473566, 6045.183900173508, 6049.715781824006, 6055.909161362583, 6061.181740465069, 6063.151158837766, 5768.307803063659, 5814.912776308359, 5815.389384114607, 5852.15143804146, 5853.209816674695, 5726.312842458931, 5731.312242530923, 5844.12338149281, 5872.500837428866, 5991.910121348184, 5835.0, 5839.065749480063, 5855.4730074292665, 5857.121431785181, 5865.208196893364, 5838.153467747238, 5843.678597677083, 5858.033424484997, 5863.296404431496, 5871.765129394862, 4427.158839820424, 4468.642508599304, 4512.458504979423, 4561.384213131185, 4623.329617205486, 4185.9953611133715, 4205.285101532686, 4213.536510983789, 4214.4099826024385, 4222.176675548239, 5460.180972854024, 5469.15228139639, 5481.643693160012, 5488.368837583729, 5516.806911758069, 5723.8569035774435, 5766.682832444172, 5840.970795145997, 5841.561882858802, 5891.49922256613, 5469.234307196995, 5539.723013849291, 5542.63972841764, 5565.443455654483, 5568.860778480571, 5242.449542798027, 5261.605379596545, 5276.657017293864, 5286.180642000496, 5298.814541491107, 5725.885482290331, 5786.913196302143, 5832.241808564944, 5842.591018628826, 5919.822405327847, 5953.791617293374, 6006.519478441627, 6012.368701286477, 6021.187139736079, 6033.12519684652, 6035.758569657341, 6050.273967123973, 6061.212042434456, 6065.059915713072, 6069.605475644069, 5579.386267510489, 5656.830295091154, 5698.886022279614, 5702.087665973424, 5785.537157027344, 5964.433378829004, 5978.521718262616, 5979.043353063489, 5980.760769569342, 5983.820485385445, 5808.651480911159, 5811.680357580373, 5821.446962538552, 5830.0, 5834.124881267844, 5526.640768350045, 5645.068563686946, 5661.235733175969, 5664.971675141598, 5720.771169153188, 5641.351244606923, 5661.405552417102, 5669.744861481161, 5679.346875109415, 5699.8860022800145, 5802.361740208658, 5805.535557155333, 5814.94185058144, 5819.6508209507565, 5847.035239185657, 5446.101393270066, 5563.666180029211, 5564.749586268708, 5574.749136288958, 5665.433456654467], "mootools.html": [1280.4686055287057, 1720.7332863406173, 1804.7202683584042, 1821.5355084453467, 1833.532449225448, 6640.800775976722, 6945.236024037352, 7141.964290178548, 7145.8928116078305, 7156.677949492272, 7111.466640002008, 7286.6356682165815, 7286.854262914739, 7287.453440991921, 7312.780616581498, 2139.1336508713994, 2160.5678864227216, 2160.9783902160934, 2162.372911855568, 2164.480524674075, 2156.4608847788054, 2182.03990244292, 2223.0885337011828, 2223.3107736601623, 2230.197129033547, 2141.5288636499945, 2163.4266919266406, 2170.0, 2174.2716190076344, 2175.216921908112, 2162.9242976495825, 2173.576152650234, 2174.923877664274, 2175.575762726269, 2176.7170267865154, 2157.870527768339, 2171.9022643981057, 2173.152470536492, 2177.161792709818, 2177.5971445282676, 6603.339666033358, 6841.110655614738, 7236.565806051653, 7263.782086537412, 7275.308845659654, 4422.071365013351, 4551.044280701057, 4554.066416384633, 4566.657500687462, 4569.223232050559, 2819.4361127774323, 2851.244420228641, 2891.8698658560415, 2895.7683385329124, 2919.0, 848.5926755157559, 860.7675927499603, 860.9009963854112, 864.0279685353977, 881.7839629290864, 9537.33238673293, 9595.23238140947, 9595.42427454355, 9603.37578057424, 9618.326717129734, 3986.80065996699, 3988.780617066031, 4026.094128820992, 4039.030632648202, 4066.0, 8504.659813607386, 8513.14868513156, 8519.914800852037, 8524.232819046316, 8529.95735021321, 4613.515580864028, 4631.282151266559, 4632.652551058684, 4634.142683603544, 4645.187092258841, 4231.894202644959, 4246.787660616957, 4248.851290204828, 4252.31962885943, 4256.382824490432, 3406.386850366908, 3426.9657303426648, 3434.0556347004276, 3446.7759595626203, 3458.723302135823, 1081.2053140941402, 1094.4473041114186, 1097.286763603648, 1103.8178700514486, 1104.6244276945877, 1304.7586196553668, 1311.1936159261986, 1311.7048664050512, 1313.8292022037074, 1335.2122247873801, 6999.615021173884, 7028.437724981989, 7067.187273463617, 7076.0, 7076.716931322792, 423.7881059470265, 433.3359897991727, 449.07266494689014, 453.4694407543182, 453.6144277364214, 5152.793888244429, 5595.972020139873, 5655.802046928337, 5657.8019769307875, 5659.066254068032, 7815.374770018385, 8251.669933202606, 8377.6230069647, 8383.11977242393, 8406.075331713506, 8183.71357002502, 8271.0, 8307.37694672902, 8311.293540049164, 8314.542700151429, 6829.829254268584, 6876.0, 6879.277675844064, 6881.346272104142, 6906.689198986058, 6670.699818508082, 6679.6994135265, 6680.265170831108, 6682.164729408824, 6694.430973367318, 7392.741254056083, 7568.659410326659, 7574.772756817304, 7597.962010189914, 7601.809954751176, 7388.335049845539, 7520.511166774142, 7538.396928245617, 7546.094468663796, 7550.7734767957045, 6544.9672751635935, 6562.048502967138, 6621.801345959629, 6638.369354911276, 6641.634710090992, 7052.118485189351, 7084.539504932163, 7088.929110709033, 7097.112860892388, 7116.039334689957, 6554.80335589933, 6653.933460665331, 6699.09562209115, 6739.0, 6763.425108865801, 6596.472282217315, 6599.670016499252, 6625.337466253336, 6668.43318317929, 6683.7660681875905, 6669.899951500828, 6759.932400675931, 6792.286809885089, 6803.047573339637, 6815.89776153368, 5894.469497745224, 5943.257092863392, 5946.851328716817, 5947.464728174485, 5957.463828255478, 5893.086571581412, 5939.316978547349, 5955.344912059757, 5963.314218864886, 5964.075568286922], "ext.html": [556.6709701488875, 594.1562980567594, 597.3488897102158, 601.6450294326347, 602.4668168670725, 34072.82963585182, 41817.0, 42562.99999999996, 42643.36034959478, 42653.36019959703, 45178.0, 45748.085038299294, 45823.31265031027, 45942.7702861486, 45956.08087838241, 8729.34529910256, 8958.059403762609, 9348.392354496953, 9535.046495350443, 9581.473018983954, 11258.718532036724, 11468.942655286712, 11489.885101148966, 11490.36802975836, 11514.42427878607, 11234.831477527803, 11330.886691133066, 11336.716582085432, 11366.71583210418, 11378.260413073165, 8979.0, 9185.448873067571, 11234.3259404436, 11335.0, 11394.373309467976, 11023.669289921316, 11176.832347514794, 11194.216404851664, 11197.552097916156, 11201.0, 42261.36607950883, 42727.57272427267, 42771.57228427707, 42775.35836962448, 42818.35772463385, 3054.831984240866, 3079.8922037728794, 3204.6314673812344, 3394.6096198937194, 3494.0, 27891.302717432023, 28630.856845715847, 28858.855705721548, 28894.711052889623, 29193.708062919522, 2383.4398916254668, 2389.175734371639, 2416.6979127609047, 2418.7460316666675, 2424.478737071538, 263947.0, 264006.0, 264500.0, 264978.9999999981, 265047.0, 56167.43832561622, 57977.42022579804, 63749.68125159344, 64365.678171608844, 64829.0, 58135.12797308044, 58572.70713646404, 58862.11706824401, 58879.0, 59029.704851475464, 18062.36781712634, 18446.0, 18457.0, 18468.261269549068, 18475.81524184768, 13878.306084695725, 13946.372413241428, 13955.092918960236, 13958.0, 13965.58103256904, 20715.689264661043, 20992.580148396948, 21017.68473472899, 21048.579028419652, 21080.894595527232, 8961.507117108491, 9180.265578753817, 9191.0, 9211.309151813506, 9253.676121335855, 1000.3747657713928, 1022.3814592171777, 1056.7939251845817, 1075.3171735947728, 1094.0591091661165, 30235.395292094036, 30255.394892102035, 30439.69560304413, 30523.8473807634, 30789.69210307913, 1031.8297480915564, 1082.1775450657399, 1108.5177947592822, 1183.0594677231622, 1263.2231177825572, 15570.221488925508, 15766.527004189893, 16168.919155404383, 16294.0, 16489.34042638305, 343257.0, 348824.0, 349579.0, 351286.0, 351552.0, 51348.22977655338, 52195.21707174395, 57360.13959790606, 58479.70760146172, 59181.40818591845, 1445.7759047347467, 1464.72170287645, 1489.9180545069692, 1499.4601943300404, 1501.0, 26231.868840655676, 26612.0, 28681.214750113344, 29023.27441813887, 30517.389652207276, 47917.0, 48280.0, 48296.275555865985, 48344.516554835405, 48350.27474587954, 283415.0, 284106.0, 284208.0, 285151.0, 285529.0, 33183.50224746679, 33698.66301337053, 33800.66199337975, 34044.0, 34163.0, 38586.22827543489, 39743.602563975146, 39841.80079099586, 40827.38758918559, 41167.588324116376, 35374.82312588523, 35674.28651427009, 37022.19482120787, 37027.8148609266, 37493.0, 35837.283254334245, 36541.634583654886, 36903.0, 37297.81351093227, 37376.0, 34076.65923340735, 35187.12032199215, 35239.0, 35275.64724352826, 35337.0, 28234.396520119004, 32204.19489512781, 32558.186045349055, 32700.672993269764, 32711.18222044468, 24776.132835350676, 25004.245796661537, 25237.242882712813, 26321.0, 26683.0], "prototype.html": [296.4767185916856, 305.106039304837, 306.51264489461755, 313.85092081261405, 316.22840269741835, 6055.909161362583, 6103.420175083365, 6137.81586552403, 6200.472959798417, 6225.315215326316, 5985.940140598593, 6074.8481287967825, 6098.603590766597, 6112.6638034908065, 6128.60164089335, 4456.532064133252, 4590.334401511787, 4600.1029799189, 4600.401947746788, 4641.883952901171, 4547.386102876102, 4567.1550763108935, 4613.838515651953, 4629.166749985001, 4638.814447422099, 4541.250693635546, 4546.681732278742, 4553.453585569736, 4568.908621827562, 4589.2198326284615, 4533.206688829442, 4547.931781023271, 4552.135094332067, 4557.817687292504, 4563.70335928167, 3852.6917846572205, 3869.7097717671286, 3878.631530004673, 3899.025243689078, 3903.941440878389, 5644.125160600072, 5932.703364831741, 5937.020391635375, 5953.13679516472, 5984.102384642295, 5095.79616815327, 5112.488751124895, 5112.846614601568, 5125.384953805567, 5128.333316668846, 6365.1725275714325, 6366.840828979266, 6368.363163683641, 6369.426751592333, 6376.234851817765, 4110.527289361702, 4202.054537729017, 4204.1591681663485, 4261.74429534229, 4286.828526858922, 6745.392914637657, 6771.796846094625, 6808.931910680879, 6813.454923606099, 6840.6921688523635, 4335.978320108442, 4349.630281426051, 4355.08543205924, 4356.803943822536, 4368.978155109204, 4356.346548017759, 4363.127374525107, 4390.341448782644, 4391.099824535962, 4409.36064270679, 5040.823571174991, 5158.484151584811, 5158.896822063538, 5212.869678258074, 5224.52979231871, 6395.904061439082, 6410.61536307823, 6422.100905873182, 6442.613443193423, 6464.095026696266, 1553.30101454346, 1569.0977687829543, 1571.0573655806654, 1572.3396173607111, 1574.7637854321715, 996.9750756231152, 998.8851282102651, 1013.422349260929, 1016.9796604068025, 1024.2727663359099, 6174.25908890936, 6176.69116544171, 6180.196574445384, 6187.381261873777, 6189.381061893775, 6494.0, 6590.472762179014, 6601.73593056282, 6674.9666251669405, 6689.096971908827, 6070.150178974947, 6103.328633850273, 6104.4505994460715, 6105.0, 6135.969320153371, 3692.9446058309145, 3716.758410703296, 3723.94414083789, 3738.32710112177, 3738.5700644425697, 6552.475801935833, 6743.426808721216, 6756.662166891734, 6760.864782704417, 6771.593704377753, 6936.306369363023, 6939.93060069403, 6945.2707465716385, 6953.130858642669, 6960.825979350557, 6696.330366963265, 6864.897026544606, 6869.793906182823, 6886.690098945459, 6891.483138764613, 6796.35434633709, 6812.795616131524, 6836.111305530249, 6837.794866154023, 6848.7260509579055, 6598.406143447113, 6634.4692424604955, 6634.734610615715, 6638.867222655424, 6650.301718319507, 6653.63405012729, 6858.5199036067, 6867.244603093556, 6875.518713689994, 6894.069300644349, 4149.8340066397, 4150.8547200847825, 4181.038361176886, 4184.895377615584, 4187.036981494212, 6772.5936443813525, 6783.660816959231, 6786.59280443175, 6790.626515541692, 6803.693833777591, 6582.243042050034, 6587.176602924635, 6600.438962688226, 6607.975763756625, 6610.272869984202, 6396.488280937607, 6475.417212450902, 6485.15692959931, 6508.316626754123, 6537.1174891389055, 6329.683515824282, 6333.841653958688, 6352.237731472253, 6352.491800656029, 6376.234851817811, 6303.338149494237, 6483.059956306403, 6493.123428337114, 6500.154979852589, 6504.837379065561, 6144.631322120687, 6228.4705800007505, 6232.283287421823, 6344.492440604648, 6356.904646430215], "yui.html": [768.3622593247605, 792.4340467894478, 792.5244853088147, 797.2704974947923, 805.2430715127778, 13501.0, 13999.790003149961, 14018.789718154236, 14050.08674436161, 14051.578452646425, 13151.210927344342, 13317.334133293345, 13344.933275333635, 13365.331733413339, 13372.732545349087, 937.5218638494383, 952.7094236257973, 952.7713348796308, 954.4511905654276, 954.7326748510428, 958.7363475044384, 966.9613215471372, 967.5355829201987, 967.7435479597913, 967.849983252597, 1006.7130867702706, 1011.7066050845283, 1013.6401577440013, 1014.137982714694, 1014.9188064954786, 1009.0615727373539, 1009.4750729620592, 1009.9040591143867, 1010.5604062232952, 1012.1093437774748, 743.5650144665377, 743.6542007966322, 743.7434085240583, 744.6128013433039, 746.6229554075157, 13828.654283642889, 14013.0, 14015.0, 14055.718885622333, 14075.929620351935, 12034.33811140387, 12086.818697719542, 12324.198927069712, 12469.376531173404, 12511.687207819787, 9179.403338782959, 9331.626734930594, 9639.614415423375, 9841.655542055994, 10096.394216347042, 3338.7162091222276, 3426.2119712466274, 3442.9655703443145, 3444.328355970587, 3444.621091679913, 42529.78735106336, 42752.57247427548, 48867.0, 49693.75153124211, 49868.0, 9117.863232051524, 9498.572564234626, 9509.381890177116, 9520.0, 9689.370190937567, 20293.18827246923, 20460.181592736124, 20572.588548228952, 20576.074076666588, 20591.176352946015, 7229.09636295463, 7512.286332798485, 7556.319931206218, 7558.357539609085, 7704.6532906019365, 3874.535055793323, 3962.2471730371135, 4022.2960981828064, 4059.2084543513733, 4072.9796351018053, 3004.6244219472565, 3032.3783624357393, 3034.059441573075, 3041.1636799879766, 3045.6192975878016, 421.6394982290159, 430.3931456646114, 438.160921834683, 438.20684560944153, 441.72833707269797, 512.4772731813604, 562.7298896529688, 571.5113577890927, 581.3866370978574, 600.9128676341905, 7075.150981882207, 7136.536125151849, 7282.599457029808, 7317.341439270491, 7331.74338898136, 481.2900971067717, 565.6549504802067, 575.4590684756315, 593.8040446652594, 608.7473698415197, 3605.7656252343513, 3627.383344831385, 3662.1027848176836, 3664.670179683841, 4097.651699605567, 55370.0, 55618.0, 55782.0, 61667.69166154141, 62560.37439625546, 50346.496535034916, 50360.748196258784, 50379.0, 50537.24194137091, 53575.73212133993, 41594.79202604028, 43699.56300436955, 45601.315980260326, 46021.76989115033, 46242.07515849664, 7785.260400261966, 8394.45436046655, 8411.0, 8453.112423195476, 8686.087960764282, 30426.695733042387, 35739.82130089333, 36180.27639447144, 36813.26373472569, 36844.81577592095, 46939.530604693515, 47169.528304716514, 47197.29204062011, 50123.24815127849, 50191.49808502015, 7503.287187717158, 7533.9246607535415, 7543.849123017619, 7562.281583249583, 7660.463767536219, 10957.397343146204, 11076.169287303646, 11202.83195752048, 11949.0, 12289.201201921847, 10044.698659040241, 10239.283250172715, 10427.322224055411, 10476.528556214836, 10795.838062428913, 10495.632652857113, 10592.205584581341, 10817.837732433862, 10882.0, 10942.0, 10027.749306267402, 10142.54358553852, 10220.693379198636, 10315.0, 10361.430121343097, 9084.682036128968, 9370.812583748424, 9395.483248421402, 9690.37012594179, 9916.355436896578, 9339.112784285482, 9386.906130938876, 9393.217997206764, 9407.341486095907, 9578.137967582672]}, "summary": {"suite": 6668.192752809779, "subtests": {"jquery.html": {"filtered": 6812.866358890701, "value": 6812.866358890701}, "dojo.html": {"filtered": 5427.337975922766, "value": 5427.337975922766}, "mootools.html": {"filtered": 4139.312349404617, "value": 4139.312349404617}, "ext.html": {"filtered": 19403.599083467016, "value": 19403.599083467016}, "prototype.html": {"filtered": 4788.231720066376, "value": 4788.231720066376}, "yui.html": {"filtered": 6181.661873910635, "value": 6181.661873910635}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0002"}, "testrun": {"date": 1448988156, "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": "20151201072831", "branch": "Mozilla-Aurora", "revision": "77de40d65ca2359f1dfe7f23640e58866a654711"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0], "ai-astar": [108.0, 106.0, 106.0, 106.0, 108.0, 110.0, 115.0, 110.0, 107.0, 106.0], "imaging-gaussian-blur": [121.0, 115.0, 120.0, 115.0, 120.0, 115.0, 115.0, 115.0, 114.0, 114.0], "audio-beat-detection": [156.0, 131.0, 158.0, 153.0, 127.0, 150.0, 128.0, 158.0, 148.0, 124.0], "json-stringify-tinderbox": [66.0, 65.0, 64.0, 65.0, 64.0, 66.0, 66.0, 66.0, 66.0, 65.0], "stanford-crypto-pbkdf2": [154.0, 143.0, 144.0, 143.0, 144.0, 143.0, 145.0, 142.0, 144.0, 146.0], "json-parse-financial": [58.0, 61.0, 62.0, 62.0, 64.0, 63.0, 63.0, 71.0, 57.0, 57.0], "stanford-crypto-sha256-iterative": [67.0, 71.0, 68.0, 69.0, 69.0, 68.0, 67.0, 70.0, 67.0, 69.0], "audio-fft": [80.0, 76.0, 83.0, 119.0, 67.0, 70.0, 70.0, 69.0, 117.0, 69.0], "imaging-darkroom": [124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0], "stanford-crypto-ccm": [127.0, 126.0, 120.0, 118.0, 122.0, 129.0, 127.0, 121.0, 120.0, 121.0], "audio-oscillator": [100.0, 95.0, 133.0, 89.0, 88.0, 88.0, 128.0, 89.0, 87.0, 133.0], "stanford-crypto-aes": [81.0, 82.0, 83.0, 80.0, 83.0, 80.0, 81.0, 82.0, 84.0, 86.0], "imaging-desaturate": [100.0, 100.0, 100.0, 99.0, 99.0, 100.0, 101.0, 100.0, 101.0, 101.0]}, "summary": {"suite": 1484.1999999999998, "subtests": {"audio-fft": {"filtered": 82.0, "value": 82.0}, "stanford-crypto-pbkdf2": {"filtered": 144.8, "value": 144.8}, "audio-beat-detection": {"filtered": 143.3, "value": 143.3}, "stanford-crypto-ccm": {"filtered": 123.1, "value": 123.1}, "imaging-darkroom": {"filtered": 124.0, "value": 124.0}, "json-parse-financial": {"filtered": 61.8, "value": 61.8}, "audio-oscillator": {"filtered": 103.0, "value": 103.0}, "ai-astar": {"filtered": 108.2, "value": 108.2}, "audio-dft": {"filtered": 161.5, "value": 161.5}, "stanford-crypto-sha256-iterative": {"filtered": 68.5, "value": 68.5}, "json-stringify-tinderbox": {"filtered": 65.3, "value": 65.3}, "imaging-gaussian-blur": {"filtered": 116.4, "value": 116.4}, "stanford-crypto-aes": {"filtered": 82.2, "value": 82.2}, "imaging-desaturate": {"filtered": 100.1, "value": 100.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0002"}, "testrun": {"date": 1448988156, "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": "20151201072831", "branch": "Mozilla-Aurora", "revision": "77de40d65ca2359f1dfe7f23640e58866a654711"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.8761213972132], "Encrypt": [325.94524119947846], "NavierStokes": [5791.907514450867], "Decrypt": [5758.620689655172], "Splay": [577.7007510109763], "Richards": [166.16816218012627], "RegExp": [29285.714285714286], "Earley": [663.1299734748011], "Boyer": [12132.530120481928], "RayTrace": [1021.4504596527069]}, "summary": {"suite": 20492.45165121168, "subtests": {"DeltaBlue": {"filtered": 346.39220200000005, "value": 346.39220200000005}, "Encrypt": {"filtered": 816.6433079999998, "value": 816.6433079999998}, "NavierStokes": {"filtered": 256.2195608782433, "value": 256.2195608782433}, "Decrypt": {"filtered": 46.22304790419163, "value": 46.22304790419163}, "Splay": {"filtered": 141.06092100000006, "value": 141.06092100000006}, "RegExp": {"filtered": 31.10680487804877, "value": 31.10680487804877}, "Richards": {"filtered": 212.4474360000001, "value": 212.4474360000001}, "Earley": {"filtered": 1005.0262039999998, "value": 1005.0262039999998}, "Boyer": {"filtered": 54.93190566037737, "value": 54.93190566037737}, "RayTrace": {"filtered": 724.4492309999999, "value": 724.4492309999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0002"}, "testrun": {"date": 1448988156, "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": "20151201072831", "branch": "Mozilla-Aurora", "revision": "77de40d65ca2359f1dfe7f23640e58866a654711"}}] 09:02:47 INFO - RETURN: dromaeo_css: 6668.19 09:02:47 INFO - RETURN: kraken: 1484.20 09:02:47 INFO - RETURN: v8_7: 20492.45 09:02:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20492.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1484.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6668.19"}}} 09:02:47 INFO - Return code: 0 09:02:47 INFO - # TBPL SUCCESS # 09:02:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:02:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:02:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:02:47 INFO - 2015-12-01 09:02:47.723 screenresolution[1684:14917] starting screenresolution argv=screenresolution get 09:02:47 INFO - 2015-12-01 09:02:47.726 screenresolution[1684:14917] Display 0: 1600x1200x32@60 09:02:47 INFO - 2015-12-01 09:02:47.732 screenresolution[1685:14921] starting screenresolution argv=screenresolution list 09:02:47 INFO - Available Modes on Display 0 09:02:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:02:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:02:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:02:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:02:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:02:47 INFO - Intel HD Graphics 3000: 09:02:47 INFO - Chipset Model: Intel HD Graphics 3000 09:02:47 INFO - Type: GPU 09:02:47 INFO - Bus: Built-In 09:02:47 INFO - VRAM (Total): 512 MB 09:02:47 INFO - VRAM (Dynamic, Max): 10 09:02:47 INFO - Vendor: Intel (0x8086) 09:02:47 INFO - Device ID: 0x0116 09:02:47 INFO - Revision ID: 0x0009 09:02:47 INFO - Displays: 09:02:47 INFO - Display: 09:02:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:02:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:02:47 INFO - Display Serial Number: 1600x1200 60 09:02:47 INFO - Main Display: Yes 09:02:47 INFO - Mirror: Off 09:02:47 INFO - Online: Yes 09:02:47 INFO - Rotation: Supported 09:02:47 INFO - Return code: 0 09:02:47 INFO - Running post-action listener: _resource_record_post_action 09:02:47 INFO - Running post-run listener: _resource_record_post_run 09:02:49 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 38089728; Write bytes: 680278016; Read time: 5790; Write time: 177225 09:02:49 INFO - install - Wall time: 39s; CPU: 29.0%; Read bytes: 336908800; Write bytes: 334460928; Read time: 33967; Write time: 38298 09:02:49 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 36893696; Write bytes: 335548416; Read time: 4251; Write time: 136676 09:02:49 INFO - Running post-run listener: _upload_blobber_files 09:02:49 INFO - Blob upload gear active. 09:02:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:02:49 INFO - Copying logs to upload dir... 09:02:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1332.560152 ========= master_lag: 53.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 5 secs) (at 2015-12-01 09:03:42.256634) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-12-01 09:03:42.261096) ========= 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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010173 build_url: 'https://queue.taskcluster.net/v1/task/Ellj15wkTsaXZ1ImWkZb8w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 2.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-12-01 09:03:44.291552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 09:03:44.291877) ========= 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.k32x0WxAwn/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.ArsCog6PRg/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/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.005321 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 09:03:44.407638) ========= ========= Started reboot skipped (results: 3, elapsed: 19 secs) (at 2015-12-01 09:03:44.407967) ========= ========= Finished reboot skipped (results: 3, elapsed: 19 secs) (at 2015-12-01 09:04:03.759522) ========= ========= Total master_lag: 55.65 =========