builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0023 starttime: 1449000994.76 results: success (0) buildid: 20151201104822 builduid: 63269702add34a02aec42c44c9df5000 revision: bb474924f23bfa27e850fd895448ccf4d85ed5c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:34.757849) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:34.758299) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:34.758580) ========= 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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.006183 basedir: '/builds/slave/test' ========= master_lag: 0.36 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.126223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.126600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.403814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.404223) ========= 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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.029095 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.469238) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.469533) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.469882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.470164) ========= 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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:16:35-- 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.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-12-01 12:16:35 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.253091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.743609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.743909) ========= 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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.136349 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.930466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:35.930805) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb474924f23bfa27e850fd895448ccf4d85ed5c8 --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 bb474924f23bfa27e850fd895448ccf4d85ed5c8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:16:36,034 truncating revision to first 12 chars 2015-12-01 12:16:36,034 Setting DEBUG logging. 2015-12-01 12:16:36,034 attempt 1/10 2015-12-01 12:16:36,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb474924f23b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-01 12:16:36,293 unpacking tar archive at: mozilla-aurora-bb474924f23b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604116 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:36.692537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:36.692802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:36.760503) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:36.760763) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 12:16:36.761150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2015-12-01 12:16:36.761423) ========= /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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:16:37 INFO - MultiFileLogger online at 20151201 12:16:37 in /builds/slave/test 12:16:37 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 12:16:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:37 INFO - {'append_to_log': False, 12:16:37 INFO - 'base_work_dir': '/builds/slave/test', 12:16:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:16:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:37 INFO - 'branch': 'Mozilla-Aurora', 12:16:37 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:37 INFO - 'config_files': ('talos/mac_config.py',), 12:16:37 INFO - 'default_actions': ('clobber', 12:16:37 INFO - 'read-buildbot-config', 12:16:37 INFO - 'download-and-extract', 12:16:37 INFO - 'populate-webroot', 12:16:37 INFO - 'create-virtualenv', 12:16:37 INFO - 'install', 12:16:37 INFO - 'run-tests'), 12:16:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:37 INFO - 'download_minidump_stackwalk': True, 12:16:37 INFO - 'download_symbols': 'ondemand', 12:16:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:37 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:37 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:37 INFO - 'installer_path': 'installer.exe', 12:16:37 INFO - 'log_level': 'info', 12:16:37 INFO - 'log_name': 'talos', 12:16:37 INFO - 'log_to_console': True, 12:16:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:16:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:16:37 INFO - 'opt_config_files': (), 12:16:37 INFO - 'pip_index': False, 12:16:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:16:37 INFO - 'cmd': ('bash', 12:16:37 INFO - '-c', 12:16:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:16:37 INFO - 'enabled': True, 12:16:37 INFO - 'halt_on_failure': False, 12:16:37 INFO - 'name': 'check_screen_resolution'},), 12:16:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:16:37 INFO - 'cmd': ('bash', 12:16:37 INFO - '-c', 12:16:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:16:37 INFO - 'enabled': True, 12:16:37 INFO - 'halt_on_failure': False, 12:16:37 INFO - 'name': 'check_screen_resolution'},), 12:16:37 INFO - 'run_cmd_checks_enabled': True, 12:16:37 INFO - 'sps_profile': False, 12:16:37 INFO - 'sps_profile_interval': 0, 12:16:37 INFO - 'suite': 'dromaeojs', 12:16:37 INFO - 'system_bits': '64', 12:16:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:37 INFO - 'title': 't-yosemite-r5-0023', 12:16:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:37 INFO - 'use_talos_json': True, 12:16:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:37 INFO - 'work_dir': 'build'} 12:16:37 INFO - ##### 12:16:37 INFO - ##### Running clobber step. 12:16:37 INFO - ##### 12:16:37 INFO - Running pre-action listener: _resource_record_pre_action 12:16:37 INFO - Running main action method: clobber 12:16:37 INFO - rmtree: /builds/slave/test/build 12:16:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:41 INFO - Running post-action listener: _resource_record_post_action 12:16:41 INFO - ##### 12:16:41 INFO - ##### Running read-buildbot-config step. 12:16:41 INFO - ##### 12:16:41 INFO - Running pre-action listener: _resource_record_pre_action 12:16:41 INFO - Running main action method: read_buildbot_config 12:16:41 INFO - Using buildbot properties: 12:16:41 INFO - { 12:16:41 INFO - "properties": { 12:16:41 INFO - "buildnumber": 288, 12:16:41 INFO - "product": "firefox", 12:16:41 INFO - "script_repo_revision": "production", 12:16:41 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 12:16:41 INFO - "repository": "", 12:16:41 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 12:16:41 INFO - "buildid": "20151201104822", 12:16:41 INFO - "slavename": "t-yosemite-r5-0023", 12:16:41 INFO - "pgo_build": "False", 12:16:41 INFO - "basedir": "/builds/slave/test", 12:16:41 INFO - "project": "", 12:16:41 INFO - "platform": "yosemite", 12:16:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:16:41 INFO - "slavebuilddir": "test", 12:16:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:16:41 INFO - "branch": "mozilla-aurora", 12:16:41 INFO - "repo_path": "releases/mozilla-aurora", 12:16:41 INFO - "stage_platform": "macosx64", 12:16:41 INFO - "builduid": "63269702add34a02aec42c44c9df5000", 12:16:41 INFO - "revision": "bb474924f23bfa27e850fd895448ccf4d85ed5c8" 12:16:41 INFO - }, 12:16:41 INFO - "sourcestamp": { 12:16:41 INFO - "repository": "", 12:16:41 INFO - "hasPatch": false, 12:16:41 INFO - "project": "", 12:16:41 INFO - "branch": "mozilla-aurora-macosx64-talos", 12:16:41 INFO - "changes": [ 12:16:41 INFO - { 12:16:41 INFO - "category": null, 12:16:41 INFO - "files": [ 12:16:41 INFO - { 12:16:41 INFO - "url": null, 12:16:41 INFO - "name": "https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 12:16:41 INFO - } 12:16:41 INFO - ], 12:16:41 INFO - "repository": "", 12:16:41 INFO - "rev": "bb474924f23bfa27e850fd895448ccf4d85ed5c8", 12:16:41 INFO - "who": "aklotz@mozilla.com", 12:16:41 INFO - "when": 1449000984, 12:16:41 INFO - "number": 6728895, 12:16:41 INFO - "comments": "Bug 1222933: Backout previous DLL blocklist change as it had no effect on crash; r=backout a=lizzard", 12:16:41 INFO - "project": "", 12:16:41 INFO - "at": "Tue 01 Dec 2015 12:16:24", 12:16:41 INFO - "branch": "mozilla-aurora-macosx64-talos", 12:16:41 INFO - "revlink": "", 12:16:41 INFO - "properties": [ 12:16:41 INFO - [ 12:16:41 INFO - "buildid", 12:16:41 INFO - "20151201104822", 12:16:41 INFO - "Change" 12:16:41 INFO - ], 12:16:41 INFO - [ 12:16:41 INFO - "builduid", 12:16:41 INFO - "63269702add34a02aec42c44c9df5000", 12:16:41 INFO - "Change" 12:16:41 INFO - ], 12:16:41 INFO - [ 12:16:41 INFO - "pgo_build", 12:16:41 INFO - "False", 12:16:41 INFO - "Change" 12:16:41 INFO - ] 12:16:41 INFO - ], 12:16:41 INFO - "revision": "bb474924f23bfa27e850fd895448ccf4d85ed5c8" 12:16:41 INFO - } 12:16:41 INFO - ], 12:16:41 INFO - "revision": "bb474924f23bfa27e850fd895448ccf4d85ed5c8" 12:16:41 INFO - } 12:16:41 INFO - } 12:16:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 12:16:41 INFO - Running post-action listener: _resource_record_post_action 12:16:41 INFO - ##### 12:16:41 INFO - ##### Running download-and-extract step. 12:16:41 INFO - ##### 12:16:41 INFO - Running pre-action listener: _resource_record_pre_action 12:16:41 INFO - Running main action method: download_and_extract 12:16:41 INFO - mkdir: /builds/slave/test/build/tests 12:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:41 INFO - https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/test_packages.json 12:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/test_packages.json 12:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:54 INFO - Downloaded 1149 bytes. 12:16:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:55 INFO - Using the following test package requirements: 12:16:55 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 12:16:55 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 12:16:55 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'jsshell-mac.zip'], 12:16:55 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 12:16:55 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 12:16:55 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 12:16:55 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 12:16:55 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 12:16:55 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 12:16:55 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:16:55 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 12:16:55 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:16:55 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')]} 12:16:55 INFO - https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:00 INFO - Downloaded 17490179 bytes. 12:17:00 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 12:17:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:17:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 12:17:05 INFO - Return code: 0 12:17:05 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 12:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:05 INFO - https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:07 INFO - Downloaded 17490179 bytes. 12:17:07 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 12:17:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:17:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 12:17:13 INFO - Return code: 0 12:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:13 INFO - https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:14 INFO - Downloaded 11131307 bytes. 12:17:14 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 12:17:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:17:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:17:14 INFO - Return code: 0 12:17:14 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')]} 12:17:14 INFO - https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 12:17:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:17:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:17:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 12:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:21 INFO - Downloaded 108650931 bytes. 12:17:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:17:21 INFO - mkdir: /builds/slave/test/properties 12:17:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:21 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:21 INFO - Contents: 12:17:21 INFO - build_url:https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:17:21 INFO - Running post-action listener: _resource_record_post_action 12:17:21 INFO - Running post-action listener: set_extra_try_arguments 12:17:21 INFO - ##### 12:17:21 INFO - ##### Running populate-webroot step. 12:17:21 INFO - ##### 12:17:21 INFO - Running pre-action listener: _resource_record_pre_action 12:17:21 INFO - Running main action method: populate_webroot 12:17:21 INFO - Guessing talos json url... 12:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:21 INFO - https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 12:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 12:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 12:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 12:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3rJalhFnQn-zMeNAp6hzdA/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 12:17:21 INFO - Downloaded 107 bytes. 12:17:21 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 12:17:21 INFO - Contents: 12:17:21 INFO - 20151201104822 12:17:21 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/bb474924f23bfa27e850fd895448ccf4d85ed5c8 12:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:21 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bb474924f2/testing/talos/talos.json 12:17:21 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bb474924f2/testing/talos/talos.json to /builds/slave/test/build/talos.json 12:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bb474924f2/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 12:17:22 INFO - Downloaded 4264 bytes. 12:17:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:17:22 INFO - '../fennec_ids.txt'], 12:17:22 INFO - 'tests': ['tcheck2']}, 12:17:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:22 INFO - '--tppagecycles', 12:17:22 INFO - '7'], 12:17:22 INFO - 'tests': ['tsvgm']}}, 12:17:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:17:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'tests': ['damp', 'tps']}, 12:17:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['damp', 'tps']}, 12:17:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:17:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:22 INFO - 'other': {'tests': ['a11yr', 12:17:22 INFO - 'ts_paint', 12:17:22 INFO - 'tpaint', 12:17:22 INFO - 'sessionrestore', 12:17:22 INFO - 'sessionrestore_no_auto_restore']}, 12:17:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['a11yr', 12:17:22 INFO - 'ts_paint', 12:17:22 INFO - 'tpaint', 12:17:22 INFO - 'sessionrestore', 12:17:22 INFO - 'sessionrestore_no_auto_restore']}, 12:17:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['a11yr', 12:17:22 INFO - 'ts_paint', 12:17:22 INFO - 'tpaint', 12:17:22 INFO - 'sessionrestore', 12:17:22 INFO - 'sessionrestore_no_auto_restore']}, 12:17:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['a11yr', 12:17:22 INFO - 'ts_paint', 12:17:22 INFO - 'tpaint', 12:17:22 INFO - 'sessionrestore', 12:17:22 INFO - 'sessionrestore_no_auto_restore']}, 12:17:22 INFO - 'other_l64': {'tests': ['a11yr', 12:17:22 INFO - 'ts_paint', 12:17:22 INFO - 'tpaint', 12:17:22 INFO - 'sessionrestore', 12:17:22 INFO - 'sessionrestore_no_auto_restore']}, 12:17:22 INFO - 'other_nol64': {'tests': ['a11yr', 12:17:22 INFO - 'ts_paint', 12:17:22 INFO - 'tpaint', 12:17:22 INFO - 'sessionrestore', 12:17:22 INFO - 'sessionrestore_no_auto_restore']}, 12:17:22 INFO - 'svgr': {'tests': ['tsvgx', 12:17:22 INFO - 'tsvgr_opacity', 12:17:22 INFO - 'tart', 12:17:22 INFO - 'tscrollx', 12:17:22 INFO - 'cart']}, 12:17:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['tsvgx', 12:17:22 INFO - 'tsvgr_opacity', 12:17:22 INFO - 'tart', 12:17:22 INFO - 'tscrollx', 12:17:22 INFO - 'cart']}, 12:17:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'tests': ['tp5o']}, 12:17:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'talos_options': ['--e10s'], 12:17:22 INFO - 'tests': ['tp5o']}, 12:17:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'talos_options': ['--xperf_path', 12:17:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:22 INFO - 'tests': ['tp5n']}, 12:17:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:22 INFO - 'talos_options': ['--e10s', 12:17:22 INFO - '--xperf_path', 12:17:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:17:22 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:17:22 INFO - 'tests': ['tp5n']}}, 12:17:22 INFO - 'talos.zip': {'path': '', 12:17:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:22 INFO - Running post-action listener: _resource_record_post_action 12:17:22 INFO - ##### 12:17:22 INFO - ##### Running create-virtualenv step. 12:17:22 INFO - ##### 12:17:22 INFO - Running pre-action listener: _resource_record_pre_action 12:17:22 INFO - Running main action method: create_virtualenv 12:17:22 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:17:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:22 INFO - Using real prefix '/tools/python27' 12:17:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:24 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:28 INFO - Installing pip.................done. 12:17:28 INFO - Return code: 0 12:17:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:28 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')]} 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:28 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')]} 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:28 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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:28 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 12:17:28 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 12:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:28 INFO - 'HOME': '/Users/cltbld', 12:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:28 INFO - 'LOGNAME': 'cltbld', 12:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:28 INFO - 'MOZ_NO_REMOTE': '1', 12:17:28 INFO - 'NO_EM_RESTART': '1', 12:17:28 INFO - 'PAGER': '/bin/cat', 12:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:28 INFO - 'PWD': '/builds/slave/test', 12:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:28 INFO - 'SHELL': '/bin/bash', 12:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:28 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:28 INFO - 'USER': 'cltbld', 12:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:28 INFO - 'XPC_FLAGS': '0x0', 12:17:28 INFO - 'XPC_SERVICE_NAME': '0', 12:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:28 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 12:17:28 INFO - Cleaning up... 12:17:28 INFO - Return code: 0 12:17:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:17:28 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')]} 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:28 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')]} 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:28 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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:28 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 12:17:28 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 12:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:28 INFO - 'HOME': '/Users/cltbld', 12:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:28 INFO - 'LOGNAME': 'cltbld', 12:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:28 INFO - 'MOZ_NO_REMOTE': '1', 12:17:28 INFO - 'NO_EM_RESTART': '1', 12:17:28 INFO - 'PAGER': '/bin/cat', 12:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:28 INFO - 'PWD': '/builds/slave/test', 12:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:28 INFO - 'SHELL': '/bin/bash', 12:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:28 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:28 INFO - 'USER': 'cltbld', 12:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:28 INFO - 'XPC_FLAGS': '0x0', 12:17:28 INFO - 'XPC_SERVICE_NAME': '0', 12:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:28 INFO - Downloading/unpacking psutil>=0.7.1 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:31 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:17:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:31 INFO - Installing collected packages: psutil 12:17:31 INFO - Running setup.py install for psutil 12:17:32 INFO - building 'psutil._psutil_osx' extension 12:17:32 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 12:17:33 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 12:17: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:17:34 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 12:17:34 INFO - building 'psutil._psutil_posix' extension 12:17:34 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 12:17:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:17:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:17:34 INFO - ^ 12:17:34 INFO - 1 warning generated. 12:17:34 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 12:17:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:34 INFO - Successfully installed psutil 12:17:34 INFO - Cleaning up... 12:17:34 INFO - Return code: 0 12:17:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:34 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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:34 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 12:17:34 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 12:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:34 INFO - 'HOME': '/Users/cltbld', 12:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:34 INFO - 'LOGNAME': 'cltbld', 12:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:34 INFO - 'MOZ_NO_REMOTE': '1', 12:17:34 INFO - 'NO_EM_RESTART': '1', 12:17:34 INFO - 'PAGER': '/bin/cat', 12:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:34 INFO - 'PWD': '/builds/slave/test', 12:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:34 INFO - 'SHELL': '/bin/bash', 12:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:34 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:34 INFO - 'USER': 'cltbld', 12:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:34 INFO - 'XPC_FLAGS': '0x0', 12:17:34 INFO - 'XPC_SERVICE_NAME': '0', 12:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:17:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:17:38 INFO - Installing collected packages: mozsystemmonitor 12:17:38 INFO - Running setup.py install for mozsystemmonitor 12:17:38 INFO - Successfully installed mozsystemmonitor 12:17:38 INFO - Cleaning up... 12:17:38 INFO - Return code: 0 12:17:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:38 INFO - 'HOME': '/Users/cltbld', 12:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:38 INFO - 'LOGNAME': 'cltbld', 12:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:38 INFO - 'MOZ_NO_REMOTE': '1', 12:17:38 INFO - 'NO_EM_RESTART': '1', 12:17:38 INFO - 'PAGER': '/bin/cat', 12:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:38 INFO - 'PWD': '/builds/slave/test', 12:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:38 INFO - 'SHELL': '/bin/bash', 12:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:38 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:38 INFO - 'USER': 'cltbld', 12:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:38 INFO - 'XPC_FLAGS': '0x0', 12:17:38 INFO - 'XPC_SERVICE_NAME': '0', 12:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:38 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:41 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 12:17:41 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 12:17:41 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 12:17:41 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 12:17:41 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 12:17:41 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 12:17:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:42 INFO - Downloading docopt-0.6.1.tar.gz 12:17:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:43 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:43 INFO - Running setup.py install for blobuploader 12:17:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:43 INFO - Running setup.py install for requests 12:17:43 INFO - Running setup.py install for docopt 12:17:44 INFO - Successfully installed blobuploader requests docopt 12:17:44 INFO - Cleaning up... 12:17:44 INFO - Return code: 0 12:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:44 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')]} 12:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:44 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')]} 12:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:44 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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:44 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 12:17:44 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 12:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:44 INFO - 'HOME': '/Users/cltbld', 12:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:44 INFO - 'LOGNAME': 'cltbld', 12:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:44 INFO - 'MOZ_NO_REMOTE': '1', 12:17:44 INFO - 'NO_EM_RESTART': '1', 12:17:44 INFO - 'PAGER': '/bin/cat', 12:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:44 INFO - 'PWD': '/builds/slave/test', 12:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:44 INFO - 'SHELL': '/bin/bash', 12:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:44 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:44 INFO - 'USER': 'cltbld', 12:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:44 INFO - 'XPC_FLAGS': '0x0', 12:17:44 INFO - 'XPC_SERVICE_NAME': '0', 12:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:44 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Bsrz6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:44 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-aWxvKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:44 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-hm3wjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:44 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-_Eagu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-YkR3zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-gwn3m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-1XPqHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-CfXss3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-iWg021-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-SlbK3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:45 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-8PHWNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:46 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-LT4i45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:46 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-eofilJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:46 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Ma8JNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:46 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-d4CKug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:46 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-H3CA1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:46 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-12MeVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:46 INFO - Running setup.py install for manifestparser 12:17:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:47 INFO - Running setup.py install for mozcrash 12:17:47 INFO - Running setup.py install for mozdebug 12:17:47 INFO - Running setup.py install for mozdevice 12:17:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:47 INFO - Running setup.py install for mozfile 12:17:47 INFO - Running setup.py install for mozhttpd 12:17:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:48 INFO - Running setup.py install for mozinfo 12:17:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:48 INFO - Running setup.py install for mozInstall 12:17:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:48 INFO - Running setup.py install for mozleak 12:17:48 INFO - Running setup.py install for mozlog 12:17:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:49 INFO - Running setup.py install for moznetwork 12:17:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:49 INFO - Running setup.py install for mozprocess 12:17:49 INFO - Running setup.py install for mozprofile 12:17:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:49 INFO - Running setup.py install for mozrunner 12:17:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:50 INFO - Running setup.py install for mozscreenshot 12:17:50 INFO - Running setup.py install for moztest 12:17:50 INFO - Running setup.py install for mozversion 12:17:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:50 INFO - Cleaning up... 12:17:50 INFO - Return code: 0 12:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:50 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')]} 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 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')]} 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:50 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 12:17:50 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 12:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:50 INFO - 'HOME': '/Users/cltbld', 12:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:50 INFO - 'LOGNAME': 'cltbld', 12:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:50 INFO - 'MOZ_NO_REMOTE': '1', 12:17:50 INFO - 'NO_EM_RESTART': '1', 12:17:50 INFO - 'PAGER': '/bin/cat', 12:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:50 INFO - 'PWD': '/builds/slave/test', 12:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:50 INFO - 'SHELL': '/bin/bash', 12:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:50 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:50 INFO - 'USER': 'cltbld', 12:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:50 INFO - 'XPC_FLAGS': '0x0', 12:17:50 INFO - 'XPC_SERVICE_NAME': '0', 12:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-XWQLIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17: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)) 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-9Zg1gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17: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)) 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Kdg8gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:51 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)) 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-U5XUKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:51 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)) 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-2w93uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:51 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)) 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-vcjEql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:51 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)) 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:51 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-g1NsF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17: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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-wGNECi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17: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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-IXDNun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17: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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-OSC7hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17: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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-gn78En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:52 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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-jRM95m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:52 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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-vDWEXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:52 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)) 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:52 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-DgT89f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17: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)) 12:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:53 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Uilznf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17: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)) 12:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:53 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-AkEADn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17: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)) 12:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:53 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-SrrXgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:56 INFO - Downloading blessings-1.5.1.tar.gz 12:17: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 12:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:56 INFO - Installing collected packages: blessings 12:17:56 INFO - Running setup.py install for blessings 12:17:56 INFO - Successfully installed blessings 12:17:56 INFO - Cleaning up... 12:17:56 INFO - Return code: 0 12:17:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:57 INFO - Reading from file tmpfile_stdout 12:17:57 INFO - Current package versions: 12:17:57 INFO - blessings == 1.5.1 12:17:57 INFO - blobuploader == 1.2.4 12:17:57 INFO - docopt == 0.6.1 12:17:57 INFO - manifestparser == 1.1 12:17:57 INFO - mozInstall == 1.12 12:17:57 INFO - mozcrash == 0.16 12:17:57 INFO - mozdebug == 0.1 12:17:57 INFO - mozdevice == 0.46 12:17:57 INFO - mozfile == 1.2 12:17:57 INFO - mozhttpd == 0.7 12:17:57 INFO - mozinfo == 0.8 12:17:57 INFO - mozleak == 0.1 12:17:57 INFO - mozlog == 3.0 12:17:57 INFO - moznetwork == 0.27 12:17:57 INFO - mozprocess == 0.22 12:17:57 INFO - mozprofile == 0.27 12:17:57 INFO - mozrunner == 6.11 12:17:57 INFO - mozscreenshot == 0.1 12:17:57 INFO - mozsystemmonitor == 0.0 12:17:57 INFO - moztest == 0.7 12:17:57 INFO - mozversion == 1.4 12:17:57 INFO - psutil == 3.1.1 12:17:57 INFO - requests == 1.2.3 12:17:57 INFO - wsgiref == 0.1.2 12:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 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 0x10be33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4f975a8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, '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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 12:17:57 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 12:17:57 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 12:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:57 INFO - 'HOME': '/Users/cltbld', 12:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:57 INFO - 'LOGNAME': 'cltbld', 12:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:57 INFO - 'MOZ_NO_REMOTE': '1', 12:17:57 INFO - 'NO_EM_RESTART': '1', 12:17:57 INFO - 'PAGER': '/bin/cat', 12:17:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:57 INFO - 'PWD': '/builds/slave/test', 12:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:57 INFO - 'SHELL': '/bin/bash', 12:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:17:57 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:57 INFO - 'USER': 'cltbld', 12:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:57 INFO - 'XPC_FLAGS': '0x0', 12:17:57 INFO - 'XPC_SERVICE_NAME': '0', 12:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17: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)) 12:17:57 INFO - Cleaning up... 12:17:57 INFO - Return code: 0 12:17:57 INFO - Running post-action listener: _resource_record_post_action 12:17:57 INFO - Running post-action listener: _start_resource_monitoring 12:17:57 INFO - Starting resource monitoring. 12:17:57 INFO - ##### 12:17:57 INFO - ##### Running install step. 12:17:57 INFO - ##### 12:17:57 INFO - Running pre-action listener: _resource_record_pre_action 12:17:57 INFO - Running main action method: install 12:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:57 INFO - Reading from file tmpfile_stdout 12:17:57 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:57 INFO - Reading from file tmpfile_stdout 12:17:57 INFO - Output received: 12:17:57 INFO - Usage: mozinstall [options] installer 12:17:57 INFO - Options: 12:17:57 INFO - -h, --help show this help message and exit 12:17:57 INFO - -d DEST, --destination=DEST 12:17:57 INFO - Directory to install application into. [default: 12:17:57 INFO - "/builds/slave/test"] 12:17:58 INFO - --app=APP Application being installed. [default: firefox] 12:17:58 INFO - mkdir: /builds/slave/test/build/application 12:17:58 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'] 12:17:58 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 12:18:40 INFO - Reading from file tmpfile_stdout 12:18:40 INFO - Output received: 12:18:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:18:40 INFO - Running post-action listener: _resource_record_post_action 12:18:40 INFO - ##### 12:18:40 INFO - ##### Running run-tests step. 12:18:40 INFO - ##### 12:18:40 INFO - Running pre-action listener: _resource_record_pre_action 12:18:40 INFO - Running main action method: run_tests 12:18:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:18:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:18:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:18:40 INFO - 2015-12-01 12:18:40.946 screenresolution[1640:8635] starting screenresolution argv=screenresolution get 12:18:40 INFO - 2015-12-01 12:18:40.950 screenresolution[1640:8635] Display 0: 1600x1200x32@60 12:18:40 INFO - 2015-12-01 12:18:40.958 screenresolution[1641:8637] starting screenresolution argv=screenresolution list 12:18:40 INFO - Available Modes on Display 0 12:18:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:18:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:18:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:18:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:18:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:18:41 INFO - Intel HD Graphics 3000: 12:18:41 INFO - Chipset Model: Intel HD Graphics 3000 12:18:41 INFO - Type: GPU 12:18:41 INFO - Bus: Built-In 12:18:41 INFO - VRAM (Total): 512 MB 12:18:41 INFO - VRAM (Dynamic, Max): 10 12:18:41 INFO - Vendor: Intel (0x8086) 12:18:41 INFO - Device ID: 0x0116 12:18:41 INFO - Revision ID: 0x0009 12:18:41 INFO - Displays: 12:18:41 INFO - Display: 12:18:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:18:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:18:41 INFO - Display Serial Number: 1600x1200 60 12:18:41 INFO - Main Display: Yes 12:18:41 INFO - Mirror: Off 12:18:41 INFO - Online: Yes 12:18:41 INFO - Rotation: Supported 12:18:41 INFO - Return code: 0 12:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:41 INFO - Python 2.7.3 12:18:41 INFO - Return code: 0 12:18:41 INFO - grabbing minidump binary from tooltool 12:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:41 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 0x10bde89f0>, '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 0x10bb47cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdb2990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:41 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 12:18:41 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 12:18:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:41 INFO - Return code: 0 12:18:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:18:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:18:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:41 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/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] in /builds/slave/test/build 12:18:41 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/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0023 --webServer localhost 12:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5NUVLTvk1K/Render', 12:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:41 INFO - 'HOME': '/Users/cltbld', 12:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:41 INFO - 'LOGNAME': 'cltbld', 12:18:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:41 INFO - 'MOZ_NO_REMOTE': '1', 12:18:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:41 INFO - 'NO_EM_RESTART': '1', 12:18:41 INFO - 'PAGER': '/bin/cat', 12:18:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:41 INFO - 'PWD': '/builds/slave/test', 12:18:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:41 INFO - 'SHELL': '/bin/bash', 12:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAzDL5R6jH/Listeners', 12:18:41 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 12:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:41 INFO - 'USER': 'cltbld', 12:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:41 INFO - 'XPC_FLAGS': '0x0', 12:18:41 INFO - 'XPC_SERVICE_NAME': '0', 12:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:18:41 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/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] with output_timeout 3600 12:18:41 INFO - mozversion INFO | application_buildid: 20151201104822 12:18:41 INFO - mozversion INFO | application_changeset: bb474924f23bfa27e850fd895448ccf4d85ed5c8 12:18:41 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 12:18:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:41 INFO - mozversion INFO | application_name: Firefox 12:18:41 INFO - mozversion INFO | application_remotingname: firefox-dev 12:18:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:18:41 INFO - mozversion INFO | application_vendor: Mozilla 12:18:41 INFO - mozversion INFO | application_version: 44.0a2 12:18:41 INFO - mozversion INFO | platform_buildid: 20151201104822 12:18:41 INFO - mozversion INFO | platform_changeset: bb474924f23bfa27e850fd895448ccf4d85ed5c8 12:18:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:18:41 INFO - mozversion INFO | platform_version: 44.0a2 12:18:41 INFO - 2015-12-01 12:18:41,775 DEBUG : using testdate: 1449001121 12:18:41 INFO - 2015-12-01 12:18:41,776 DEBUG : actual date: 1449001121 12:18:41 INFO - 2015-12-01 12:18:41,785 INFO : starting webserver on 'localhost:49267' 12:18:41 INFO - 2015-12-01 12:18:41,787 INFO : Starting test suite t-yosemite-r5-0023 12:18:41 INFO - 2015-12-01 12:18:41,787 INFO : Starting test dromaeo_css 12:18:41 INFO - 2015-12-01 12:18:41,787 DEBUG : operating with platform_type : mac_ 12:18:41 INFO - 2015-12-01 12:18:41,788 INFO : Initialising browser for dromaeo_css test... 12:18:41 INFO - 2015-12-01 12:18:41,815 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpFMEZXg/profile http://localhost:49267/getInfo.html 12:18:44 INFO - 2015-12-01 12:18:44,850 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:18:44 INFO - 2015-12-01 12:18:44,850 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:18:44 INFO - 2015-12-01 12:18:44,850 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:18:44 INFO - 2015-12-01 12:18:44,850 DEBUG : BROWSER_OUTPUT: __metrics 12:18:44 INFO - 2015-12-01 12:18:44,868 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] 12:18:45 INFO - 2015-12-01 12:18:45,612 INFO : Browser initialized. 12:18:45 INFO - 2015-12-01 12:18:45,612 INFO : Running cycle 1/1 for dromaeo_css test... 12:18:45 INFO - 2015-12-01 12:18:45,613 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpFMEZXg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:18:57 INFO - 2015-12-01 12:18:57,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 198209536 12:18:57 INFO - 2015-12-01 12:18:57,683 DEBUG : BROWSER_OUTPUT: 12:19:48 INFO - 2015-12-01 12:19:48,691 DEBUG : BROWSER_OUTPUT: 1449001188690 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] 12:22:00 INFO - 2015-12-01 12:22:00,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 12:22:01 INFO - 2015-12-01 12:22:01,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 319287296 12:22:01 INFO - 2015-12-01 12:22:01,618 DEBUG : BROWSER_OUTPUT: 12:25:04 INFO - 2015-12-01 12:25:04,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 12:25:04 INFO - 2015-12-01 12:25:04,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 344354816 12:25:04 INFO - 2015-12-01 12:25:04,958 DEBUG : BROWSER_OUTPUT: 12:28:07 INFO - 2015-12-01 12:28:07,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 12:28:07 INFO - 2015-12-01 12:28:07,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 302157824 12:28:07 INFO - 2015-12-01 12:28:07,840 DEBUG : BROWSER_OUTPUT: 12:31:09 INFO - 2015-12-01 12:31:09,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 12:31:10 INFO - 2015-12-01 12:31:10,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 298291200 12:31:10 INFO - 2015-12-01 12:31:10,503 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-01 12:34:13,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 12:34:14 INFO - 2015-12-01 12:34:14,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 297566208 12:34:14 INFO - 2015-12-01 12:34:14,349 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 12:37:17 INFO - 2015-12-01 12:37:17,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 339476480 12:37:17 INFO - 2015-12-01 12:37:17,473 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,474 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:17 INFO - 2015-12-01 12:37:17,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:17 INFO - 2015-12-01 12:37:17,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:17 INFO - 2015-12-01 12:37:17,474 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:17 INFO - 2015-12-01 12:37:17,474 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2650.6289119523262;2719.4968930747805;2721.047633328334;2761.599568062631;2772.500949829031;4568.109218702354;4585.105904348653;4636.1886669832775;4665.253559430492;4708.505606911268;4666.393368862052;4678.157931572316;4681.672282940195;4693.389859318284;4699.2951057341415;4088.2232375848494;4151.730137541065;4204.306289462243;4274.807633656493;4318.8488402905905;4095.877123686294;4175.144095460423;4187.979060104695;4218.957810421903;4310.116426132651;4172.582741725833;4184.8535301264465;4221.071364299849;4252.574742525753;4264.168487145008;4125.422440858252;4172.248995180867;4194.182134483777;4216.114615930627;4271.893202669942;3850.6534411902785;3998;4084.346504559286;4084.591540845892;4097.7541347518945;4442.067165895166;4460.77696115193;4484.573965473275;4497.730136191839;4508.819647214107;4790.329353890458;4808.807647694123;4814.7833347499445;4828.396450443694;4857.73282469464;4642.396488456513;4765.880852978668;4778.593819525345;4866.245731911559;4897.8775530611665;4335.046289816235;4430.13612345596;4445.888852778642;4475.485319188302;4487.5961163494785;4870.147724148331;4988.55103040728;4990.6257030722845;5034.345535080416;5067.746612669352;4562.224421848294;4623.398958135488;4666.066786642685;4779.354787103766;4834.516548345207;4680.3915490985955;4696.319033740088;4707.340972263886;4762.380890484214;4766.6901651392545;4868.610511159099;4899.779509921991;4925.113479573711;4941.110600091946;4942;4636.79134438951;4693.882652933636;4761.785719642625;4859.198232291632;4938.555530002317;3717.2937141942944;3747.269282489888;3785.9432108518395;3797.6582107610448;3810.2950954073585;3405.9489107663403;3428.245785927092;3432.2277487565098;3469.774464659789;3502.124468882779;4478.798454069574;4481.439820022497;4494.348319493721;4498.887527811831;4509.864704058883;4727.787249573777;4760.357351757469;4904.411470623477;4905.3132561441425;4914.189158788831;4455.086707225011;4497.887552811206;4527.705699129546;4533.297338912474;4538.818447262139;4268.317069268902;4286.292761694348;4291.9785401072795;4305.375720520507;4326.6754993375625;4813.1336359454235;4838.395200599925;4916.385451818523;4964.205727083649;5020.096382651158;4925.310456536016;4967.933521323526;5020.021095886267;5040.269160971565;5048.7223202722735;5060.721660308718;5062.215356619729;5071.39143302806;5075.213341932006;5079.593632509316;4684.367610372556;4755.2153894607;4806.279058141167;4814.711117332971;4909.582685471775;4811.470738218723;4816.735079570657;4827.155247831545;4841.370621819141;4914.336564563881;4592.989542300822;4696.0607878425135;4714.528547145258;4747.477777444547;4750.287456881495;4610.930836037529;4699.953000469952;4704.341392205026;4738.549837765407;4770.666053376231;4685.929711054268;4698.69458485211;4702.92945605823;4795.712257264575;4839.612830973584;4793.640476964172;4864.027194561031;4882.096812089775;4911.214205727067;4923.113839508779;4538.977305113453;4621.445426548836;4648.395708557866;4780.737059461763;4846.903061938812 12:37:17 INFO - 2015-12-01 12:37:17,474 DEBUG : BROWSER_OUTPUT: |1;ext.html;474.09921149815347;479.2858640625468;481.2060100833624;493.0115119186033;506.35945528905916;27444.451110977792;28254.717452825465;33159.66840331596;33335.333293334115;33497.16257093574;36215.275694486096;36718;36787;36812.44781328276;37027.07432314193;7214.7114115435315;7698.92301076989;7814.648340824648;7845.490043147206;7854.646540905673;7242.818929526751;9229.123233292827;9240.306976976754;9428.010058943815;9589.760255993586;9229.261659067259;9279.30405219608;9380.343375963685;9398.483083430408;9403.529823508798;7147.428205743528;7440;9150.725478235663;9400.529973501298;9421.717348479557;9027.684031058881;9186.724398267996;9265.16613504781;9285.489298088602;9317.11487408695;34144.14639634004;34236.315273694636;34676.47985280223;34705.132371690655;34775.30449390998;2508.1973768394123;2513.2711513661015;2771.625830512875;2871.4974879396023;2938.720821521952;23976.760232397628;24023.759762402326;24223.7577624225;24558.508829823302;24677.383065423328;1971.802819718031;2015.1637070615677;2019.1620477501965;2040.5306779440812;2058.6603210470253;233277;234247;234373;234430;236782;44015;45574;50901.490985090415;51289.23066154011;51378.48621513737;51878.74060629673;52823.73588132112;53370;53387;53430;14563.563093107225;14672.193029383487;14821;14881.851181488262;14912.328945197276;11258;11263.324200547993;11337.206395552232;11429.828552571718;11438.199326047263;16138.515844524683;16782.496525104023;16860.156992150343;16905.915470422817;16997.830021699872;6649.135612370457;6753.45972322213;6769.661516924134;6813.318668133246;6886.51794374389;768.4390395011673;868.6264906090441;874.54960695242;966.8211380894558;980.3039841712322;24099;24103;24772;24784.876075619508;24875.875620622144;843.2621456225802;863.2921004776149;910.7267819654078;910.8588168833842;980.6371642492181;11811.704707382385;12499.50001999928;12840.807387889188;12901.419436125208;12960.80558791619;424419;429868;430444;431308;432100;40986;41766.79116604458;45450;46616;47985.5201447981;1198.7003249187703;1212.0848759186758;1226.9325187114794;1232.1744431230918;1237.808139738342;21643.13427462884;22879.199228027606;23088.076476941405;23265;23358.299251022498;35574.64425355713;35694.4645830318;35741.28517429585;35784.284314314085;35808.820955896095;233381;236760;237320;239461;239578;27645.447091058468;27918.44163116767;28087.578686320132;28095.719042810128;28097.438051238452;35577.644223557436;35987;36744;36848.44727329146;36897.44653830249;28736.425271494034;29066;30773;30830.53754193644;30855.69144308528;29554.704452956055;29889.402211955203;29950.101496955125;30098.548521771754;30129;30501.389972199988;30904.845475772476;31647.683523164473;32058;32093.518597220595;25188.622170667088;26996.46007079887;27056.864715676296;27204.591931120653;27318.180454586392;20597.691034634194;20779.272725454535;20813.271535496184;20835.166593336096;21126.577468450236 12:37:17 INFO - 2015-12-01 12:37:17,478 DEBUG : BROWSER_OUTPUT: |2;jquery.html;293.5669886916797;296.4885572387632;298.358529162301;298.63119047975755;301.48897618536574;12132.878671213286;12577.622671319876;14631.268436578168;14748.115113093208;15168.620784480394;12369.876301236985;14406.207658578774;14557.199354035523;14886.106833589965;14988.10071395717;3809.8285577149027;3979.661728753045;4106.8973275668195;4478.731276123443;4480.820767169309;3024.2439390152463;3079.7536197104178;3104.9689503104905;4102.077032667656;4136.73111247768;3904.2581909437117;4002.1995600879795;4059.7361171523903;4094.160697057111;4108.609682080212;3872.6320999505283;4049.514058312992;4080.0207950091913;4088.632023117919;4096.242195193869;3411.249525104498;3414.5048967899515;3425;3425.6745609167087;3429.8971030869116;10583.259171857973;10748;10885.945570272099;10914.890851091466;11027.44862756867;1511.8554499309646;1553.432996956103;1569.4036266218877;1572.4653617769898;1574.3545146489885;7697.0763508378795;7889.842203155905;8015.839683206362;8157.75526734199;8189.549574773385;1244.695049712817;1284.678830292427;1306.8366454193226;1317.084626184802;1365.1672479787321;47189.76405117987;47687.28469072967;49763;49766.253506197434;50127;5482.205080263339;5628.774849005994;5645.266115404971;5704.429557044263;5762.279715035621;6426.421622053944;6448.903266451007;6490.772822951174;6504.15445992018;6514.5114116441455;4686.95313046872;4785.688930219525;4786.688865223749;4808.158572249842;4844.515548445127;5119.820806271762;5158.664686795346;5164.845054648366;5177.767000484987;5179.870503237374;2514.585093459595;2529.6584961030026;2563.115725074846;2572.408346080412;2578.1105518596055;887.7203680840514;903.4263242840843;906.2025417632441;927.0405130689704;958.1424624960621;287.3247867511373;356.37278390033725;376.18743514009606;377.8545260074836;385.07581803670854;9595.088466595662;9605.327627066177;9840.950795245977;9937.155341796028;9948.651797187209;358.36211543452697;394.7907608967252;401.81516502408635;404.06660613981796;405.34132035442406;5186.766595503212;5215.29593504872;5264.894702105937;5349.679019258857;5490.396056433789;419676;492912;496074;502202;504023;61114.69442652847;65371;65400.67299663471;65416;65434.34565654378;386.28922782081105;396.9325214713506;398.90426297688924;399.1757021750135;399.75415119701756;9299;9334.113259240361;9405.153536181777;9421.905780942378;9677.806443870943;29174.41651167007;30466.695333046388;30750.231244219074;30937.845310774203;31169.68830311668;40943.795281023406;41372.37941430941;41416;42059.7897010513;42148.367774482795;5165.457626949116;5366.275552800322;5385.165299378603;5389.110796718497;5397.487238712316;9286.860697089684;9812.558434870305;9933.453660048766;9950.701478955643;10158.695239142837;8529.3602979778;8581.570921454027;8650.13498650155;8761.91238087611;8764.1674040966;7934.603269836601;8400.747977560683;8452.070272269922;8479.533625650402;8492.065872753868;8191.959040204761;8807.955960220157;8837.983631882416;8860.424072435271;8863.556822158995;4659.813607455664;4728.196206644948;5265.52610265078;5313.043652142652;5350.545203657733;8298.543580103153;8439.746807595782;8558.358123140913;8586.957065214634;8605.569721514024 12:37:17 INFO - 2015-12-01 12:37:17,479 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1103.0458653264927;1450.8113945187124;1511.221720813781;1540.1144342003347;1542.8534289242525;5677.886442271158;5951.732172052257;5971.223740913681;6072.939270607292;6077.02767557191;6079.422454866781;6173.50611951044;6175.475084617801;6192.659403732793;6201.968990155043;1802.513321403217;1809.2672467650623;1812.9365472208476;1812.9637407251846;1813.0934532733634;1822.6172503774224;1853.7404763333145;1854.5270955906226;1856.9628607427844;1860.748798912143;1803.936862209823;1811.1849667649544;1816.455063480957;1821.317006122704;1825.4341154242227;1761.3042848075004;1788.2668106076512;1789.1680368628586;1791.265581111738;1797.2271923073074;1787.8748487605874;1814.319630138698;1819.0995457248614;1826.6711991841464;1832.7983921768596;5473.17902314656;6051.0923361496125;6079.39206079393;6084.330723620398;6113.296970848365;3424.4520876659863;3773.3019391412677;3884.3396622574232;3892.591277915835;3905.8632947846972;2313.4447732544068;2361.114582031738;2400.5198960208027;2401.363638635763;2405.579023670851;717.3077979749514;720.6396801599201;723.6779633063289;744.0847757258603;750.4634186556584;8019.799505012421;8049;8081.43429959903;8095.919040809576;8118.512889226666;3407.9488807667904;3469.427544455187;3471.5139880416764;3518.595361533405;3544.8936531904083;7184.317489838457;7189.0654214952765;7191.64041797908;7217.314355136254;7217.953396757441;3935.4687117239378;3938.4879965604287;3939.8227079781477;3947.743396679207;3960.207958408272;3629.4192929131214;3633.1280492681567;3636.8545258189906;3642.6357364263363;3645.2709458108484;2882.927926801805;2908.1130255271923;2938.133250691051;2956.645202575705;2965.7775666825073;905.3617199874072;919.6367434863325;921.5991043895926;927.679950417105;928.0116675740315;1014.8934361892043;1046.4610725476387;1054.6414219165367;1055.4406164732704;1118.4854966715402;5910.586258961831;5923.289205295392;5955.821325360246;5959.344472108065;5987.670678112746;401.4219523885654;405.2078187144126;409.3327875562873;411.7652937825471;412.4658567155541;4725.9527404726205;4777.044591081798;4778.020505796303;4800;4809.014152098812;6739.292374300726;6868.107146070979;6950.652467376611;7194.568325900463;7195.712171513185;7123.715051397886;7156.355927966404;7177.89233161503;7203.495755297079;7208.675609597581;5676.574256930747;5838.4453476919625;5862;5877.382874798084;5902.822915312548;5700.287464066992;5731.168980497888;5733.627314224562;5749.798757043651;5767.423257674199;6388.488920886225;6471.996840489732;6472.093906853139;6582.670866456562;6649;6558.311377305315;6720.899186512109;6751.324867513209;6767.695453704497;6922.8961565577565;5512.724363781875;5533.723313834373;5547.2511210986;5557.610967232416;5584.525315348078;5791.507721843691;5824.592278540462;5825;5835.328937172109;5864.032434648235;5558.749856256397;5635.182898479779;5696.715164241854;5737.053386191232;5747.942520574908;5228.7647055883335;5551.972240138935;5561.527270181918;5640.435956404327;5641.520470759867;5587.497125258747;5646.802361917313;5669.951059054089;5683.8863222736145;5695.572832037531;4945.406551213878;4976.701397916137;4979.875503112306;5007.37407824022;5013.749312534432;4784.808607655794;4825.155597770447;4830.7101573905675;4835.661503694708;4878.048780487771 12:37:17 INFO - 2015-12-01 12:37:17,481 DEBUG : BROWSER_OUTPUT: |4;prototype.html;254.21701160425891;263.63354936638063;268.5769912387989;278.039373962958;281.3206107250989;5063.62022848287;5118.539331460168;5144.845654630358;5165.30268413764;5173.2240163975375;4966.677165984209;5022.422421421537;5054.84835454936;5085.923711144335;5094.083065048299;3912.23711376281;3944.1914407546383;3963.544192417866;3970.285348637244;3987.3022221111332;3796.2027974125467;3884.514435695538;3894.045958740113;3949.8222579983826;3954.070793363557;3832.7508711933774;3882.9611703882883;3922.0979174789813;3933.645971862532;3939.468171796799;3918.216356728637;3918.8236529355963;3922.2547715933883;3923.5291764988096;3924;3424.195314101184;3424.366492198926;3424.520567120605;3440.17435815405;3440.6559344065395;4912.606991440676;4931.235658472942;4949.307097006422;4967.801287948478;4969.055879382906;3950.4271880577444;4188.958110418887;4250.681198910063;4337.9132417351475;4354.129174165148;5230.686158830483;5297.073012222884;5304.681719096867;5314.548263397616;5342;3705.925881482382;3708.554973403182;3717.888463346104;3729.2355067211156;3733.141377483194;5511.063119269734;5523.6685798852195;5525.4474552544825;5534.252875861747;5544;3788.2802267569073;3813.923721525554;3829.425586162098;3830.367989281737;3839.308924393636;3758.267137908136;3860.864869729546;3867.1298957734284;3871.5934826842777;3876.8255428505786;4448.510663826976;4462.241418958784;4471;4476.350929115325;4481.775911204427;5368.248445217672;5394.514493695587;5402.567794576425;5405.00007498614;5419.972900135474;1353.8443079046035;1401.740677974578;1405.2692599848021;1407.4792326839136;1410.5697762182633;869.3957699398857;892.1836519584507;915.9954200228956;929.9674511392204;939.9765005874908;5080.5681517070725;5082.33929589151;5089.083964886282;5104.2088476286235;5107.514786095315;5557.249771280906;5582.106862901916;5584.441555844383;5584.553235741131;5596.664200148004;4919.508049195123;5072.721000345016;5075.39095308558;5087.287779710843;5090.261912022736;2985.537241727492;3004.1288026472516;3070.7543396528226;3077.07687693691;3080.7997480163717;5566.443355664401;5609.691466969356;5617.960677274717;5626.493615574536;5631.8592035199445;5653.152027195953;5709.74306156224;5714.200011998323;5734.541236701054;5738.569607279471;5517.062099443105;5590.329160500766;5598.916016259759;5650.689212093374;5659.151127330769;5574.386817450159;5584.944150558443;5585.357683866408;5619.578531610064;5636.943630563642;5503.587230957614;5503.972480137573;5504.53211477029;5512.283403157564;5519.061759500974;5439.564834813126;5637.098064309691;5640.407757185437;5647.463490968352;5672.404397538199;3855.0940528975107;3904.39481880309;3910.9217815644097;3915.4518367428013;3917.5298964124486;5602.1036634138345;5607.271054763018;5626.324841019104;5629.380768115586;5643.858903527444;5450.373207081237;5460.180972854104;5478.260434841405;5485.424030476743;5491.203775452457;5277.102892508359;5442.700651464207;5445.727713614383;5457.8362649119;5468;5159.664621799571;5292.259083728204;5303.7878484860175;5306.814261500829;5314.52169304749;5380.461953804745;5396.109641909198;5408.621396502207;5409.729513524387;5419.539339156216;5197.272381866617;5295.7352132394;5311.044012077863;5327.440618734977;5364.356277246756 12:37:17 INFO - 2015-12-01 12:37:17,484 DEBUG : BROWSER_OUTPUT: |5;yui.html;526.6339893773826;530.453632758259;531.7314756048195;559.3092530724552;637.0380725105091;11379.431028448576;11643.30140191589;11669.183157179;11673.824892626606;11760.882391176086;10123.392596444219;11060.391678457681;11098.112151027919;11102.111831053517;11132.721681957955;608.1030480041936;618.7741474361848;729.6825880741868;745.2249660353226;751.7594369801666;763.5723994563035;773.9458237923347;774.2412435812906;774.8915151878741;775.2673723331454;631.3465563142149;786.0528063683248;794.5868148562744;795.4153697032705;797.5453991225004;639.4979940746515;758.3970743259094;759.2331744937653;771.340503869195;774.6436639146;551.3686828581252;563.4787821265313;563.8956792993309;566.9433056694339;566.9907564535134;11371.545138194546;11452.885471145266;11498.367589782558;11547.364894930775;11550.36472993985;7525.698972041112;7657.4639775215755;7898.447108702393;8106.807436036054;8349.95825020871;7260.2013778484325;7340.302671246223;7453.813654658677;7476.626168691544;7618.542887426772;2456.65606815046;2544.211294498711;2551.1836212412036;2590.002848903167;2624.238970698495;40211.122862331344;40613.18773624511;40974.59025409738;41044;41057.794711026254;5858.765649373977;5868.941310586925;6026.306974697878;6085.5435842312;6267.2165979252595;9861.950690246646;9967.750806229757;9976.501174941224;9985.1512621428;10007.599696012223;4869.586085182728;4938.975305123451;5047.949520504748;5172.948270517247;5177.870553236199;3271.329377477611;3303.7687361884437;3336.7831090979007;3355.4295769719206;3397.235621985083;2160.2763074369946;2180.531185795062;2181.5636872625537;2184.333778197665;2184.6286131357706;332.5344517675274;335.47498165371115;336.157924399378;336.95956485221933;336.9696727294555;365.459120501659;423.0439207391318;424.6772452935791;424.8931533355564;470.4777696756598;5908.379620139909;6082.665453400017;6122.66325352101;6154.415330543681;6249.7187626556915;333.9983300083484;470.454273043275;476.5234765234765;496.9349094304011;498.8827625508003;2492.626106084102;2594.6626938497875;2620.513254343057;3040.9543856842165;3091.520814273791;47219.76390118096;48229;48323.27515087206;51331.48668513267;51377.229341559905;42379.15241695149;42815.14369712651;42919.7854010728;42986.355204671956;43393.78303108527;38708;38719.419208712454;39338.80330598329;41636.37545436821;41797.1640567193;5846.210761547307;5935.5548333875995;6027.547933904887;6040.607360521552;6088;29879.402411952073;30724.692753072184;30750.384992300475;31194.37611247717;31889;39928.201435970535;40053;40764;41891;42454.15091698087;6215.906761398493;6224.844378890564;6271.529635277281;6400.839979000376;6869.656517174221;9146;9187.678431254873;9192.310576706908;9250.4912229828;9328.347015709107;8176.223258790405;8553.82892342162;8604.78488037779;8617.913820861962;8625.69810056645;8695.391322607356;8708.60811263482;8711.128887111237;8756.474611523328;8760.737177884674;8570.100139485265;8671.653133874574;8689;8703.782405439915;8717.738467845975;7612.581308028111;7692.307692307683;7838.725644602411;7877.448578599672;8112.553809540532;7087.822804429724;7613.5431874087735;7684.538927664358;7869.134395216407;7891.723789667334 12:37:17 INFO - 2015-12-01 12:37:17,484 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:17 INFO - 2015-12-01 12:37:17,484 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:37:17 INFO - 2015-12-01 12:37:17,485 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,946 12:37:17 INFO - 2015-12-01 12:37:17,485 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:37:17 INFO - 2015-12-01 12:37:17,485 DEBUG : BROWSER_OUTPUT: __startTimestamp1449002237469__endTimestamp 12:37:17 INFO - 2015-12-01 12:37:17,485 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,485 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:17 INFO - 2015-12-01 12:37:17,485 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:37:17 INFO - 2015-12-01 12:37:17,486 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,486 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4521.14 Median:4681.67 stddev:484.89 (10.4%) stddev-sans-first:463.64 12:37:17 INFO - 2015-12-01 12:37:17,486 DEBUG : BROWSER_OUTPUT: Values: 2650.6 2719.5 2721.0 2761.6 2772.5 4568.1 4585.1 4636.2 4665.3 4708.5 4666.4 4678.2 4681.7 4693.4 4699.3 4088.2 4151.7 4204.3 4274.8 4318.8 4095.9 4175.1 4188.0 4219.0 4310.1 4172.6 4184.9 4221.1 4252.6 4264.2 4125.4 4172.2 4194.2 4216.1 4271.9 3850.7 3998.0 4084.3 4084.6 4097.8 4442.1 4460.8 4484.6 4497.7 4508.8 4790.3 4808.8 4814.8 4828.4 4857.7 4642.4 4765.9 4778.6 4866.2 4897.9 4335.0 4430.1 4445.9 4475.5 4487.6 4870.1 4988.6 4990.6 5034.3 5067.7 4562.2 4623.4 4666.1 4779.4 4834.5 4680.4 4696.3 4707.3 4762.4 4766.7 4868.6 4899.8 4925.1 4941.1 4942.0 4636.8 4693.9 4761.8 4859.2 4938.6 3717.3 3747.3 3785.9 3797.7 3810.3 3405.9 3428.2 3432.2 3469.8 3502.1 4478.8 4481.4 4494.3 4498.9 4509.9 4727.8 4760.4 4904.4 4905.3 4914.2 4455.1 4497.9 4527.7 4533.3 4538.8 4268.3 4286.3 4292.0 4305.4 4326.7 4813.1 4838.4 4916.4 4964.2 5020.1 4925.3 4967.9 5020.0 5040.3 5048.7 5060.7 5062.2 5071.4 5075.2 5079.6 4684.4 4755.2 4806.3 4814.7 4909.6 4811.5 4816.7 4827.2 4841.4 4914.3 4593.0 4696.1 4714.5 4747.5 4750.3 4610.9 4700.0 4704.3 4738.5 4770.7 4685.9 4698.7 4702.9 4795.7 4839.6 4793.6 4864.0 4882.1 4911.2 4923.1 4539.0 4621.4 4648.4 4780.7 4846.9 12:37:17 INFO - 2015-12-01 12:37:17,486 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,486 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43750.47 Median:32075.76 stddev:83231.75 (259.5%) stddev-sans-first:83401.81 12:37:17 INFO - 2015-12-01 12:37:17,488 DEBUG : BROWSER_OUTPUT: Values: 474.1 479.3 481.2 493.0 506.4 27444.5 28254.7 33159.7 33335.3 33497.2 36215.3 36718.0 36787.0 36812.4 37027.1 7214.7 7698.9 7814.6 7845.5 7854.6 7242.8 9229.1 9240.3 9428.0 9589.8 9229.3 9279.3 9380.3 9398.5 9403.5 7147.4 7440.0 9150.7 9400.5 9421.7 9027.7 9186.7 9265.2 9285.5 9317.1 34144.1 34236.3 34676.5 34705.1 34775.3 2508.2 2513.3 2771.6 2871.5 2938.7 23976.8 24023.8 24223.8 24558.5 24677.4 1971.8 2015.2 2019.2 2040.5 2058.7 233277.0 234247.0 234373.0 234430.0 236782.0 44015.0 45574.0 50901.5 51289.2 51378.5 51878.7 52823.7 53370.0 53387.0 53430.0 14563.6 14672.2 14821.0 14881.9 14912.3 11258.0 11263.3 11337.2 11429.8 11438.2 16138.5 16782.5 16860.2 16905.9 16997.8 6649.1 6753.5 6769.7 6813.3 6886.5 768.4 868.6 874.5 966.8 980.3 24099.0 24103.0 24772.0 24784.9 24875.9 843.3 863.3 910.7 910.9 980.6 11811.7 12499.5 12840.8 12901.4 12960.8 424419.0 429868.0 430444.0 431308.0 432100.0 40986.0 41766.8 45450.0 46616.0 47985.5 1198.7 1212.1 1226.9 1232.2 1237.8 21643.1 22879.2 23088.1 23265.0 23358.3 35574.6 35694.5 35741.3 35784.3 35808.8 233381.0 236760.0 237320.0 239461.0 239578.0 27645.4 27918.4 28087.6 28095.7 28097.4 35577.6 35987.0 36744.0 36848.4 36897.4 28736.4 29066.0 30773.0 30830.5 30855.7 29554.7 29889.4 29950.1 30098.5 30129.0 30501.4 30904.8 31647.7 32058.0 32093.5 25188.6 26996.5 27056.9 27204.6 27318.2 20597.7 20779.3 20813.3 20835.2 21126.6 12:37:17 INFO - 2015-12-01 12:37:17,488 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,488 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23427.49 Median:26207.74 stddev:79311.70 (302.6%) stddev-sans-first:79515.17 12:37:17 INFO - 2015-12-01 12:37:17,489 DEBUG : BROWSER_OUTPUT: Values: 293.6 296.5 298.4 298.6 301.5 12132.9 12577.6 14631.3 14748.1 15168.6 12369.9 14406.2 14557.2 14886.1 14988.1 3809.8 3979.7 4106.9 4478.7 4480.8 3024.2 3079.8 3105.0 4102.1 4136.7 3904.3 4002.2 4059.7 4094.2 4108.6 3872.6 4049.5 4080.0 4088.6 4096.2 3411.2 3414.5 3425.0 3425.7 3429.9 10583.3 10748.0 10885.9 10914.9 11027.4 1511.9 1553.4 1569.4 1572.5 1574.4 7697.1 7889.8 8015.8 8157.8 8189.5 1244.7 1284.7 1306.8 1317.1 1365.2 47189.8 47687.3 49763.0 49766.3 50127.0 5482.2 5628.8 5645.3 5704.4 5762.3 6426.4 6448.9 6490.8 6504.2 6514.5 4687.0 4785.7 4786.7 4808.2 4844.5 5119.8 5158.7 5164.8 5177.8 5179.9 2514.6 2529.7 2563.1 2572.4 2578.1 887.7 903.4 906.2 927.0 958.1 287.3 356.4 376.2 377.9 385.1 9595.1 9605.3 9841.0 9937.2 9948.7 358.4 394.8 401.8 404.1 405.3 5186.8 5215.3 5264.9 5349.7 5490.4 419676.0 492912.0 496074.0 502202.0 504023.0 61114.7 65371.0 65400.7 65416.0 65434.3 386.3 396.9 398.9 399.2 399.8 9299.0 9334.1 9405.2 9421.9 9677.8 29174.4 30466.7 30750.2 30937.8 31169.7 40943.8 41372.4 41416.0 42059.8 42148.4 5165.5 5366.3 5385.2 5389.1 5397.5 9286.9 9812.6 9933.5 9950.7 10158.7 8529.4 8581.6 8650.1 8761.9 8764.2 7934.6 8400.7 8452.1 8479.5 8492.1 8192.0 8808.0 8838.0 8860.4 8863.6 4659.8 4728.2 5265.5 5313.0 5350.5 8298.5 8439.7 8558.4 8587.0 8605.6 12:37:17 INFO - 2015-12-01 12:37:17,489 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,489 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4302.25 Median:5554.79 stddev:2188.37 (39.4%) stddev-sans-first:2181.30 12:37:17 INFO - 2015-12-01 12:37:17,491 DEBUG : BROWSER_OUTPUT: Values: 1103.0 1450.8 1511.2 1540.1 1542.9 5677.9 5951.7 5971.2 6072.9 6077.0 6079.4 6173.5 6175.5 6192.7 6202.0 1802.5 1809.3 1812.9 1813.0 1813.1 1822.6 1853.7 1854.5 1857.0 1860.7 1803.9 1811.2 1816.5 1821.3 1825.4 1761.3 1788.3 1789.2 1791.3 1797.2 1787.9 1814.3 1819.1 1826.7 1832.8 5473.2 6051.1 6079.4 6084.3 6113.3 3424.5 3773.3 3884.3 3892.6 3905.9 2313.4 2361.1 2400.5 2401.4 2405.6 717.3 720.6 723.7 744.1 750.5 8019.8 8049.0 8081.4 8095.9 8118.5 3407.9 3469.4 3471.5 3518.6 3544.9 7184.3 7189.1 7191.6 7217.3 7218.0 3935.5 3938.5 3939.8 3947.7 3960.2 3629.4 3633.1 3636.9 3642.6 3645.3 2882.9 2908.1 2938.1 2956.6 2965.8 905.4 919.6 921.6 927.7 928.0 1014.9 1046.5 1054.6 1055.4 1118.5 5910.6 5923.3 5955.8 5959.3 5987.7 401.4 405.2 409.3 411.8 412.5 4726.0 4777.0 4778.0 4800.0 4809.0 6739.3 6868.1 6950.7 7194.6 7195.7 7123.7 7156.4 7177.9 7203.5 7208.7 5676.6 5838.4 5862.0 5877.4 5902.8 5700.3 5731.2 5733.6 5749.8 5767.4 6388.5 6472.0 6472.1 6582.7 6649.0 6558.3 6720.9 6751.3 6767.7 6922.9 5512.7 5533.7 5547.3 5557.6 5584.5 5791.5 5824.6 5825.0 5835.3 5864.0 5558.7 5635.2 5696.7 5737.1 5747.9 5228.8 5552.0 5561.5 5640.4 5641.5 5587.5 5646.8 5670.0 5683.9 5695.6 4945.4 4976.7 4979.9 5007.4 5013.7 4784.8 4825.2 4830.7 4835.7 4878.0 12:37:17 INFO - 2015-12-01 12:37:17,491 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,491 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4497.11 Median:5113.03 stddev:1344.78 (26.3%) stddev-sans-first:1310.30 12:37:17 INFO - 2015-12-01 12:37:17,492 DEBUG : BROWSER_OUTPUT: Values: 254.2 263.6 268.6 278.0 281.3 5063.6 5118.5 5144.8 5165.3 5173.2 4966.7 5022.4 5054.8 5085.9 5094.1 3912.2 3944.2 3963.5 3970.3 3987.3 3796.2 3884.5 3894.0 3949.8 3954.1 3832.8 3883.0 3922.1 3933.6 3939.5 3918.2 3918.8 3922.3 3923.5 3924.0 3424.2 3424.4 3424.5 3440.2 3440.7 4912.6 4931.2 4949.3 4967.8 4969.1 3950.4 4189.0 4250.7 4337.9 4354.1 5230.7 5297.1 5304.7 5314.5 5342.0 3705.9 3708.6 3717.9 3729.2 3733.1 5511.1 5523.7 5525.4 5534.3 5544.0 3788.3 3813.9 3829.4 3830.4 3839.3 3758.3 3860.9 3867.1 3871.6 3876.8 4448.5 4462.2 4471.0 4476.4 4481.8 5368.2 5394.5 5402.6 5405.0 5420.0 1353.8 1401.7 1405.3 1407.5 1410.6 869.4 892.2 916.0 930.0 940.0 5080.6 5082.3 5089.1 5104.2 5107.5 5557.2 5582.1 5584.4 5584.6 5596.7 4919.5 5072.7 5075.4 5087.3 5090.3 2985.5 3004.1 3070.8 3077.1 3080.8 5566.4 5609.7 5618.0 5626.5 5631.9 5653.2 5709.7 5714.2 5734.5 5738.6 5517.1 5590.3 5598.9 5650.7 5659.2 5574.4 5584.9 5585.4 5619.6 5636.9 5503.6 5504.0 5504.5 5512.3 5519.1 5439.6 5637.1 5640.4 5647.5 5672.4 3855.1 3904.4 3910.9 3915.5 3917.5 5602.1 5607.3 5626.3 5629.4 5643.9 5450.4 5460.2 5478.3 5485.4 5491.2 5277.1 5442.7 5445.7 5457.8 5468.0 5159.7 5292.3 5303.8 5306.8 5314.5 5380.5 5396.1 5408.6 5409.7 5419.5 5197.3 5295.7 5311.0 5327.4 5364.4 12:37:17 INFO - 2015-12-01 12:37:17,492 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-12-01 12:37:17,492 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11125.01 Median:561.39 stddev:13948.24 (2484.6%) stddev-sans-first:13964.66 12:37:17 INFO - 2015-12-01 12:37:17,493 DEBUG : BROWSER_OUTPUT: Values: 526.6 530.5 531.7 559.3 637.0 11379.4 11643.3 11669.2 11673.8 11760.9 10123.4 11060.4 11098.1 11102.1 11132.7 608.1 618.8 729.7 745.2 751.8 763.6 773.9 774.2 774.9 775.3 631.3 786.1 794.6 795.4 797.5 639.5 758.4 759.2 771.3 774.6 551.4 563.5 563.9 566.9 567.0 11371.5 11452.9 11498.4 11547.4 11550.4 7525.7 7657.5 7898.4 8106.8 8350.0 7260.2 7340.3 7453.8 7476.6 7618.5 2456.7 2544.2 2551.2 2590.0 2624.2 40211.1 40613.2 40974.6 41044.0 41057.8 5858.8 5868.9 6026.3 6085.5 6267.2 9862.0 9967.8 9976.5 9985.2 10007.6 4869.6 4939.0 5047.9 5172.9 5177.9 3271.3 3303.8 3336.8 3355.4 3397.2 2160.3 2180.5 2181.6 2184.3 2184.6 332.5 335.5 336.2 337.0 337.0 365.5 423.0 424.7 424.9 470.5 5908.4 6082.7 6122.7 6154.4 6249.7 334.0 470.5 476.5 496.9 498.9 2492.6 2594.7 2620.5 3041.0 3091.5 47219.8 48229.0 48323.3 51331.5 51377.2 42379.2 42815.1 42919.8 42986.4 43393.8 38708.0 38719.4 39338.8 41636.4 41797.2 5846.2 5935.6 6027.5 6040.6 6088.0 29879.4 30724.7 30750.4 31194.4 31889.0 39928.2 40053.0 40764.0 41891.0 42454.2 6215.9 6224.8 6271.5 6400.8 6869.7 9146.0 9187.7 9192.3 9250.5 9328.3 8176.2 8553.8 8604.8 8617.9 8625.7 8695.4 8708.6 8711.1 8756.5 8760.7 8570.1 8671.7 8689.0 8703.8 8717.7 7612.6 7692.3 7838.7 7877.4 8112.6 7087.8 7613.5 7684.5 7869.1 7891.7 12:37:17 INFO - 2015-12-01 12:37:17,493 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:17 INFO - 2015-12-01 12:37:17,493 DEBUG : BROWSER_OUTPUT: 12:37:18 INFO - 2015-12-01 12:37:18,131 INFO : Browser exited with error code: 0 12:37:18 INFO - 2015-12-01 12:37:18,164 INFO : Completed test dromaeo_css (00:18:36) 12:37:18 INFO - 2015-12-01 12:37:18,165 INFO : Starting test kraken 12:37:18 INFO - 2015-12-01 12:37:18,165 DEBUG : operating with platform_type : mac_ 12:37:18 INFO - 2015-12-01 12:37:18,165 INFO : Initialising browser for kraken test... 12:37:18 INFO - 2015-12-01 12:37:18,181 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpSwTAQW/profile http://localhost:49267/getInfo.html 12:37:20 INFO - 2015-12-01 12:37:20,684 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:37:20 INFO - 2015-12-01 12:37:20,684 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:37:20 INFO - 2015-12-01 12:37:20,684 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:37:20 INFO - 2015-12-01 12:37:20,684 DEBUG : BROWSER_OUTPUT: __metrics 12:37:20 INFO - 2015-12-01 12:37:20,700 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] 12:37:21 INFO - 2015-12-01 12:37:21,419 INFO : Browser initialized. 12:37:21 INFO - 2015-12-01 12:37:21,420 INFO : Running cycle 1/1 for kraken test... 12:37:21 INFO - 2015-12-01 12:37:21,420 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpSwTAQW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:33 INFO - 2015-12-01 12:37:33,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 197877760 12:37:33 INFO - 2015-12-01 12:37:33,426 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-12-01 12:37:36,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:37 INFO - 2015-12-01 12:37:37,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 264146944 12:37:37 INFO - 2015-12-01 12:37:37,001 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-01 12:37:40,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 12:37:40 INFO - 2015-12-01 12:37:40,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 276668416 12:37:40 INFO - 2015-12-01 12:37:40,635 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-01 12:37:43,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 12:37:44 INFO - 2015-12-01 12:37:44,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 265060352 12:37:44 INFO - 2015-12-01 12:37:44,492 DEBUG : BROWSER_OUTPUT: 12:37:46 INFO - 2015-12-01 12:37:46,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 12:37:47 INFO - 2015-12-01 12:37:47,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 265547776 12:37:47 INFO - 2015-12-01 12:37:47,405 DEBUG : BROWSER_OUTPUT: 12:37:49 INFO - 2015-12-01 12:37:49,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:50 INFO - 2015-12-01 12:37:50,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 264867840 12:37:50 INFO - 2015-12-01 12:37:50,496 DEBUG : BROWSER_OUTPUT: 12:37:54 INFO - 2015-12-01 12:37:54,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:54 INFO - 2015-12-01 12:37:54,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 263073792 12:37:54 INFO - 2015-12-01 12:37:54,603 DEBUG : BROWSER_OUTPUT: 12:37:58 INFO - 2015-12-01 12:37:58,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:58 INFO - 2015-12-01 12:37:58,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 263856128 12:37:58 INFO - 2015-12-01 12:37:58,835 DEBUG : BROWSER_OUTPUT: 12:38:02 INFO - 2015-12-01 12:38:02,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 12:38:02 INFO - 2015-12-01 12:38:02,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 263950336 12:38:02 INFO - 2015-12-01 12:38:02,745 DEBUG : BROWSER_OUTPUT: 12:38:04 INFO - 2015-12-01 12:38:04,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:05 INFO - 2015-12-01 12:38:05,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 297410560 12:38:05 INFO - 2015-12-01 12:38:05,104 DEBUG : BROWSER_OUTPUT: 12:38:07 INFO - 2015-12-01 12:38:07,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:07 INFO - 2015-12-01 12:38:07,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 298020864 12:38:07 INFO - 2015-12-01 12:38:07,757 DEBUG : BROWSER_OUTPUT: 12:38:10 INFO - 2015-12-01 12:38:10,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:38:10 INFO - 2015-12-01 12:38:10,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 304787456 12:38:10 INFO - 2015-12-01 12:38:10,687 DEBUG : BROWSER_OUTPUT: 12:38:13 INFO - 2015-12-01 12:38:13,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:14 INFO - 2015-12-01 12:38:14,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 306290688 12:38:14 INFO - 2015-12-01 12:38:14,205 DEBUG : BROWSER_OUTPUT: 12:38:17 INFO - 2015-12-01 12:38:17,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:17 INFO - 2015-12-01 12:38:17,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 306409472 12:38:17 INFO - 2015-12-01 12:38:17,711 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 12:38:19 INFO - 2015-12-01 12:38:19,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 365326336 12:38:19 INFO - 2015-12-01 12:38:19,910 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:38:19 INFO - 2015-12-01 12:38:19,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:38:19 INFO - 2015-12-01 12:38:19,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:38:19 INFO - 2015-12-01 12:38:19,911 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:38:19 INFO - 2015-12-01 12:38:19,911 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;133;126;131;132;133;118;132;130;122 12:38:19 INFO - 2015-12-01 12:38:19,911 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;186;155;194;185;161;181;151;189;178;152 12:38:19 INFO - 2015-12-01 12:38:19,911 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;196;195;195;195;196;192;190;197;197 12:38:19 INFO - 2015-12-01 12:38:19,911 DEBUG : BROWSER_OUTPUT: |3;audio-fft;91;101;94;144;81;83;86;87;140;82 12:38:19 INFO - 2015-12-01 12:38:19,911 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;115;119;160;109;109;108;157;109;109;159 12:38:19 INFO - 2015-12-01 12:38:19,912 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;148;142;142;142;142;135;141;143;148 12:38:19 INFO - 2015-12-01 12:38:19,912 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;153;154;154;153;154;154;152;147;153;153 12:38:19 INFO - 2015-12-01 12:38:19,912 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;123;122;129;128;124;124;123;123;123;123 12:38:19 INFO - 2015-12-01 12:38:19,912 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;73;74;76;77;76;76;86;70;70 12:38:19 INFO - 2015-12-01 12:38:19,912 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;75;79;79;79;80;80;80;80;76 12:38:19 INFO - 2015-12-01 12:38:19,912 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;101;102;103;100;100;100;100;103;105 12:38:19 INFO - 2015-12-01 12:38:19,913 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;151;149;152;154;144;155;150;147;148;154 12:38:19 INFO - 2015-12-01 12:38:19,913 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;176;168;179;181;177;179;172;177;167;168 12:38:19 INFO - 2015-12-01 12:38:19,913 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;81;83;84;83;84;83;85;83;82 12:38:19 INFO - 2015-12-01 12:38:19,913 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:38:19 INFO - 2015-12-01 12:38:19,913 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,964 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: __startTimestamp1449002299909__endTimestamp 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:38:19 INFO - 2015-12-01 12:38:19,915 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,916 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:128.40 Median:131.50 stddev:5.10 (3.9%) stddev-sans-first:5.39 12:38:19 INFO - 2015-12-01 12:38:19,916 DEBUG : BROWSER_OUTPUT: Values: 127.0 133.0 126.0 131.0 132.0 133.0 118.0 132.0 130.0 122.0 12:38:19 INFO - 2015-12-01 12:38:19,916 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,916 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:173.20 Median:183.00 stddev:16.64 (9.1%) stddev-sans-first:16.99 12:38:19 INFO - 2015-12-01 12:38:19,916 DEBUG : BROWSER_OUTPUT: Values: 186.0 155.0 194.0 185.0 161.0 181.0 151.0 189.0 178.0 152.0 12:38:19 INFO - 2015-12-01 12:38:19,916 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,917 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:194.50 Median:195.50 stddev:2.37 (1.2%) stddev-sans-first:2.33 12:38:19 INFO - 2015-12-01 12:38:19,917 DEBUG : BROWSER_OUTPUT: Values: 192.0 196.0 195.0 195.0 195.0 196.0 192.0 190.0 197.0 197.0 12:38:19 INFO - 2015-12-01 12:38:19,917 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,917 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:98.90 Median:84.50 stddev:23.53 (27.8%) stddev-sans-first:24.78 12:38:19 INFO - 2015-12-01 12:38:19,917 DEBUG : BROWSER_OUTPUT: Values: 91.0 101.0 94.0 144.0 81.0 83.0 86.0 87.0 140.0 82.0 12:38:19 INFO - 2015-12-01 12:38:19,917 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,918 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:125.40 Median:117.00 stddev:23.22 (19.8%) stddev-sans-first:24.32 12:38:19 INFO - 2015-12-01 12:38:19,918 DEBUG : BROWSER_OUTPUT: Values: 115.0 119.0 160.0 109.0 109.0 108.0 157.0 109.0 109.0 159.0 12:38:19 INFO - 2015-12-01 12:38:19,918 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,919 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.20 Median:142.50 stddev:4.18 (2.9%) stddev-sans-first:3.88 12:38:19 INFO - 2015-12-01 12:38:19,920 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 142.0 142.0 142.0 142.0 135.0 141.0 143.0 148.0 12:38:19 INFO - 2015-12-01 12:38:19,920 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,920 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:152.70 Median:153.50 stddev:2.11 (1.4%) stddev-sans-first:2.24 12:38:19 INFO - 2015-12-01 12:38:19,920 DEBUG : BROWSER_OUTPUT: Values: 153.0 154.0 154.0 153.0 154.0 154.0 152.0 147.0 153.0 153.0 12:38:19 INFO - 2015-12-01 12:38:19,920 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,920 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.20 Median:123.50 stddev:2.35 (1.9%) stddev-sans-first:2.45 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 129.0 128.0 124.0 124.0 123.0 123.0 123.0 123.0 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:76.00 stddev:5.95 (7.8%) stddev-sans-first:4.77 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: Values: 63.0 73.0 74.0 76.0 77.0 76.0 76.0 86.0 70.0 70.0 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:79.50 stddev:2.51 (3.2%) stddev-sans-first:1.87 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 79.0 79.0 79.0 80.0 80.0 80.0 80.0 76.0 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:100.80 Median:102.50 stddev:2.94 (2.9%) stddev-sans-first:1.81 12:38:19 INFO - 2015-12-01 12:38:19,921 DEBUG : BROWSER_OUTPUT: Values: 94.0 101.0 102.0 103.0 100.0 100.0 100.0 100.0 103.0 105.0 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:151.50 stddev:3.50 (2.3%) stddev-sans-first:3.71 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: Values: 151.0 149.0 152.0 154.0 144.0 155.0 150.0 147.0 148.0 154.0 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:177.00 stddev:5.21 (2.9%) stddev-sans-first:5.49 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: Values: 176.0 168.0 179.0 181.0 177.0 179.0 172.0 177.0 167.0 168.0 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.40 Median:83.00 stddev:2.50 (3.0%) stddev-sans-first:1.17 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: Values: 76.0 81.0 83.0 84.0 83.0 84.0 83.0 85.0 83.0 82.0 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:38:19 INFO - 2015-12-01 12:38:19,922 DEBUG : BROWSER_OUTPUT: 12:38:20 INFO - 2015-12-01 12:38:20,613 INFO : Browser exited with error code: 0 12:38:20 INFO - 2015-12-01 12:38:20,670 INFO : Completed test kraken (00:01:02) 12:38:20 INFO - 2015-12-01 12:38:20,671 INFO : Starting test v8_7 12:38:20 INFO - 2015-12-01 12:38:20,671 DEBUG : operating with platform_type : mac_ 12:38:20 INFO - 2015-12-01 12:38:20,671 INFO : Initialising browser for v8_7 test... 12:38:20 INFO - 2015-12-01 12:38:20,686 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmp1KtIM6/profile http://localhost:49267/getInfo.html 12:38:23 INFO - 2015-12-01 12:38:23,049 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:38:23 INFO - 2015-12-01 12:38:23,049 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:38:23 INFO - 2015-12-01 12:38:23,049 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:38:23 INFO - 2015-12-01 12:38:23,050 DEBUG : BROWSER_OUTPUT: __metrics 12:38:23 INFO - 2015-12-01 12:38:23,067 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] 12:38:23 INFO - 2015-12-01 12:38:23,825 INFO : Browser initialized. 12:38:23 INFO - 2015-12-01 12:38:23,825 INFO : Running cycle 1/1 for v8_7 test... 12:38:23 INFO - 2015-12-01 12:38:23,825 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmp1KtIM6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:38:35 INFO - 2015-12-01 12:38:35,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 197890048 12:38:35 INFO - 2015-12-01 12:38:35,817 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 12:38:58 INFO - 2015-12-01 12:38:58,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 524271616 12:38:58 INFO - 2015-12-01 12:38:58,939 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,939 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:38:58 INFO - 2015-12-01 12:38:58,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:38:58 INFO - 2015-12-01 12:38:58,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:38:58 INFO - 2015-12-01 12:38:58,940 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:38:58 INFO - 2015-12-01 12:38:58,940 DEBUG : BROWSER_OUTPUT: |0;Richards;199.6007984031936 12:38:58 INFO - 2015-12-01 12:38:58,940 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;222.0741727737064 12:38:58 INFO - 2015-12-01 12:38:58,940 DEBUG : BROWSER_OUTPUT: |2;Encrypt;416.49312786339027 12:38:58 INFO - 2015-12-01 12:38:58,940 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6972.222222222223 12:38:58 INFO - 2015-12-01 12:38:58,941 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1251.5644555694619 12:38:58 INFO - 2015-12-01 12:38:58,941 DEBUG : BROWSER_OUTPUT: |5;Earley;843.3024431339511 12:38:58 INFO - 2015-12-01 12:38:58,941 DEBUG : BROWSER_OUTPUT: |6;Boyer;14940.298507462687 12:38:58 INFO - 2015-12-01 12:38:58,941 DEBUG : BROWSER_OUTPUT: |7;RegExp;35068.96551724138 12:38:58 INFO - 2015-12-01 12:38:58,941 DEBUG : BROWSER_OUTPUT: |8;Splay;720.9805335255949 12:38:58 INFO - 2015-12-01 12:38:58,941 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6986.111111111111 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: __startTimestamp1449002338937__endTimestamp 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,942 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:199.60 Median:199.60 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,943 DEBUG : BROWSER_OUTPUT: Values: 199.6 12:38:58 INFO - 2015-12-01 12:38:58,943 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,943 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:222.07 Median:222.07 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,943 DEBUG : BROWSER_OUTPUT: Values: 222.1 12:38:58 INFO - 2015-12-01 12:38:58,943 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,944 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:416.49 Median:416.49 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,944 DEBUG : BROWSER_OUTPUT: Values: 416.5 12:38:58 INFO - 2015-12-01 12:38:58,944 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,944 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,944 DEBUG : BROWSER_OUTPUT: Values: 6972.2 12:38:58 INFO - 2015-12-01 12:38:58,945 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,945 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1251.56 Median:1251.56 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,945 DEBUG : BROWSER_OUTPUT: Values: 1251.6 12:38:58 INFO - 2015-12-01 12:38:58,945 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,945 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:843.30 Median:843.30 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,946 DEBUG : BROWSER_OUTPUT: Values: 843.3 12:38:58 INFO - 2015-12-01 12:38:58,946 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,946 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14940.30 Median:14940.30 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,947 DEBUG : BROWSER_OUTPUT: Values: 14940.3 12:38:58 INFO - 2015-12-01 12:38:58,947 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,947 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35068.97 Median:35068.97 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: Values: 35069.0 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: Values: 721.0 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6986.11 Median:6986.11 stddev:0.00 (0.0%) 12:38:58 INFO - 2015-12-01 12:38:58,948 DEBUG : BROWSER_OUTPUT: Values: 6986.1 12:38:58 INFO - 2015-12-01 12:38:58,949 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:38:58 INFO - 2015-12-01 12:38:58,949 DEBUG : BROWSER_OUTPUT: 12:38:59 INFO - 2015-12-01 12:38:59,637 INFO : Browser exited with error code: 0 12:38:59 INFO - 2015-12-01 12:38:59,662 INFO : Completed test v8_7 (00:00:38) 12:38:59 INFO - 2015-12-01 12:38:59,708 INFO : Completed test suite (00:20:17) 12:38:59 INFO - 2015-12-01 12:38:59,708 DEBUG : Working with test: dromaeo_css 12:38:59 INFO - 2015-12-01 12:38:59,708 DEBUG : Generating results file: dromaeo_css 12:38:59 INFO - 2015-12-01 12:38:59,709 DEBUG : Working with test: kraken 12:38:59 INFO - 2015-12-01 12:38:59,709 DEBUG : Generating results file: kraken 12:38:59 INFO - 2015-12-01 12:38:59,709 INFO : javascript benchmark 12:38:59 INFO - 2015-12-01 12:38:59,709 DEBUG : Working with test: v8_7 12:38:59 INFO - 2015-12-01 12:38:59,709 DEBUG : Generating results file: v8_7 12:38:59 INFO - 2015-12-01 12:38:59,710 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:59 INFO - 2015-12-01 12:38:59,789 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 12:38:59 INFO - 2015-12-01 12:38:59,789 DEBUG : process_Request line: dromaeo_css 5504.68 graph.html#tests=[[72,52,55]] 12:38:59 INFO - 2015-12-01 12:38:59,789 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:59 INFO - 2015-12-01 12:38:59,823 DEBUG : process_Request line: kraken 1800.70 graph.html#tests=[[232,52,55]] 12:38:59 INFO - 2015-12-01 12:38:59,823 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:59 INFO - 2015-12-01 12:38:59,854 DEBUG : process_Request line: v8_7 16772.45 graph.html#tests=[[230,52,55]] 12:38:59 INFO - 2015-12-01 12:38:59,855 INFO : javascript benchmark 12:38:59 INFO - 2015-12-01 12:38:59,857 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [293.5669886916797, 296.4885572387632, 298.358529162301, 298.63119047975755, 301.48897618536574, 12132.878671213286, 12577.622671319876, 14631.268436578168, 14748.115113093208, 15168.620784480394, 12369.876301236985, 14406.207658578774, 14557.199354035523, 14886.106833589965, 14988.10071395717, 3809.8285577149027, 3979.661728753045, 4106.8973275668195, 4478.731276123443, 4480.820767169309, 3024.2439390152463, 3079.7536197104178, 3104.9689503104905, 4102.077032667656, 4136.73111247768, 3904.2581909437117, 4002.1995600879795, 4059.7361171523903, 4094.160697057111, 4108.609682080212, 3872.6320999505283, 4049.514058312992, 4080.0207950091913, 4088.632023117919, 4096.242195193869, 3411.249525104498, 3414.5048967899515, 3425.0, 3425.6745609167087, 3429.8971030869116, 10583.259171857973, 10748.0, 10885.945570272099, 10914.890851091466, 11027.44862756867, 1511.8554499309646, 1553.432996956103, 1569.4036266218877, 1572.4653617769898, 1574.3545146489885, 7697.0763508378795, 7889.842203155905, 8015.839683206362, 8157.75526734199, 8189.549574773385, 1244.695049712817, 1284.678830292427, 1306.8366454193226, 1317.084626184802, 1365.1672479787321, 47189.76405117987, 47687.28469072967, 49763.0, 49766.253506197434, 50127.0, 5482.205080263339, 5628.774849005994, 5645.266115404971, 5704.429557044263, 5762.279715035621, 6426.421622053944, 6448.903266451007, 6490.772822951174, 6504.15445992018, 6514.5114116441455, 4686.95313046872, 4785.688930219525, 4786.688865223749, 4808.158572249842, 4844.515548445127, 5119.820806271762, 5158.664686795346, 5164.845054648366, 5177.767000484987, 5179.870503237374, 2514.585093459595, 2529.6584961030026, 2563.115725074846, 2572.408346080412, 2578.1105518596055, 887.7203680840514, 903.4263242840843, 906.2025417632441, 927.0405130689704, 958.1424624960621, 287.3247867511373, 356.37278390033725, 376.18743514009606, 377.8545260074836, 385.07581803670854, 9595.088466595662, 9605.327627066177, 9840.950795245977, 9937.155341796028, 9948.651797187209, 358.36211543452697, 394.7907608967252, 401.81516502408635, 404.06660613981796, 405.34132035442406, 5186.766595503212, 5215.29593504872, 5264.894702105937, 5349.679019258857, 5490.396056433789, 419676.0, 492912.0, 496074.0, 502202.0, 504023.0, 61114.69442652847, 65371.0, 65400.67299663471, 65416.0, 65434.34565654378, 386.28922782081105, 396.9325214713506, 398.90426297688924, 399.1757021750135, 399.75415119701756, 9299.0, 9334.113259240361, 9405.153536181777, 9421.905780942378, 9677.806443870943, 29174.41651167007, 30466.695333046388, 30750.231244219074, 30937.845310774203, 31169.68830311668, 40943.795281023406, 41372.37941430941, 41416.0, 42059.7897010513, 42148.367774482795, 5165.457626949116, 5366.275552800322, 5385.165299378603, 5389.110796718497, 5397.487238712316, 9286.860697089684, 9812.558434870305, 9933.453660048766, 9950.701478955643, 10158.695239142837, 8529.3602979778, 8581.570921454027, 8650.13498650155, 8761.91238087611, 8764.1674040966, 7934.603269836601, 8400.747977560683, 8452.070272269922, 8479.533625650402, 8492.065872753868, 8191.959040204761, 8807.955960220157, 8837.983631882416, 8860.424072435271, 8863.556822158995, 4659.813607455664, 4728.196206644948, 5265.52610265078, 5313.043652142652, 5350.545203657733, 8298.543580103153, 8439.746807595782, 8558.358123140913, 8586.957065214634, 8605.569721514024], "dojo.html": [2650.6289119523262, 2719.4968930747805, 2721.047633328334, 2761.599568062631, 2772.500949829031, 4568.109218702354, 4585.105904348653, 4636.1886669832775, 4665.253559430492, 4708.505606911268, 4666.393368862052, 4678.157931572316, 4681.672282940195, 4693.389859318284, 4699.2951057341415, 4088.2232375848494, 4151.730137541065, 4204.306289462243, 4274.807633656493, 4318.8488402905905, 4095.877123686294, 4175.144095460423, 4187.979060104695, 4218.957810421903, 4310.116426132651, 4172.582741725833, 4184.8535301264465, 4221.071364299849, 4252.574742525753, 4264.168487145008, 4125.422440858252, 4172.248995180867, 4194.182134483777, 4216.114615930627, 4271.893202669942, 3850.6534411902785, 3998.0, 4084.346504559286, 4084.591540845892, 4097.7541347518945, 4442.067165895166, 4460.77696115193, 4484.573965473275, 4497.730136191839, 4508.819647214107, 4790.329353890458, 4808.807647694123, 4814.7833347499445, 4828.396450443694, 4857.73282469464, 4642.396488456513, 4765.880852978668, 4778.593819525345, 4866.245731911559, 4897.8775530611665, 4335.046289816235, 4430.13612345596, 4445.888852778642, 4475.485319188302, 4487.5961163494785, 4870.147724148331, 4988.55103040728, 4990.6257030722845, 5034.345535080416, 5067.746612669352, 4562.224421848294, 4623.398958135488, 4666.066786642685, 4779.354787103766, 4834.516548345207, 4680.3915490985955, 4696.319033740088, 4707.340972263886, 4762.380890484214, 4766.6901651392545, 4868.610511159099, 4899.779509921991, 4925.113479573711, 4941.110600091946, 4942.0, 4636.79134438951, 4693.882652933636, 4761.785719642625, 4859.198232291632, 4938.555530002317, 3717.2937141942944, 3747.269282489888, 3785.9432108518395, 3797.6582107610448, 3810.2950954073585, 3405.9489107663403, 3428.245785927092, 3432.2277487565098, 3469.774464659789, 3502.124468882779, 4478.798454069574, 4481.439820022497, 4494.348319493721, 4498.887527811831, 4509.864704058883, 4727.787249573777, 4760.357351757469, 4904.411470623477, 4905.3132561441425, 4914.189158788831, 4455.086707225011, 4497.887552811206, 4527.705699129546, 4533.297338912474, 4538.818447262139, 4268.317069268902, 4286.292761694348, 4291.9785401072795, 4305.375720520507, 4326.6754993375625, 4813.1336359454235, 4838.395200599925, 4916.385451818523, 4964.205727083649, 5020.096382651158, 4925.310456536016, 4967.933521323526, 5020.021095886267, 5040.269160971565, 5048.7223202722735, 5060.721660308718, 5062.215356619729, 5071.39143302806, 5075.213341932006, 5079.593632509316, 4684.367610372556, 4755.2153894607, 4806.279058141167, 4814.711117332971, 4909.582685471775, 4811.470738218723, 4816.735079570657, 4827.155247831545, 4841.370621819141, 4914.336564563881, 4592.989542300822, 4696.0607878425135, 4714.528547145258, 4747.477777444547, 4750.287456881495, 4610.930836037529, 4699.953000469952, 4704.341392205026, 4738.549837765407, 4770.666053376231, 4685.929711054268, 4698.69458485211, 4702.92945605823, 4795.712257264575, 4839.612830973584, 4793.640476964172, 4864.027194561031, 4882.096812089775, 4911.214205727067, 4923.113839508779, 4538.977305113453, 4621.445426548836, 4648.395708557866, 4780.737059461763, 4846.903061938812], "mootools.html": [1103.0458653264927, 1450.8113945187124, 1511.221720813781, 1540.1144342003347, 1542.8534289242525, 5677.886442271158, 5951.732172052257, 5971.223740913681, 6072.939270607292, 6077.02767557191, 6079.422454866781, 6173.50611951044, 6175.475084617801, 6192.659403732793, 6201.968990155043, 1802.513321403217, 1809.2672467650623, 1812.9365472208476, 1812.9637407251846, 1813.0934532733634, 1822.6172503774224, 1853.7404763333145, 1854.5270955906226, 1856.9628607427844, 1860.748798912143, 1803.936862209823, 1811.1849667649544, 1816.455063480957, 1821.317006122704, 1825.4341154242227, 1761.3042848075004, 1788.2668106076512, 1789.1680368628586, 1791.265581111738, 1797.2271923073074, 1787.8748487605874, 1814.319630138698, 1819.0995457248614, 1826.6711991841464, 1832.7983921768596, 5473.17902314656, 6051.0923361496125, 6079.39206079393, 6084.330723620398, 6113.296970848365, 3424.4520876659863, 3773.3019391412677, 3884.3396622574232, 3892.591277915835, 3905.8632947846972, 2313.4447732544068, 2361.114582031738, 2400.5198960208027, 2401.363638635763, 2405.579023670851, 717.3077979749514, 720.6396801599201, 723.6779633063289, 744.0847757258603, 750.4634186556584, 8019.799505012421, 8049.0, 8081.43429959903, 8095.919040809576, 8118.512889226666, 3407.9488807667904, 3469.427544455187, 3471.5139880416764, 3518.595361533405, 3544.8936531904083, 7184.317489838457, 7189.0654214952765, 7191.64041797908, 7217.314355136254, 7217.953396757441, 3935.4687117239378, 3938.4879965604287, 3939.8227079781477, 3947.743396679207, 3960.207958408272, 3629.4192929131214, 3633.1280492681567, 3636.8545258189906, 3642.6357364263363, 3645.2709458108484, 2882.927926801805, 2908.1130255271923, 2938.133250691051, 2956.645202575705, 2965.7775666825073, 905.3617199874072, 919.6367434863325, 921.5991043895926, 927.679950417105, 928.0116675740315, 1014.8934361892043, 1046.4610725476387, 1054.6414219165367, 1055.4406164732704, 1118.4854966715402, 5910.586258961831, 5923.289205295392, 5955.821325360246, 5959.344472108065, 5987.670678112746, 401.4219523885654, 405.2078187144126, 409.3327875562873, 411.7652937825471, 412.4658567155541, 4725.9527404726205, 4777.044591081798, 4778.020505796303, 4800.0, 4809.014152098812, 6739.292374300726, 6868.107146070979, 6950.652467376611, 7194.568325900463, 7195.712171513185, 7123.715051397886, 7156.355927966404, 7177.89233161503, 7203.495755297079, 7208.675609597581, 5676.574256930747, 5838.4453476919625, 5862.0, 5877.382874798084, 5902.822915312548, 5700.287464066992, 5731.168980497888, 5733.627314224562, 5749.798757043651, 5767.423257674199, 6388.488920886225, 6471.996840489732, 6472.093906853139, 6582.670866456562, 6649.0, 6558.311377305315, 6720.899186512109, 6751.324867513209, 6767.695453704497, 6922.8961565577565, 5512.724363781875, 5533.723313834373, 5547.2511210986, 5557.610967232416, 5584.525315348078, 5791.507721843691, 5824.592278540462, 5825.0, 5835.328937172109, 5864.032434648235, 5558.749856256397, 5635.182898479779, 5696.715164241854, 5737.053386191232, 5747.942520574908, 5228.7647055883335, 5551.972240138935, 5561.527270181918, 5640.435956404327, 5641.520470759867, 5587.497125258747, 5646.802361917313, 5669.951059054089, 5683.8863222736145, 5695.572832037531, 4945.406551213878, 4976.701397916137, 4979.875503112306, 5007.37407824022, 5013.749312534432, 4784.808607655794, 4825.155597770447, 4830.7101573905675, 4835.661503694708, 4878.048780487771], "ext.html": [474.09921149815347, 479.2858640625468, 481.2060100833624, 493.0115119186033, 506.35945528905916, 27444.451110977792, 28254.717452825465, 33159.66840331596, 33335.333293334115, 33497.16257093574, 36215.275694486096, 36718.0, 36787.0, 36812.44781328276, 37027.07432314193, 7214.7114115435315, 7698.92301076989, 7814.648340824648, 7845.490043147206, 7854.646540905673, 7242.818929526751, 9229.123233292827, 9240.306976976754, 9428.010058943815, 9589.760255993586, 9229.261659067259, 9279.30405219608, 9380.343375963685, 9398.483083430408, 9403.529823508798, 7147.428205743528, 7440.0, 9150.725478235663, 9400.529973501298, 9421.717348479557, 9027.684031058881, 9186.724398267996, 9265.16613504781, 9285.489298088602, 9317.11487408695, 34144.14639634004, 34236.315273694636, 34676.47985280223, 34705.132371690655, 34775.30449390998, 2508.1973768394123, 2513.2711513661015, 2771.625830512875, 2871.4974879396023, 2938.720821521952, 23976.760232397628, 24023.759762402326, 24223.7577624225, 24558.508829823302, 24677.383065423328, 1971.802819718031, 2015.1637070615677, 2019.1620477501965, 2040.5306779440812, 2058.6603210470253, 233277.0, 234247.0, 234373.0, 234430.0, 236782.0, 44015.0, 45574.0, 50901.490985090415, 51289.23066154011, 51378.48621513737, 51878.74060629673, 52823.73588132112, 53370.0, 53387.0, 53430.0, 14563.563093107225, 14672.193029383487, 14821.0, 14881.851181488262, 14912.328945197276, 11258.0, 11263.324200547993, 11337.206395552232, 11429.828552571718, 11438.199326047263, 16138.515844524683, 16782.496525104023, 16860.156992150343, 16905.915470422817, 16997.830021699872, 6649.135612370457, 6753.45972322213, 6769.661516924134, 6813.318668133246, 6886.51794374389, 768.4390395011673, 868.6264906090441, 874.54960695242, 966.8211380894558, 980.3039841712322, 24099.0, 24103.0, 24772.0, 24784.876075619508, 24875.875620622144, 843.2621456225802, 863.2921004776149, 910.7267819654078, 910.8588168833842, 980.6371642492181, 11811.704707382385, 12499.50001999928, 12840.807387889188, 12901.419436125208, 12960.80558791619, 424419.0, 429868.0, 430444.0, 431308.0, 432100.0, 40986.0, 41766.79116604458, 45450.0, 46616.0, 47985.5201447981, 1198.7003249187703, 1212.0848759186758, 1226.9325187114794, 1232.1744431230918, 1237.808139738342, 21643.13427462884, 22879.199228027606, 23088.076476941405, 23265.0, 23358.299251022498, 35574.64425355713, 35694.4645830318, 35741.28517429585, 35784.284314314085, 35808.820955896095, 233381.0, 236760.0, 237320.0, 239461.0, 239578.0, 27645.447091058468, 27918.44163116767, 28087.578686320132, 28095.719042810128, 28097.438051238452, 35577.644223557436, 35987.0, 36744.0, 36848.44727329146, 36897.44653830249, 28736.425271494034, 29066.0, 30773.0, 30830.53754193644, 30855.69144308528, 29554.704452956055, 29889.402211955203, 29950.101496955125, 30098.548521771754, 30129.0, 30501.389972199988, 30904.845475772476, 31647.683523164473, 32058.0, 32093.518597220595, 25188.622170667088, 26996.46007079887, 27056.864715676296, 27204.591931120653, 27318.180454586392, 20597.691034634194, 20779.272725454535, 20813.271535496184, 20835.166593336096, 21126.577468450236], "prototype.html": [254.21701160425891, 263.63354936638063, 268.5769912387989, 278.039373962958, 281.3206107250989, 5063.62022848287, 5118.539331460168, 5144.845654630358, 5165.30268413764, 5173.2240163975375, 4966.677165984209, 5022.422421421537, 5054.84835454936, 5085.923711144335, 5094.083065048299, 3912.23711376281, 3944.1914407546383, 3963.544192417866, 3970.285348637244, 3987.3022221111332, 3796.2027974125467, 3884.514435695538, 3894.045958740113, 3949.8222579983826, 3954.070793363557, 3832.7508711933774, 3882.9611703882883, 3922.0979174789813, 3933.645971862532, 3939.468171796799, 3918.216356728637, 3918.8236529355963, 3922.2547715933883, 3923.5291764988096, 3924.0, 3424.195314101184, 3424.366492198926, 3424.520567120605, 3440.17435815405, 3440.6559344065395, 4912.606991440676, 4931.235658472942, 4949.307097006422, 4967.801287948478, 4969.055879382906, 3950.4271880577444, 4188.958110418887, 4250.681198910063, 4337.9132417351475, 4354.129174165148, 5230.686158830483, 5297.073012222884, 5304.681719096867, 5314.548263397616, 5342.0, 3705.925881482382, 3708.554973403182, 3717.888463346104, 3729.2355067211156, 3733.141377483194, 5511.063119269734, 5523.6685798852195, 5525.4474552544825, 5534.252875861747, 5544.0, 3788.2802267569073, 3813.923721525554, 3829.425586162098, 3830.367989281737, 3839.308924393636, 3758.267137908136, 3860.864869729546, 3867.1298957734284, 3871.5934826842777, 3876.8255428505786, 4448.510663826976, 4462.241418958784, 4471.0, 4476.350929115325, 4481.775911204427, 5368.248445217672, 5394.514493695587, 5402.567794576425, 5405.00007498614, 5419.972900135474, 1353.8443079046035, 1401.740677974578, 1405.2692599848021, 1407.4792326839136, 1410.5697762182633, 869.3957699398857, 892.1836519584507, 915.9954200228956, 929.9674511392204, 939.9765005874908, 5080.5681517070725, 5082.33929589151, 5089.083964886282, 5104.2088476286235, 5107.514786095315, 5557.249771280906, 5582.106862901916, 5584.441555844383, 5584.553235741131, 5596.664200148004, 4919.508049195123, 5072.721000345016, 5075.39095308558, 5087.287779710843, 5090.261912022736, 2985.537241727492, 3004.1288026472516, 3070.7543396528226, 3077.07687693691, 3080.7997480163717, 5566.443355664401, 5609.691466969356, 5617.960677274717, 5626.493615574536, 5631.8592035199445, 5653.152027195953, 5709.74306156224, 5714.200011998323, 5734.541236701054, 5738.569607279471, 5517.062099443105, 5590.329160500766, 5598.916016259759, 5650.689212093374, 5659.151127330769, 5574.386817450159, 5584.944150558443, 5585.357683866408, 5619.578531610064, 5636.943630563642, 5503.587230957614, 5503.972480137573, 5504.53211477029, 5512.283403157564, 5519.061759500974, 5439.564834813126, 5637.098064309691, 5640.407757185437, 5647.463490968352, 5672.404397538199, 3855.0940528975107, 3904.39481880309, 3910.9217815644097, 3915.4518367428013, 3917.5298964124486, 5602.1036634138345, 5607.271054763018, 5626.324841019104, 5629.380768115586, 5643.858903527444, 5450.373207081237, 5460.180972854104, 5478.260434841405, 5485.424030476743, 5491.203775452457, 5277.102892508359, 5442.700651464207, 5445.727713614383, 5457.8362649119, 5468.0, 5159.664621799571, 5292.259083728204, 5303.7878484860175, 5306.814261500829, 5314.52169304749, 5380.461953804745, 5396.109641909198, 5408.621396502207, 5409.729513524387, 5419.539339156216, 5197.272381866617, 5295.7352132394, 5311.044012077863, 5327.440618734977, 5364.356277246756], "yui.html": [526.6339893773826, 530.453632758259, 531.7314756048195, 559.3092530724552, 637.0380725105091, 11379.431028448576, 11643.30140191589, 11669.183157179, 11673.824892626606, 11760.882391176086, 10123.392596444219, 11060.391678457681, 11098.112151027919, 11102.111831053517, 11132.721681957955, 608.1030480041936, 618.7741474361848, 729.6825880741868, 745.2249660353226, 751.7594369801666, 763.5723994563035, 773.9458237923347, 774.2412435812906, 774.8915151878741, 775.2673723331454, 631.3465563142149, 786.0528063683248, 794.5868148562744, 795.4153697032705, 797.5453991225004, 639.4979940746515, 758.3970743259094, 759.2331744937653, 771.340503869195, 774.6436639146, 551.3686828581252, 563.4787821265313, 563.8956792993309, 566.9433056694339, 566.9907564535134, 11371.545138194546, 11452.885471145266, 11498.367589782558, 11547.364894930775, 11550.36472993985, 7525.698972041112, 7657.4639775215755, 7898.447108702393, 8106.807436036054, 8349.95825020871, 7260.2013778484325, 7340.302671246223, 7453.813654658677, 7476.626168691544, 7618.542887426772, 2456.65606815046, 2544.211294498711, 2551.1836212412036, 2590.002848903167, 2624.238970698495, 40211.122862331344, 40613.18773624511, 40974.59025409738, 41044.0, 41057.794711026254, 5858.765649373977, 5868.941310586925, 6026.306974697878, 6085.5435842312, 6267.2165979252595, 9861.950690246646, 9967.750806229757, 9976.501174941224, 9985.1512621428, 10007.599696012223, 4869.586085182728, 4938.975305123451, 5047.949520504748, 5172.948270517247, 5177.870553236199, 3271.329377477611, 3303.7687361884437, 3336.7831090979007, 3355.4295769719206, 3397.235621985083, 2160.2763074369946, 2180.531185795062, 2181.5636872625537, 2184.333778197665, 2184.6286131357706, 332.5344517675274, 335.47498165371115, 336.157924399378, 336.95956485221933, 336.9696727294555, 365.459120501659, 423.0439207391318, 424.6772452935791, 424.8931533355564, 470.4777696756598, 5908.379620139909, 6082.665453400017, 6122.66325352101, 6154.415330543681, 6249.7187626556915, 333.9983300083484, 470.454273043275, 476.5234765234765, 496.9349094304011, 498.8827625508003, 2492.626106084102, 2594.6626938497875, 2620.513254343057, 3040.9543856842165, 3091.520814273791, 47219.76390118096, 48229.0, 48323.27515087206, 51331.48668513267, 51377.229341559905, 42379.15241695149, 42815.14369712651, 42919.7854010728, 42986.355204671956, 43393.78303108527, 38708.0, 38719.419208712454, 39338.80330598329, 41636.37545436821, 41797.1640567193, 5846.210761547307, 5935.5548333875995, 6027.547933904887, 6040.607360521552, 6088.0, 29879.402411952073, 30724.692753072184, 30750.384992300475, 31194.37611247717, 31889.0, 39928.201435970535, 40053.0, 40764.0, 41891.0, 42454.15091698087, 6215.906761398493, 6224.844378890564, 6271.529635277281, 6400.839979000376, 6869.656517174221, 9146.0, 9187.678431254873, 9192.310576706908, 9250.4912229828, 9328.347015709107, 8176.223258790405, 8553.82892342162, 8604.78488037779, 8617.913820861962, 8625.69810056645, 8695.391322607356, 8708.60811263482, 8711.128887111237, 8756.474611523328, 8760.737177884674, 8570.100139485265, 8671.653133874574, 8689.0, 8703.782405439915, 8717.738467845975, 7612.581308028111, 7692.307692307683, 7838.725644602411, 7877.448578599672, 8112.553809540532, 7087.822804429724, 7613.5431874087735, 7684.538927664358, 7869.134395216407, 7891.723789667334]}, "summary": {"suite": 5504.67734302464, "subtests": {"jquery.html": {"filtered": 5668.543907389188, "value": 5668.543907389188}, "dojo.html": {"filtered": 4490.896078819008, "value": 4490.896078819008}, "mootools.html": {"filtered": 3502.7410057765305, "value": 3502.7410057765305}, "ext.html": {"filtered": 16084.325399047275, "value": 16084.325399047275}, "prototype.html": {"filtered": 4054.764162695093, "value": 4054.764162695093}, "yui.html": {"filtered": 4783.672029422431, "value": 4783.672029422431}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0023"}, "testrun": {"date": 1449001121, "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": "20151201104822", "branch": "Mozilla-Aurora", "revision": "bb474924f23bfa27e850fd895448ccf4d85ed5c8"}}, {"talos_counters": {}, "results": {"audio-dft": [192.0, 196.0, 195.0, 195.0, 195.0, 196.0, 192.0, 190.0, 197.0, 197.0], "ai-astar": [127.0, 133.0, 126.0, 131.0, 132.0, 133.0, 118.0, 132.0, 130.0, 122.0], "imaging-gaussian-blur": [149.0, 148.0, 142.0, 142.0, 142.0, 142.0, 135.0, 141.0, 143.0, 148.0], "audio-beat-detection": [186.0, 155.0, 194.0, 185.0, 161.0, 181.0, 151.0, 189.0, 178.0, 152.0], "json-stringify-tinderbox": [73.0, 75.0, 79.0, 79.0, 79.0, 80.0, 80.0, 80.0, 80.0, 76.0], "stanford-crypto-pbkdf2": [176.0, 168.0, 179.0, 181.0, 177.0, 179.0, 172.0, 177.0, 167.0, 168.0], "json-parse-financial": [63.0, 73.0, 74.0, 76.0, 77.0, 76.0, 76.0, 86.0, 70.0, 70.0], "stanford-crypto-sha256-iterative": [76.0, 81.0, 83.0, 84.0, 83.0, 84.0, 83.0, 85.0, 83.0, 82.0], "audio-fft": [91.0, 101.0, 94.0, 144.0, 81.0, 83.0, 86.0, 87.0, 140.0, 82.0], "imaging-darkroom": [153.0, 154.0, 154.0, 153.0, 154.0, 154.0, 152.0, 147.0, 153.0, 153.0], "stanford-crypto-ccm": [151.0, 149.0, 152.0, 154.0, 144.0, 155.0, 150.0, 147.0, 148.0, 154.0], "audio-oscillator": [115.0, 119.0, 160.0, 109.0, 109.0, 108.0, 157.0, 109.0, 109.0, 159.0], "stanford-crypto-aes": [94.0, 101.0, 102.0, 103.0, 100.0, 100.0, 100.0, 100.0, 103.0, 105.0], "imaging-desaturate": [123.0, 122.0, 129.0, 128.0, 124.0, 124.0, 123.0, 123.0, 123.0, 123.0]}, "summary": {"suite": 1800.7, "subtests": {"audio-fft": {"filtered": 98.9, "value": 98.9}, "stanford-crypto-pbkdf2": {"filtered": 174.4, "value": 174.4}, "audio-beat-detection": {"filtered": 173.2, "value": 173.2}, "stanford-crypto-ccm": {"filtered": 150.4, "value": 150.4}, "imaging-darkroom": {"filtered": 152.7, "value": 152.7}, "json-parse-financial": {"filtered": 74.1, "value": 74.1}, "audio-oscillator": {"filtered": 125.4, "value": 125.4}, "ai-astar": {"filtered": 128.4, "value": 128.4}, "audio-dft": {"filtered": 194.5, "value": 194.5}, "stanford-crypto-sha256-iterative": {"filtered": 82.4, "value": 82.4}, "json-stringify-tinderbox": {"filtered": 78.1, "value": 78.1}, "imaging-gaussian-blur": {"filtered": 143.2, "value": 143.2}, "stanford-crypto-aes": {"filtered": 100.8, "value": 100.8}, "imaging-desaturate": {"filtered": 124.2, "value": 124.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0023"}, "testrun": {"date": 1449001121, "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": "20151201104822", "branch": "Mozilla-Aurora", "revision": "bb474924f23bfa27e850fd895448ccf4d85ed5c8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [222.0741727737064], "Encrypt": [416.49312786339027], "NavierStokes": [6986.111111111111], "Decrypt": [6972.222222222223], "Splay": [720.9805335255949], "Richards": [199.6007984031936], "RegExp": [35068.96551724138], "Earley": [843.3024431339511], "Boyer": [14940.298507462687], "RayTrace": [1251.5644555694619]}, "summary": {"suite": 16772.4531509457, "subtests": {"DeltaBlue": {"filtered": 297.7293540000001, "value": 297.7293540000001}, "Encrypt": {"filtered": 639.1005810000001, "value": 639.1005810000001}, "NavierStokes": {"filtered": 212.42147117296216, "value": 212.42147117296216}, "Decrypt": {"filtered": 38.177354581673285, "value": 38.177354581673285}, "Splay": {"filtered": 113.028017, "value": 113.028017}, "RegExp": {"filtered": 25.976956735496543, "value": 25.976956735496543}, "Richards": {"filtered": 176.86301999999998, "value": 176.86301999999998}, "Earley": {"filtered": 790.3012797202798, "value": 790.3012797202798}, "Boyer": {"filtered": 44.60841258741261, "value": 44.60841258741261}, "RayTrace": {"filtered": 591.2512109999999, "value": 591.2512109999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0023"}, "testrun": {"date": 1449001121, "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": "20151201104822", "branch": "Mozilla-Aurora", "revision": "bb474924f23bfa27e850fd895448ccf4d85ed5c8"}}] 12:38:59 INFO - RETURN: dromaeo_css: 5504.68 12:38:59 INFO - RETURN: kraken: 1800.70 12:38:59 INFO - RETURN: v8_7: 16772.45 12:38:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "16772.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1800.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5504.68"}}} 12:38:59 INFO - Return code: 0 12:38:59 INFO - # TBPL SUCCESS # 12:38:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:38:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:38:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:38:59 INFO - 2015-12-01 12:38:59.952 screenresolution[1666:10679] starting screenresolution argv=screenresolution get 12:38:59 INFO - 2015-12-01 12:38:59.956 screenresolution[1666:10679] Display 0: 1600x1200x32@60 12:38:59 INFO - 2015-12-01 12:38:59.963 screenresolution[1667:10682] starting screenresolution argv=screenresolution list 12:38:59 INFO - Available Modes on Display 0 12:38:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:38:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:38:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:38:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:39:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:39:00 INFO - Intel HD Graphics 3000: 12:39:00 INFO - Chipset Model: Intel HD Graphics 3000 12:39:00 INFO - Type: GPU 12:39:00 INFO - Bus: Built-In 12:39:00 INFO - VRAM (Total): 512 MB 12:39:00 INFO - VRAM (Dynamic, Max): 10 12:39:00 INFO - Vendor: Intel (0x8086) 12:39:00 INFO - Device ID: 0x0116 12:39:00 INFO - Revision ID: 0x0009 12:39:00 INFO - Displays: 12:39:00 INFO - Display: 12:39:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:39:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:39:00 INFO - Display Serial Number: 1600x1200 60 12:39:00 INFO - Main Display: Yes 12:39:00 INFO - Mirror: Off 12:39:00 INFO - Online: Yes 12:39:00 INFO - Rotation: Supported 12:39:00 INFO - Return code: 0 12:39:00 INFO - Running post-action listener: _resource_record_post_action 12:39:00 INFO - Running post-run listener: _resource_record_post_run 12:39:01 INFO - Total resource usage - Wall time: 1262s; CPU: 30.0%; Read bytes: 37794816; Write bytes: 680196096; Read time: 4079; Write time: 55701 12:39:01 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 339575296; Write bytes: 334266368; Read time: 38144; Write time: 2925 12:39:01 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 35763200; Write bytes: 334833664; Read time: 3458; Write time: 51846 12:39:01 INFO - Running post-run listener: _upload_blobber_files 12:39:01 INFO - Blob upload gear active. 12:39:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:39:01 INFO - Copying logs to upload dir... 12:39:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1344.619943 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2015-12-01 12:39:01.424820) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 12:39:01.428413) ========= 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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/3rJalhFnQn-zMeNAp6hzdA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 12:39:01.452002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:39:01.452320) ========= 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.5NUVLTvk1K/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.eAzDL5R6jH/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.006246 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 12:39:01.501795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 12:39:01.502113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 12:39:01.502500) ========= ========= Total master_lag: 0.72 =========