builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0016 starttime: 1448102486.52 results: success (0) buildid: 20151121004041 builduid: 9029a10527914c5c9d28660cf3a6f1fd revision: 1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:26.524851) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:26.525357) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:26.525688) ========= 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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.005770 basedir: '/builds/slave/test' ========= master_lag: 0.36 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:26.892850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:26.893195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.057953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.058240) ========= 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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.020690 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.184472) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.184788) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.185194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.185507) ========= 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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-21 02:41:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-21 02:41:27 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.247692 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.538352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.538719) ========= 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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.141605 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.818736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:27.822474) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa --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 1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-21 02:41:27,935 truncating revision to first 12 chars 2015-11-21 02:41:27,935 Setting DEBUG logging. 2015-11-21 02:41:27,935 attempt 1/10 2015-11-21 02:41:27,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1802aa83ee3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 02:41:28,289 unpacking tar archive at: mozilla-aurora-1802aa83ee3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610812 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:28.507235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:28.507571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:28.582711) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:28.583037) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 02:41:28.583495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 41 secs) (at 2015-11-21 02:41:28.583848) ========= /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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 02:41:28 INFO - MultiFileLogger online at 20151121 02:41:28 in /builds/slave/test 02:41:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:41:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:41:28 INFO - {'append_to_log': False, 02:41:28 INFO - 'base_work_dir': '/builds/slave/test', 02:41:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:41:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:41:28 INFO - 'branch': 'Mozilla-Aurora', 02:41:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:28 INFO - 'config_files': ('talos/mac_config.py',), 02:41:28 INFO - 'default_actions': ('clobber', 02:41:28 INFO - 'read-buildbot-config', 02:41:28 INFO - 'download-and-extract', 02:41:28 INFO - 'populate-webroot', 02:41:28 INFO - 'create-virtualenv', 02:41:28 INFO - 'install', 02:41:28 INFO - 'run-tests'), 02:41:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:28 INFO - 'download_minidump_stackwalk': True, 02:41:28 INFO - 'download_symbols': 'ondemand', 02:41:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:28 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:28 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:28 INFO - 'installer_path': 'installer.exe', 02:41:28 INFO - 'log_level': 'info', 02:41:28 INFO - 'log_name': 'talos', 02:41:28 INFO - 'log_to_console': True, 02:41:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:41:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:41:28 INFO - 'opt_config_files': (), 02:41:28 INFO - 'pip_index': False, 02:41:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:41:28 INFO - 'cmd': ('bash', 02:41:28 INFO - '-c', 02:41:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:41:28 INFO - 'enabled': True, 02:41:28 INFO - 'halt_on_failure': False, 02:41:28 INFO - 'name': 'check_screen_resolution'},), 02:41:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:41:28 INFO - 'cmd': ('bash', 02:41:28 INFO - '-c', 02:41:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:41:28 INFO - 'enabled': True, 02:41:28 INFO - 'halt_on_failure': False, 02:41:28 INFO - 'name': 'check_screen_resolution'},), 02:41:28 INFO - 'run_cmd_checks_enabled': True, 02:41:28 INFO - 'sps_profile': False, 02:41:28 INFO - 'sps_profile_interval': 0, 02:41:28 INFO - 'suite': 'dromaeojs', 02:41:28 INFO - 'system_bits': '64', 02:41:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:28 INFO - 'title': 't-yosemite-r5-0016', 02:41:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:28 INFO - 'use_talos_json': True, 02:41:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:41:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:28 INFO - 'work_dir': 'build'} 02:41:28 INFO - ##### 02:41:28 INFO - ##### Running clobber step. 02:41:28 INFO - ##### 02:41:28 INFO - Running pre-action listener: _resource_record_pre_action 02:41:28 INFO - Running main action method: clobber 02:41:28 INFO - rmtree: /builds/slave/test/build 02:41:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:32 INFO - Running post-action listener: _resource_record_post_action 02:41:32 INFO - ##### 02:41:32 INFO - ##### Running read-buildbot-config step. 02:41:32 INFO - ##### 02:41:32 INFO - Running pre-action listener: _resource_record_pre_action 02:41:32 INFO - Running main action method: read_buildbot_config 02:41:32 INFO - Using buildbot properties: 02:41:32 INFO - { 02:41:32 INFO - "properties": { 02:41:32 INFO - "buildnumber": 432, 02:41:32 INFO - "product": "firefox", 02:41:32 INFO - "script_repo_revision": "production", 02:41:32 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:41:32 INFO - "repository": "", 02:41:32 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:41:32 INFO - "buildid": "20151121004041", 02:41:32 INFO - "slavename": "t-yosemite-r5-0016", 02:41:32 INFO - "stage_platform": "macosx64", 02:41:32 INFO - "basedir": "/builds/slave/test", 02:41:32 INFO - "nightly_build": "True", 02:41:32 INFO - "project": "", 02:41:32 INFO - "platform": "yosemite", 02:41:32 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:41:32 INFO - "slavebuilddir": "test", 02:41:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:41:32 INFO - "branch": "mozilla-aurora", 02:41:32 INFO - "repo_path": "releases/mozilla-aurora", 02:41:32 INFO - "pgo_build": "False", 02:41:32 INFO - "builduid": "9029a10527914c5c9d28660cf3a6f1fd", 02:41:32 INFO - "revision": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa" 02:41:32 INFO - }, 02:41:32 INFO - "sourcestamp": { 02:41:32 INFO - "repository": "", 02:41:32 INFO - "hasPatch": false, 02:41:32 INFO - "project": "", 02:41:32 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:41:32 INFO - "changes": [ 02:41:32 INFO - { 02:41:32 INFO - "category": null, 02:41:32 INFO - "files": [ 02:41:32 INFO - { 02:41:32 INFO - "url": null, 02:41:32 INFO - "name": "https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:41:32 INFO - } 02:41:32 INFO - ], 02:41:32 INFO - "repository": "", 02:41:32 INFO - "rev": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa", 02:41:32 INFO - "who": "sendchange", 02:41:32 INFO - "when": 1448102470, 02:41:32 INFO - "number": 6692183, 02:41:32 INFO - "comments": "", 02:41:32 INFO - "project": "", 02:41:32 INFO - "at": "Sat 21 Nov 2015 02:41:10", 02:41:32 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:41:32 INFO - "revlink": "", 02:41:32 INFO - "properties": [ 02:41:32 INFO - [ 02:41:32 INFO - "buildid", 02:41:32 INFO - "20151121004041", 02:41:32 INFO - "Change" 02:41:32 INFO - ], 02:41:32 INFO - [ 02:41:32 INFO - "builduid", 02:41:32 INFO - "9029a10527914c5c9d28660cf3a6f1fd", 02:41:32 INFO - "Change" 02:41:32 INFO - ], 02:41:32 INFO - [ 02:41:32 INFO - "nightly_build", 02:41:32 INFO - "True", 02:41:32 INFO - "Change" 02:41:32 INFO - ], 02:41:32 INFO - [ 02:41:32 INFO - "pgo_build", 02:41:32 INFO - "False", 02:41:32 INFO - "Change" 02:41:32 INFO - ] 02:41:32 INFO - ], 02:41:32 INFO - "revision": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa" 02:41:32 INFO - } 02:41:32 INFO - ], 02:41:32 INFO - "revision": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa" 02:41:32 INFO - } 02:41:32 INFO - } 02:41:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:41:32 INFO - Running post-action listener: _resource_record_post_action 02:41:32 INFO - ##### 02:41:32 INFO - ##### Running download-and-extract step. 02:41:32 INFO - ##### 02:41:32 INFO - Running pre-action listener: _resource_record_pre_action 02:41:32 INFO - Running main action method: download_and_extract 02:41:32 INFO - mkdir: /builds/slave/test/build/tests 02:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:32 INFO - https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:41:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json 02:41:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json 02:41:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:42:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json: timed out 02:42:02 INFO - retry: attempt #1 caught exception: timed out 02:42:02 INFO - retry: Failed, sleeping 30 seconds before retrying 02:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 02:42:33 INFO - Downloaded 1149 bytes. 02:42:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:42:33 INFO - Using the following test package requirements: 02:42:33 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:42:33 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:42:33 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'jsshell-mac.zip'], 02:42:33 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:42:33 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:42:33 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:42:33 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:42:33 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:42:33 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:42:33 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:42:33 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:42:33 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:33 INFO - https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:42:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:42:34 INFO - Downloaded 17448089 bytes. 02:42:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:42:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:42:39 INFO - Return code: 0 02:42:39 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:39 INFO - https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:42:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:42:41 INFO - Downloaded 17448089 bytes. 02:42:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:42:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:42:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:42:46 INFO - Return code: 0 02:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:46 INFO - https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:42:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:42:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:42:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:42:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:42:47 INFO - Downloaded 11131307 bytes. 02:42:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:42:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:42:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:42:48 INFO - Return code: 0 02:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:48 INFO - https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:42:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:42:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:42:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:42:51 INFO - Downloaded 107767448 bytes. 02:42:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:42:51 INFO - mkdir: /builds/slave/test/properties 02:42:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:42:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:42:51 INFO - Contents: 02:42:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:42:51 INFO - Running post-action listener: _resource_record_post_action 02:42:51 INFO - Running post-action listener: set_extra_try_arguments 02:42:51 INFO - ##### 02:42:51 INFO - ##### Running populate-webroot step. 02:42:51 INFO - ##### 02:42:51 INFO - Running pre-action listener: _resource_record_pre_action 02:42:51 INFO - Running main action method: populate_webroot 02:42:51 INFO - Guessing talos json url... 02:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:51 INFO - https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:42:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:42:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:42:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:42:51 INFO - Downloaded 107 bytes. 02:42:51 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:42:51 INFO - Contents: 02:42:51 INFO - 20151121004041 02:42:51 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa 02:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:51 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1802aa83ee/testing/talos/talos.json 02:42:51 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1802aa83ee/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1802aa83ee/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:42:52 INFO - Downloaded 4264 bytes. 02:42:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:42:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:42:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:42:52 INFO - '../fennec_ids.txt'], 02:42:52 INFO - 'tests': ['tcheck2']}, 02:42:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:42:52 INFO - '--tppagecycles', 02:42:52 INFO - '7'], 02:42:52 INFO - 'tests': ['tsvgm']}}, 02:42:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:42:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:42:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:42:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:42:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'tests': ['damp', 'tps']}, 02:42:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['damp', 'tps']}, 02:42:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:42:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:42:52 INFO - 'other': {'tests': ['a11yr', 02:42:52 INFO - 'ts_paint', 02:42:52 INFO - 'tpaint', 02:42:52 INFO - 'sessionrestore', 02:42:52 INFO - 'sessionrestore_no_auto_restore']}, 02:42:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['a11yr', 02:42:52 INFO - 'ts_paint', 02:42:52 INFO - 'tpaint', 02:42:52 INFO - 'sessionrestore', 02:42:52 INFO - 'sessionrestore_no_auto_restore']}, 02:42:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['a11yr', 02:42:52 INFO - 'ts_paint', 02:42:52 INFO - 'tpaint', 02:42:52 INFO - 'sessionrestore', 02:42:52 INFO - 'sessionrestore_no_auto_restore']}, 02:42:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['a11yr', 02:42:52 INFO - 'ts_paint', 02:42:52 INFO - 'tpaint', 02:42:52 INFO - 'sessionrestore', 02:42:52 INFO - 'sessionrestore_no_auto_restore']}, 02:42:52 INFO - 'other_l64': {'tests': ['a11yr', 02:42:52 INFO - 'ts_paint', 02:42:52 INFO - 'tpaint', 02:42:52 INFO - 'sessionrestore', 02:42:52 INFO - 'sessionrestore_no_auto_restore']}, 02:42:52 INFO - 'other_nol64': {'tests': ['a11yr', 02:42:52 INFO - 'ts_paint', 02:42:52 INFO - 'tpaint', 02:42:52 INFO - 'sessionrestore', 02:42:52 INFO - 'sessionrestore_no_auto_restore']}, 02:42:52 INFO - 'svgr': {'tests': ['tsvgx', 02:42:52 INFO - 'tsvgr_opacity', 02:42:52 INFO - 'tart', 02:42:52 INFO - 'tscrollx', 02:42:52 INFO - 'cart']}, 02:42:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['tsvgx', 02:42:52 INFO - 'tsvgr_opacity', 02:42:52 INFO - 'tart', 02:42:52 INFO - 'tscrollx', 02:42:52 INFO - 'cart']}, 02:42:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'tests': ['tp5o']}, 02:42:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'talos_options': ['--e10s'], 02:42:52 INFO - 'tests': ['tp5o']}, 02:42:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'talos_options': ['--xperf_path', 02:42:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:52 INFO - 'tests': ['tp5n']}, 02:42:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:52 INFO - 'talos_options': ['--e10s', 02:42:52 INFO - '--xperf_path', 02:42:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:42:52 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:42:52 INFO - 'tests': ['tp5n']}}, 02:42:52 INFO - 'talos.zip': {'path': '', 02:42:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:42:52 INFO - Running post-action listener: _resource_record_post_action 02:42:52 INFO - ##### 02:42:52 INFO - ##### Running create-virtualenv step. 02:42:52 INFO - ##### 02:42:52 INFO - Running pre-action listener: _resource_record_pre_action 02:42:52 INFO - Running main action method: create_virtualenv 02:42:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:42:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:42:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:42:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:42:52 INFO - Using real prefix '/tools/python27' 02:42:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:42:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:42:56 INFO - Installing pip.................done. 02:42:56 INFO - Return code: 0 02:42:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:56 INFO - 'HOME': '/Users/cltbld', 02:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:56 INFO - 'LOGNAME': 'cltbld', 02:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:56 INFO - 'MOZ_NO_REMOTE': '1', 02:42:56 INFO - 'NO_EM_RESTART': '1', 02:42:56 INFO - 'PAGER': '/bin/cat', 02:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:56 INFO - 'PWD': '/builds/slave/test', 02:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:56 INFO - 'SHELL': '/bin/bash', 02:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:42:56 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:56 INFO - 'USER': 'cltbld', 02:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:56 INFO - 'XPC_FLAGS': '0x0', 02:42:56 INFO - 'XPC_SERVICE_NAME': '0', 02:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:42:57 INFO - Cleaning up... 02:42:57 INFO - Return code: 0 02:42:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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', '--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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:42:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:57 INFO - 'HOME': '/Users/cltbld', 02:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:57 INFO - 'LOGNAME': 'cltbld', 02:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:57 INFO - 'MOZ_NO_REMOTE': '1', 02:42:57 INFO - 'NO_EM_RESTART': '1', 02:42:57 INFO - 'PAGER': '/bin/cat', 02:42:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:57 INFO - 'PWD': '/builds/slave/test', 02:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:57 INFO - 'SHELL': '/bin/bash', 02:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:42:57 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:57 INFO - 'USER': 'cltbld', 02:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:57 INFO - 'XPC_FLAGS': '0x0', 02:42:57 INFO - 'XPC_SERVICE_NAME': '0', 02:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:57 INFO - Downloading/unpacking psutil>=0.7.1 02:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:43:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:00 INFO - Installing collected packages: psutil 02:43:00 INFO - Running setup.py install for psutil 02:43:00 INFO - building 'psutil._psutil_osx' extension 02:43:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:43:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:43:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:43:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:43:02 INFO - building 'psutil._psutil_posix' extension 02:43:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:43:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:43:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:43:02 INFO - ^ 02:43:02 INFO - 1 warning generated. 02:43:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:03 INFO - Successfully installed psutil 02:43:03 INFO - Cleaning up... 02:43:03 INFO - Return code: 0 02:43:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:03 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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:03 INFO - 'HOME': '/Users/cltbld', 02:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:03 INFO - 'LOGNAME': 'cltbld', 02:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:03 INFO - 'MOZ_NO_REMOTE': '1', 02:43:03 INFO - 'NO_EM_RESTART': '1', 02:43:03 INFO - 'PAGER': '/bin/cat', 02:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:03 INFO - 'PWD': '/builds/slave/test', 02:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:03 INFO - 'SHELL': '/bin/bash', 02:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:43:03 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:03 INFO - 'USER': 'cltbld', 02:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:03 INFO - 'XPC_FLAGS': '0x0', 02:43:03 INFO - 'XPC_SERVICE_NAME': '0', 02:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:43:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:43:05 INFO - Installing collected packages: mozsystemmonitor 02:43:05 INFO - Running setup.py install for mozsystemmonitor 02:43:06 INFO - Successfully installed mozsystemmonitor 02:43:06 INFO - Cleaning up... 02:43:06 INFO - Return code: 0 02:43:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:06 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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:06 INFO - 'HOME': '/Users/cltbld', 02:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:06 INFO - 'LOGNAME': 'cltbld', 02:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:06 INFO - 'MOZ_NO_REMOTE': '1', 02:43:06 INFO - 'NO_EM_RESTART': '1', 02:43:06 INFO - 'PAGER': '/bin/cat', 02:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:06 INFO - 'PWD': '/builds/slave/test', 02:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:06 INFO - 'SHELL': '/bin/bash', 02:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:43:06 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:06 INFO - 'USER': 'cltbld', 02:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:06 INFO - 'XPC_FLAGS': '0x0', 02:43:06 INFO - 'XPC_SERVICE_NAME': '0', 02:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:06 INFO - Downloading/unpacking blobuploader==1.2.4 02:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:43:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:43:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:43:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:10 INFO - Downloading docopt-0.6.1.tar.gz 02:43:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:43:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:43:10 INFO - Running setup.py install for blobuploader 02:43:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:43:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:43:10 INFO - Running setup.py install for requests 02:43:10 INFO - Running setup.py install for docopt 02:43:11 INFO - Successfully installed blobuploader requests docopt 02:43:11 INFO - Cleaning up... 02:43:11 INFO - Return code: 0 02:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:11 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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:11 INFO - 'HOME': '/Users/cltbld', 02:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:11 INFO - 'LOGNAME': 'cltbld', 02:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:11 INFO - 'MOZ_NO_REMOTE': '1', 02:43:11 INFO - 'NO_EM_RESTART': '1', 02:43:11 INFO - 'PAGER': '/bin/cat', 02:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:11 INFO - 'PWD': '/builds/slave/test', 02:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:11 INFO - 'SHELL': '/bin/bash', 02:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:43:11 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:11 INFO - 'USER': 'cltbld', 02:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:11 INFO - 'XPC_FLAGS': '0x0', 02:43:11 INFO - 'XPC_SERVICE_NAME': '0', 02:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:11 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-ZVE6aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:11 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-HauTGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:43:11 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-BjMJHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:43:11 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-YNOmIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:43:11 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-VMCOaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-FaVoDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-sA2MBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-nSaAFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-50hQzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-Y1MLpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-hl9Ggs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-5mWntL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:43:12 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-yNPc7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:43:13 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-yS27PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:13 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-j0r6zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:43:13 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-PCQBsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:43:13 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-ZBVsRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:43:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:43:13 INFO - Running setup.py install for manifestparser 02:43:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:43:13 INFO - Running setup.py install for mozcrash 02:43:13 INFO - Running setup.py install for mozdebug 02:43:14 INFO - Running setup.py install for mozdevice 02:43:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Running setup.py install for mozfile 02:43:14 INFO - Running setup.py install for mozhttpd 02:43:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Running setup.py install for mozinfo 02:43:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Running setup.py install for mozInstall 02:43:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:43:14 INFO - Running setup.py install for mozleak 02:43:15 INFO - Running setup.py install for mozlog 02:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:43:15 INFO - Running setup.py install for moznetwork 02:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:43:15 INFO - Running setup.py install for mozprocess 02:43:15 INFO - Running setup.py install for mozprofile 02:43:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:43:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:43:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:43:15 INFO - Running setup.py install for mozrunner 02:43:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:43:15 INFO - Running setup.py install for mozscreenshot 02:43:16 INFO - Running setup.py install for moztest 02:43:16 INFO - Running setup.py install for mozversion 02:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:43:16 INFO - Cleaning up... 02:43:16 INFO - Return code: 0 02:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:16 INFO - 'HOME': '/Users/cltbld', 02:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:16 INFO - 'LOGNAME': 'cltbld', 02:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:16 INFO - 'MOZ_NO_REMOTE': '1', 02:43:16 INFO - 'NO_EM_RESTART': '1', 02:43:16 INFO - 'PAGER': '/bin/cat', 02:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:16 INFO - 'PWD': '/builds/slave/test', 02:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:16 INFO - 'SHELL': '/bin/bash', 02:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:43:16 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:16 INFO - 'USER': 'cltbld', 02:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:16 INFO - 'XPC_FLAGS': '0x0', 02:43:16 INFO - 'XPC_SERVICE_NAME': '0', 02:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:16 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-PFEdgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:16 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-j7gBOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-uAw9Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-yqR7Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-YYbn5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-W5U1cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-q0s4s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-3iTv_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-cs3PN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:43:17 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-guKbm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-7yQ91C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-ojK4Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-2tEBnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-cQJbvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-HqfvrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-okwX79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:43:18 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-uZhHko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:43:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:21 INFO - Downloading blessings-1.5.1.tar.gz 02:43:21 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:43:21 INFO - Installing collected packages: blessings 02:43:21 INFO - Running setup.py install for blessings 02:43:21 INFO - Successfully installed blessings 02:43:21 INFO - Cleaning up... 02:43:21 INFO - Return code: 0 02:43:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:43:21 INFO - Reading from file tmpfile_stdout 02:43:21 INFO - Current package versions: 02:43:21 INFO - blessings == 1.5.1 02:43:21 INFO - blobuploader == 1.2.4 02:43:21 INFO - docopt == 0.6.1 02:43:21 INFO - manifestparser == 1.1 02:43:21 INFO - mozInstall == 1.12 02:43:21 INFO - mozcrash == 0.16 02:43:21 INFO - mozdebug == 0.1 02:43:21 INFO - mozdevice == 0.46 02:43:21 INFO - mozfile == 1.2 02:43:21 INFO - mozhttpd == 0.7 02:43:21 INFO - mozinfo == 0.8 02:43:21 INFO - mozleak == 0.1 02:43:21 INFO - mozlog == 3.0 02:43:21 INFO - moznetwork == 0.27 02:43:21 INFO - mozprocess == 0.22 02:43:21 INFO - mozprofile == 0.27 02:43:21 INFO - mozrunner == 6.11 02:43:21 INFO - mozscreenshot == 0.1 02:43:21 INFO - mozsystemmonitor == 0.0 02:43:21 INFO - moztest == 0.7 02:43:21 INFO - mozversion == 1.4 02:43:21 INFO - psutil == 3.1.1 02:43:21 INFO - requests == 1.2.3 02:43:21 INFO - wsgiref == 0.1.2 02:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43: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')]} 02:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43: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')]} 02:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:21 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 0x10567ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa212c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, '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.YSKLOq0NWo/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.50LMgSfZrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:21 INFO - 'HOME': '/Users/cltbld', 02:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:21 INFO - 'LOGNAME': 'cltbld', 02:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:21 INFO - 'MOZ_NO_REMOTE': '1', 02:43:21 INFO - 'NO_EM_RESTART': '1', 02:43:21 INFO - 'PAGER': '/bin/cat', 02:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:21 INFO - 'PWD': '/builds/slave/test', 02:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:21 INFO - 'SHELL': '/bin/bash', 02:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:43:21 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:21 INFO - 'USER': 'cltbld', 02:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:21 INFO - 'XPC_FLAGS': '0x0', 02:43:21 INFO - 'XPC_SERVICE_NAME': '0', 02:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:43:22 INFO - Cleaning up... 02:43:22 INFO - Return code: 0 02:43:22 INFO - Running post-action listener: _resource_record_post_action 02:43:22 INFO - Running post-action listener: _start_resource_monitoring 02:43:22 INFO - Starting resource monitoring. 02:43:22 INFO - ##### 02:43:22 INFO - ##### Running install step. 02:43:22 INFO - ##### 02:43:22 INFO - Running pre-action listener: _resource_record_pre_action 02:43:22 INFO - Running main action method: install 02:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:43:22 INFO - Reading from file tmpfile_stdout 02:43:22 INFO - Detecting whether we're running mozinstall >=1.0... 02:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:43:22 INFO - Reading from file tmpfile_stdout 02:43:22 INFO - Output received: 02:43:22 INFO - Usage: mozinstall [options] installer 02:43:22 INFO - Options: 02:43:22 INFO - -h, --help show this help message and exit 02:43:22 INFO - -d DEST, --destination=DEST 02:43:22 INFO - Directory to install application into. [default: 02:43:22 INFO - "/builds/slave/test"] 02:43:22 INFO - --app=APP Application being installed. [default: firefox] 02:43:22 INFO - mkdir: /builds/slave/test/build/application 02:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:43:59 INFO - Reading from file tmpfile_stdout 02:43:59 INFO - Output received: 02:43:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:43:59 INFO - Running post-action listener: _resource_record_post_action 02:43:59 INFO - ##### 02:43:59 INFO - ##### Running run-tests step. 02:43:59 INFO - ##### 02:43:59 INFO - Running pre-action listener: _resource_record_pre_action 02:43:59 INFO - Running main action method: run_tests 02:43:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:43:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:43:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:43:59 INFO - 2015-11-21 02:43:59.728 screenresolution[1639:9177] starting screenresolution argv=screenresolution get 02:43:59 INFO - 2015-11-21 02:43:59.731 screenresolution[1639:9177] Display 0: 1600x1200x32@60 02:43:59 INFO - 2015-11-21 02:43:59.737 screenresolution[1640:9179] starting screenresolution argv=screenresolution list 02:43:59 INFO - Available Modes on Display 0 02:43:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:43:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:43:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:43:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:43:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:43:59 INFO - Intel HD Graphics 3000: 02:43:59 INFO - Chipset Model: Intel HD Graphics 3000 02:43:59 INFO - Type: GPU 02:43:59 INFO - Bus: Built-In 02:43:59 INFO - VRAM (Total): 512 MB 02:43:59 INFO - VRAM (Dynamic, Max): 10 02:43:59 INFO - Vendor: Intel (0x8086) 02:43:59 INFO - Device ID: 0x0116 02:43:59 INFO - Revision ID: 0x0009 02:43:59 INFO - Displays: 02:43:59 INFO - Display: 02:43:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:43:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:43:59 INFO - Display Serial Number: 1600x1200 60 02:43:59 INFO - Main Display: Yes 02:43:59 INFO - Mirror: Off 02:43:59 INFO - Online: Yes 02:43:59 INFO - Rotation: Supported 02:44:00 INFO - Return code: 0 02:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:44:00 INFO - Python 2.7.3 02:44:00 INFO - Return code: 0 02:44:00 INFO - grabbing minidump binary from tooltool 02:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:00 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 0x1056319f0>, '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 0x105390cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fb990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:44:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:44:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:44:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:44:00 INFO - Return code: 0 02:44:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:44:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:44:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:44:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:44:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:44:00 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/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0016', '--webServer', 'localhost'] in /builds/slave/test/build 02:44:00 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/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0016 --webServer localhost 02:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YSKLOq0NWo/Render', 02:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:00 INFO - 'HOME': '/Users/cltbld', 02:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:00 INFO - 'LOGNAME': 'cltbld', 02:44:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:44:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:00 INFO - 'MOZ_NO_REMOTE': '1', 02:44:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:44:00 INFO - 'NO_EM_RESTART': '1', 02:44:00 INFO - 'PAGER': '/bin/cat', 02:44:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:00 INFO - 'PWD': '/builds/slave/test', 02:44:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:00 INFO - 'SHELL': '/bin/bash', 02:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.50LMgSfZrg/Listeners', 02:44:00 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 02:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:00 INFO - 'USER': 'cltbld', 02:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:00 INFO - 'XPC_FLAGS': '0x0', 02:44:00 INFO - 'XPC_SERVICE_NAME': '0', 02:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:44:00 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/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0016', '--webServer', 'localhost'] with output_timeout 3600 02:44:00 INFO - mozversion INFO | application_buildid: 20151121004041 02:44:00 INFO - mozversion INFO | application_changeset: 1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa 02:44:00 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:44:00 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:44:00 INFO - mozversion INFO | application_name: Firefox 02:44:00 INFO - mozversion INFO | application_remotingname: firefox-dev 02:44:00 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:44:00 INFO - mozversion INFO | application_vendor: Mozilla 02:44:00 INFO - mozversion INFO | application_version: 44.0a2 02:44:00 INFO - mozversion INFO | platform_buildid: 20151121004041 02:44:00 INFO - mozversion INFO | platform_changeset: 1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa 02:44:00 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:44:00 INFO - mozversion INFO | platform_version: 44.0a2 02:44:00 INFO - 2015-11-21 02:44:00,477 DEBUG : using testdate: 1448102640 02:44:00 INFO - 2015-11-21 02:44:00,477 DEBUG : actual date: 1448102640 02:44:00 INFO - 2015-11-21 02:44:00,486 INFO : starting webserver on 'localhost:49271' 02:44:00 INFO - 2015-11-21 02:44:00,487 INFO : Starting test suite t-yosemite-r5-0016 02:44:00 INFO - 2015-11-21 02:44:00,487 INFO : Starting test dromaeo_css 02:44:00 INFO - 2015-11-21 02:44:00,487 DEBUG : operating with platform_type : mac_ 02:44:00 INFO - 2015-11-21 02:44:00,488 INFO : Initialising browser for dromaeo_css test... 02:44:00 INFO - 2015-11-21 02:44:00,502 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpacpJPH/profile http://localhost:49271/getInfo.html 02:44:03 INFO - 2015-11-21 02:44:03,528 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:44:03 INFO - 2015-11-21 02:44:03,528 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:44:03 INFO - 2015-11-21 02:44:03,528 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:44:03 INFO - 2015-11-21 02:44:03,528 DEBUG : BROWSER_OUTPUT: __metrics 02:44:03 INFO - 2015-11-21 02:44:03,547 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:44:04 INFO - 2015-11-21 02:44:04,242 INFO : Browser initialized. 02:44:04 INFO - 2015-11-21 02:44:04,243 INFO : Running cycle 1/1 for dromaeo_css test... 02:44:04 INFO - 2015-11-21 02:44:04,243 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpacpJPH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:44:16 INFO - 2015-11-21 02:44:16,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 199307264 02:44:16 INFO - 2015-11-21 02:44:16,140 DEBUG : BROWSER_OUTPUT: 02:45:07 INFO - 2015-11-21 02:45:07,998 DEBUG : BROWSER_OUTPUT: 1448102707994 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:47:18 INFO - 2015-11-21 02:47:18,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 02:47:19 INFO - 2015-11-21 02:47:19,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 307380224 02:47:19 INFO - 2015-11-21 02:47:19,635 DEBUG : BROWSER_OUTPUT: 02:50:22 INFO - 2015-11-21 02:50:22,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 02:50:22 INFO - 2015-11-21 02:50:22,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 344776704 02:50:22 INFO - 2015-11-21 02:50:22,752 DEBUG : BROWSER_OUTPUT: 02:53:24 INFO - 2015-11-21 02:53:24,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 02:53:25 INFO - 2015-11-21 02:53:25,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 315494400 02:53:25 INFO - 2015-11-21 02:53:25,468 DEBUG : BROWSER_OUTPUT: 02:56:27 INFO - 2015-11-21 02:56:27,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 02:56:27 INFO - 2015-11-21 02:56:27,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 301957120 02:56:27 INFO - 2015-11-21 02:56:27,976 DEBUG : BROWSER_OUTPUT: 02:59:30 INFO - 2015-11-21 02:59:30,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 02:59:31 INFO - 2015-11-21 02:59:31,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 303824896 02:59:31 INFO - 2015-11-21 02:59:31,527 DEBUG : BROWSER_OUTPUT: 03:02:33 INFO - 2015-11-21 03:02:33,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 03:02:34 INFO - 2015-11-21 03:02:34,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 348565504 03:02:34 INFO - 2015-11-21 03:02:34,094 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,095 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:02:34 INFO - 2015-11-21 03:02:34,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:02:34 INFO - 2015-11-21 03:02:34,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:02:34 INFO - 2015-11-21 03:02:34,095 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:02:34 INFO - 2015-11-21 03:02:34,099 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3219.323941972186;3224.3228921926393;3273.3126043530874;3283.3433313337323;3306.12387717255;5335.839924802252;5361.222622719703;5363.168708850125;5364.624476286662;5373.838784836456;5280.867978300545;5314.043472175007;5321.893562128756;5355.866103347418;5384.542313903323;4943.085529177114;4950.603951683875;5010.874728131789;5018.272350509174;5071.898562028758;4956.231784073457;4971.229459433794;5008.148614735485;5030.195168772997;5047.066292735837;5108.259302401149;5137.486251374851;5148.0476111919415;5162.174052151657;5173.275741396207;4837.129316722989;5063.544281014726;5095.210242412432;5102.566281866046;5136.845894623168;4876.731779752112;4971.45314015458;4986.626003049786;5000.1999680051385;5016.849494515171;5248.685078895241;5309.973450132763;5359.3032905722;5403.135498320289;5419.620626556142;5360.249565060894;5450.345958484968;5740.741666625012;5755.654660720328;5816.651000939914;5635.943640563582;5699.145128230757;5714.285714285715;5728.054870946289;5761.251037365158;5408.134698448269;5429.8099566515775;5435.239066530688;5436.728163591844;5438.782448702087;5600.747966341524;5716.971415142898;5796.8550786229835;5910;5940.257467816523;5329.227262047059;5419.756110975016;5498.422665620053;5504.532114770209;5532.419095994943;5707.0583353747;5756.510696590753;5777.913331300034;5782.971085144547;5783.248177736951;5407.242985981966;5525.198846167284;5564.137558678412;5644.97177514118;5717;5451.3458384994055;5498.285222920995;5585.636933599303;5604.159376093618;5633.8309850704545;4412.977935110304;4449.555044495524;4451.532589078165;4460.442444694413;4467.30756732707;3969.702272329587;4039.5152581690386;4045.8179381927885;4046.393041043867;4091.1408604192857;5234.555062819627;5285.709285989307;5322.2548843161985;5342.1185504392115;5362.51737343641;5676;5693.743781529841;5724.341700704473;5755.050416681284;5756.769729210785;5146;5190.506901844319;5223.373195216598;5232;5310.840674779763;4841.588464980446;4938.037082768898;4953.356063711694;4954.826581069718;4976.253561965734;5798.275215598051;5800.796972105956;5883.852903677443;5889.23439952812;5894.0274854648505;5460.31746031746;5558.944410555842;5574.693391863487;5762.4525670061275;5785.27684039495;5784.2769653793275;5847.06446968483;5860.179574859609;5861.589688721919;5881.088431293157;5712.485876271156;5713.628614140068;5723.627964182481;5732.512736417451;5791.247137872049;5323.201519772065;5350.143976963667;5437.265969094122;5808.332041815245;5867.794627188028;5389.407165211745;5399.78400863961;5470.507654311131;5497.587680924026;5506.256655351476;5510.972445137749;5555.3333599966645;5575.080111781511;5604.159376093618;5605.5515558756015;5250.789968401221;5351.9464805351445;5357.946420535744;5437;5456;5403.594730395157;5467.07059799827;5546.36216835053;5550.250716153268;5574.358948720786;5303.761330740203;5401.540869026177;5500.339959204761;5525.613207075627;5530.7511161997 03:02:34 INFO - 2015-11-21 03:02:34,100 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.3583896438578;560.7112337146369;566.8384510414531;577.2697537614918;577.8728679690472;32426.18934526635;33022;39410.408843867364;39435.80282098585;39883.20233595326;41529.37705934406;42329.788351058276;42800.14399712004;43216.13567728644;43239;8412.537310447922;9005.45967241966;9091.727248182566;9111.088891110901;9221.538923053855;8501.787455313635;10799.83800242997;10935.398553079578;10997.780044399107;11058.557657693682;10650.946745266263;10658.520366583483;10701.83947240792;10789.352638841694;10800.081993030602;7529.247075292427;8824.117588241188;10693.358398496077;10965.725856853564;11051.613193538227;10594.788104237949;10748.193885458622;10825.729356766065;10831.783364332749;10848.728781780439;39559.60440395588;39771.8011409944;40161.39757903634;40214.59785402138;40293.59706402928;2977.836219007954;3063.6936306369407;3109.70457806508;3431.9485207721905;3611.404118320474;26910.73089269102;27944;27950.860245698845;28224.717752822413;28884.8555757222;2353.646952957053;2359.893804778789;2428.854268743881;2503.0613519930025;2508.5735424977797;280477;281974;284674;286287;406984.9650751757;49889.75055124774;61271.38728612746;62420;62425.68787156035;62468.37531624625;57216.71391643015;57745.422545774;57811.421885780604;57831.71084144552;58353;16486.917565412336;16524;16823.831761682228;16864.241109150116;16907.070111144007;13328.733425331438;13435.19388836673;13662.385192666354;13680.110792798436;13782.379792909143;18564.164612592194;19528.049733463926;19628.70556941647;19668.40994770159;19794.40616781499;7844.254795794391;8011.959940200379;8032.919670803334;8051.838963220703;8089.757307280674;905.8505346617734;906.3519583497831;921.3780698028804;924.408378637659;942.561708805395;27270.727292727217;27288.181354559394;27310.180694579194;27582.44835103327;27853.442931141668;959.2182371367453;961.2838435365558;1072.973175670599;1096.9725756855983;1162.581470670558;11227.38249396291;14483.068624513162;14781.26093695311;14886.404543818342;14901.701965960838;314237;317905;318276;318371;320460;50371.24443133356;51946.740266298424;52287.47712522902;52716.20925686118;52879.20681189785;1408.9577312680635;1409.1615488784157;1415.6036309833264;1421.2609443089536;1422.395481920159;23518;26423.207303780917;26927.461450771265;27691.861540692167;28136.29659258453;51264.23103653523;51786.741066294424;51911;51954.74022629863;52054.479455204964;257464;259458;259915;260278;261328;32391.676083238865;32749.50875736818;32821.507677385336;32960.340793184485;33280.00159995204;42323.57676423196;42484.36273455839;43691.56308436875;43870.56129438665;43912.121757565306;35259;36137;36193.63806361903;36462.63537364592;36892.155392229746;35513.644863552065;35939.46090808692;36212.818935905154;36222.45666314955;36383.45424818683;36091.45862812112;37019.44470832994;37399.252014959005;37443.6255637451;37531.62468375391;30254.697453025186;32357.676423236408;32474.188145296557;32514;32596.34807303793;24225.51548969046;24295.149669761475;24535.631965520173;24556.877215613807;24561.63157552674 03:02:34 INFO - 2015-11-21 03:02:34,101 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.7759872480975;355.27878406834134;356.0866377741094;359.92621512589915;360.18418282589937;14718.116912985228;14976.550703478886;17373.218205180765;17947.730784038235;18836.717449238273;11877.406129693523;12186.02511799056;15306.311215995307;18247.270109195615;18526.81473185268;4448.11037792442;4500.797464114123;4519.7740112994215;4563.201439748047;4576.4737055238575;3483.372992861284;3689.8339574719066;4360.28055370865;4437.267850804614;4714.552117548845;4770.332153498513;4784.138855006097;4790.257510085925;4823.20417131173;4825.734584597846;4495.235809912323;4564.748938808364;4752.002079563313;4804.303376010494;4813.807447702087;4023.5976402359825;4039.272930872442;4099.118689481776;4125.814338354781;4126.42230087788;13175.934120329433;13351.799723004162;13408.46366145353;13435.596932092052;13617.795733064011;1867.953301167468;1883.3314173468495;1958.3733205374144;1992.7816576229286;2012.667909794882;9389;9523.238140948708;9526.761830954212;9644.469554174517;9692.75768105796;1511.9697606047816;1521.4903007492503;1530.9770353444596;1560.5084398414576;1608.750643650236;58787;59932.400675993114;60234.09648855271;60875.39124608786;61121.38878611202;6657.234418041987;6662;6680;6680.665966701646;6703.597784132968;7648.579328137006;7697.6151192441275;7716.344110750537;7744.961275193588;7767.106782719947;5275.076861549213;5286.60350473716;5489.945100548944;5695.800646977336;5713.342965558931;6101.877962440726;6105.145279660851;6122.755089796358;6173.197484327009;6186.381361863868;2977.5980242667397;2985.671576126624;2993.5659329397117;2996.460637085302;3023.7883348165856;1035.8549803027581;1046.7697106636529;1067.3755852826184;1083.0523292119397;1108.6784832398675;426.10517912384364;431.58567774935784;458.51397518629693;460.28885372100183;479.79608666316676;10467.476626168662;11574.131940104357;11582.131340149353;12147.757044859054;12202.633920982385;446.9195544801902;451.1405772004337;455.8769132334251;457.8557754307383;469.1414711078718;5220.425753167148;6327.651979141099;6437.259715132726;6525.2169739631545;6535.183102112236;569562;573616;583558;584703;585118;68548;71946.64026679833;72209;72433.6378318105;74286;487.2483422097554;491.5134017322825;494.9752512374367;495.60351718624236;496.990060198794;10430.947845260725;11036.448177591248;11120.165987550805;11134.27627204229;11149.108071354434;33186.17034574155;33332.33335333231;33357;33847;34323.828380857936;43672.56327436812;44410;44444.777776112205;47838.76080619574;48847.5115248843;6210.441060304413;6358.682065896779;6447.451966582706;6530.869382612416;6539.476841852736;11358.54565817358;11770.411479426166;11813.881861181279;11814.82277765817;12033.097517686034;9797.461139637104;10186.847197292194;10219.335743176669;10272.22958278147;10362.171026318027;9732.659356922473;9778.85331720039;9889.901100989186;9952.850707239253;10193.643222487473;9101.453912765255;9413.670521531987;10120.949395252977;10566.630167944393;10783.245172837826;6220.533459990609;6426.614403135827;6429.38920802523;6507.381798729113;6540;9916.553755081182;10223.948880255848;10335.328203666737;10411.219158562986;10412.68761937143 03:02:34 INFO - 2015-11-21 03:02:34,105 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1336.9866301336997;1496.8952173347864;1546.8143822741272;1657;1831.4505648305505;6923.515353925227;7564.432667549928;7706.845863082735;7745.225477452252;7764.96117519413;7533.84932301355;7754.495957762756;7771.145174030867;7771.261730135628;7931.405144614148;2218.7892150245743;2234.6312858378346;2244.494988627562;2256.6727824465524;2256.875871827057;2270.375646697155;2293.243229734192;2305.7578954209816;2321.907123715058;2324.732655744594;2208.712867327245;2210.10490751246;2221.9333419997424;2222.5332680137108;2248.15694114707;2187.3656639574506;2195.6047911375945;2223.566404551113;2235.508188198602;2248.303026061926;2240.7199100112484;2249.4713742270555;2262.2760716570706;2267.172482044042;2270;6973.546719463218;7019.92980070203;7605.505642133299;7633.618319084079;7738.535687858746;4508.887277818048;4620.330052142454;4623.214053610895;4626.86119416418;4638.744869032202;2796.6084748135277;2809.6487939007625;2834.6031555582235;2854.200823769348;2927.209653393572;835.3943391041507;860.4450129666393;863.2748491267365;884.4914174349775;886.8403687336277;10289.382637041801;10299.485025748758;10373.429461379621;10380.273380863267;10474.947625261824;4276.5295817460055;4283.635890949305;4326.437563116775;4339.1104823511105;4351.412559304516;8991.14584114508;9027.14242146995;9110.225630821455;9112.772180695536;9115.954420227856;4779.665423420327;4801.831935882227;4807.062622788522;4832.081904438145;4832.661713680009;4368.301071828492;4395.582419670126;4395.7582332972;4403.251447253911;4412.4043254160915;3521.436570148764;3531.911702207465;3549.290141971616;3622.855085796539;3640.2537479816574;1112.7329440934118;1134.1153899958047;1135.8807325230732;1138.7950168969498;1140.372794962767;1285.607889593683;1309.18830325199;1321.8149459075737;1324.8675132486674;1327.2434712213944;7194.928050719531;7242.058532390755;7262.237465066198;7283.089613798275;7291.125064992235;422.07565431704467;437.6848668958345;438.52639149718226;440.5286343612368;441.7835260722223;5371.060064488699;5783.566232532493;5827.155062515912;5841.153032810219;5847.152162936351;8087.272145506932;8894.955525222333;8985.640574377083;9015.27877769777;9031.142041506046;8773.38586298953;8918.152775486318;8920.375573709778;8985.685501007563;9021.729348119436;7211.170715367695;7314.817129571697;7321.0116634254755;7412.851742965218;7431.628418579049;7008.7546935857;7051.612161331176;7061.929380706332;7093.32613401726;7124.145102587515;8332.208440198172;8340.791480213044;8347.582620869054;8447.704330348408;8459.746207613782;8116.959415202886;8505.702300419704;8570.871436928326;8604.225619694258;8655.3508486865;7039.260877607778;7052.576845389293;7122.038524799293;7125.216226215009;7154.678039488132;7512.812179695551;7534.773956781305;7571.3942884568005;7571.432142589438;7645.694172233271;7086.645667716697;7093.042439270633;7100.147982242164;7112.431005519649;7138.143422789299;6837.247902730795;6932.202796678245;6933.37599616037;7013.614251216232;7073.964630176816;7117.786466405809;7142.785716428515;7150.392216661642;7193.028941092885;7224.74713385029;6383.425491705769;6434.613923164625;6452.838679033061;6459.935400645933;6522.478201743754;6455.741770329134;6526.771562995273;6568.868622627616;6569.178852643419;6592.670366481752 03:02:34 INFO - 2015-11-21 03:02:34,105 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.1841921519341;325.514982675813;325.6320357995465;335.68613346521005;338.47029398990577;6012.669303188323;6038.245219347582;6059.636421814695;6093.390660933905;6143.26280846298;5772.826815195541;5955.106733989904;5961.493273071794;5968.1346204800275;6034.577579569432;4630.536946305359;4636.4436267647925;4640.83757068501;4686.9531304687025;4696.483386827446;4614.353990441324;4628.583427491525;4645.721256724607;4692.5072867348945;4707.176244157259;4512.526184750587;4565.178267911774;4620.815167393317;4625.444946606412;4628.1669299526075;4583.152116858392;4595.195840727876;4599.149157405891;4614.630829533629;4626.930596041062;3938.6258305460933;3939.8424063037446;3982.960170398288;3987.4218238355566;3998.7600743955454;5859;5870.295564532241;5881.206037184968;5887.999040163182;5913.438223368773;5074.213496907985;5254.816081437131;5298.947010529922;5321.760520776575;5332.306800115999;6303.842403939892;6315.115883776229;6370.904436433457;6378.425941665226;6392.105105285264;4418.160549495586;4421.049474363027;4438.134563760068;4448.288273876196;4455.46534415869;6387.201599800025;6518.543701940866;6537.280899101095;6546.44355229806;6676.499262555328;4482.125985432875;4514.977425112854;4522.706024108423;4525.343825145335;4534.614557762561;4568.88577785558;4613.3771940787565;4616.861494155113;4619.214733495314;4620.029793743284;5278.392984806719;5305.018571564273;5320.095583750772;5325.068113080196;5330.9733451332495;6230.408111229426;6246.625202487774;6330.746770129143;6335.809925702236;6391.9680401598625;1596.8003999500063;1657.0471978612345;1658.0797657300313;1669.2071266148482;1685.1153144599184;1012.448215722433;1027.6249169053242;1050.054950544516;1051;1078.7195329214303;5983.551233657406;5995.700214989233;6036.63780173191;6039.758409663565;6063.272407311063;6435.581687190412;6441.420272175433;6567.573107747981;6567.573107747981;6573.342665733484;6003;6005.249343832021;6009.278886533644;6013.428724271274;6083.11794789753;3571.1072231942017;3611.963880361163;3622.945655815165;3633.6184700606586;3661.0481274868725;6441.67791610427;6649.401553860176;6711.530192886548;6724.562903411263;6733;6712.832179195461;6737.393634572912;6748.460123190133;6793.150856142982;6891.586504809728;6688.264290928091;6724.495662825308;6751.054852320679;6754.18949726036;6759.5944243344575;6391.6804159792755;6612;6676.732930682912;6682.365175308338;6739.292374300824;6474.741010359533;6517.73929042833;6564;6592.90110648331;6596.340365963365;6703.698333575098;6712.798616041527;6758.42553382968;6813.080234168324;6832;4398.296272596497;4416.889577760582;4442.555744425532;4445.666575006822;4450.287953927356;6515.381038801306;6587.736490540325;6608.900866486911;6609.405153536012;6675.732970681119;6417.711202995783;6488.772892948913;6508.707108180049;6513.250976137615;6535.477161826947;6410.839729006812;6512.511561632802;6516;6521.445677117308;6523.575967562093;6187.659678717714;6211.254649442096;6263.6241825490615;6308.306086330592;6327.588706734047;6359;6439.484841212598;6445.452136568444;6454.903176452263;6455.580387274812;6060.272767267956;6254.21822272216;6314.368563143649;6327.746890124527;6340.873182536416 03:02:34 INFO - 2015-11-21 03:02:34,109 DEBUG : BROWSER_OUTPUT: |5;yui.html;750.6659536506257;754.6566312327891;793.7579038393295;811.7361857396346;823.8475881961836;13998.860011399884;14303;14337.498187563424;14390.568282951503;14409.351579178936;12421.751564968718;12861.614151575444;13005.284709340982;13187.406566704498;13305.866941330609;891.2558014058253;900.3697411811726;912.552849103941;913.3789023464042;914.3005600715425;882.5984177199359;901.9278457723399;901.9549022548879;902.5171533229724;908.2416182487631;923.3167456082484;933.2580598424269;943.4103685196752;943.7876477792511;945.1021529546923;918.4581097152678;923.5936188077225;926.8007378413673;928.2342067794096;932.7061975477736;655.7245956698198;685.7291369908858;686.9866946254285;690.4648897104734;694.2918223412141;12593.748125037448;12651.304178270191;12746.426410811535;12773.042021848398;12782.041346898926;9925.404475731408;10016.89983100167;10076.294659373847;10359.326643768207;10632.149428045737;8224.712135075304;8269.503829770172;8388.748337549883;8421.83156336876;8512.276456501204;3175.4442972479956;3234.514822776579;3235.3529294141267;3293.324868401996;3323.933521329584;42698.57301426977;42991.14017719628;48545;50214;50568.24147637789;9061.592228349607;9205.079492050741;9226.723198304062;9320.254379649612;9586.808263834684;19391.709124362864;19404.805951940583;19419.32032378888;19423.223071077282;19459.610807784047;7098.751543695946;7121.501494895308;7215.170255420694;7300.926990730131;7498.3626391756225;3794.7912864792147;3827.483289755903;3846.076941534012;3870.8645197417954;3970.8808735737975;2984.522476403765;3008.3080891395102;3027.819150531295;3030.8787648494254;3041.2092855857636;395.96832253419655;401.12554630904907;404.17951558336625;421.71534214405153;421.8186179942593;475.96668233224034;491.7983924650551;583.7664934026424;622.6668732228236;639.7824739588469;7737.187595302412;7857.253560911704;7971.601419929097;8037.477563958441;8074.878876816852;519.9584033277329;576.1904524143584;576.3861487515783;588.4615576747314;610.8014895159091;3594.4967704521387;3865.9226815464094;3974.125692347679;4056.492938382702;4164.8125834337525;62595.061074083926;62848;62922;63156.68421657954;63202;54402;55063.174052389244;55281.89436211334;55299.170512442346;55640;43710.56289437129;45697.7715111429;50096.745646446;50587.49412505901;50961.49038509642;7705.730299439717;7954.284114429498;7956.2043795619975;7992.36061115121;8046.396520260887;31372.05883823489;35623.46564801478;35654.465183022796;36557.817210913774;36592.63407365999;42101.36847947344;44822.551774481835;45060;45460.318095227936;45613.08773824571;7306.780796576111;7415.703371865065;7551.584662843597;7746.450709857938;7789.6884124636645;11067.312159954397;11087.22389432732;11319.264247823865;11355.457021852106;11482.540698371971;10142.695719128438;10193.184545236216;10252;10314.123299519624;10328.741781455523;10353.482325883526;10452;10459.633912813015;10509.421981791074;10599.523021464207;10274.897251027394;10282;10282.76606807188;10311.587536498757;10316.948415257875;7508.249175082667;7612.7716168515035;7879.763607091796;7905.56519391439;8176.959115204386;7712.498687585289;7746.92253077462;7775.183605721318;7969.561674107747;7975.322097621535 03:02:34 INFO - 2015-11-21 03:02:34,110 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:02:34 INFO - 2015-11-21 03:02:34,110 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:02:34 INFO - 2015-11-21 03:02:34,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1078 03:02:34 INFO - 2015-11-21 03:02:34,110 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:02:34 INFO - 2015-11-21 03:02:34,111 DEBUG : BROWSER_OUTPUT: __startTimestamp1448103754094__endTimestamp 03:02:34 INFO - 2015-11-21 03:02:34,111 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,111 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:02:34 INFO - 2015-11-21 03:02:34,111 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:02:34 INFO - 2015-11-21 03:02:34,111 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,111 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5303.37 Median:5408.13 stddev:535.90 (9.9%) stddev-sans-first:512.00 03:02:34 INFO - 2015-11-21 03:02:34,112 DEBUG : BROWSER_OUTPUT: Values: 3219.3 3224.3 3273.3 3283.3 3306.1 5335.8 5361.2 5363.2 5364.6 5373.8 5280.9 5314.0 5321.9 5355.9 5384.5 4943.1 4950.6 5010.9 5018.3 5071.9 4956.2 4971.2 5008.1 5030.2 5047.1 5108.3 5137.5 5148.0 5162.2 5173.3 4837.1 5063.5 5095.2 5102.6 5136.8 4876.7 4971.5 4986.6 5000.2 5016.8 5248.7 5310.0 5359.3 5403.1 5419.6 5360.2 5450.3 5740.7 5755.7 5816.7 5635.9 5699.1 5714.3 5728.1 5761.3 5408.1 5429.8 5435.2 5436.7 5438.8 5600.7 5717.0 5796.9 5910.0 5940.3 5329.2 5419.8 5498.4 5504.5 5532.4 5707.1 5756.5 5777.9 5783.0 5783.2 5407.2 5525.2 5564.1 5645.0 5717.0 5451.3 5498.3 5585.6 5604.2 5633.8 4413.0 4449.6 4451.5 4460.4 4467.3 3969.7 4039.5 4045.8 4046.4 4091.1 5234.6 5285.7 5322.3 5342.1 5362.5 5676.0 5693.7 5724.3 5755.1 5756.8 5146.0 5190.5 5223.4 5232.0 5310.8 4841.6 4938.0 4953.4 4954.8 4976.3 5798.3 5800.8 5883.9 5889.2 5894.0 5460.3 5558.9 5574.7 5762.5 5785.3 5784.3 5847.1 5860.2 5861.6 5881.1 5712.5 5713.6 5723.6 5732.5 5791.2 5323.2 5350.1 5437.3 5808.3 5867.8 5389.4 5399.8 5470.5 5497.6 5506.3 5511.0 5555.3 5575.1 5604.2 5605.6 5250.8 5351.9 5357.9 5437.0 5456.0 5403.6 5467.1 5546.4 5550.3 5574.4 5303.8 5401.5 5500.3 5525.6 5530.8 03:02:34 INFO - 2015-11-21 03:02:34,112 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,112 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46734.58 Median:32450.19 stddev:77812.90 (239.8%) stddev-sans-first:77953.95 03:02:34 INFO - 2015-11-21 03:02:34,112 DEBUG : BROWSER_OUTPUT: Values: 560.4 560.7 566.8 577.3 577.9 32426.2 33022.0 39410.4 39435.8 39883.2 41529.4 42329.8 42800.1 43216.1 43239.0 8412.5 9005.5 9091.7 9111.1 9221.5 8501.8 10799.8 10935.4 10997.8 11058.6 10650.9 10658.5 10701.8 10789.4 10800.1 7529.2 8824.1 10693.4 10965.7 11051.6 10594.8 10748.2 10825.7 10831.8 10848.7 39559.6 39771.8 40161.4 40214.6 40293.6 2977.8 3063.7 3109.7 3431.9 3611.4 26910.7 27944.0 27950.9 28224.7 28884.9 2353.6 2359.9 2428.9 2503.1 2508.6 280477.0 281974.0 284674.0 286287.0 406985.0 49889.8 61271.4 62420.0 62425.7 62468.4 57216.7 57745.4 57811.4 57831.7 58353.0 16486.9 16524.0 16823.8 16864.2 16907.1 13328.7 13435.2 13662.4 13680.1 13782.4 18564.2 19528.0 19628.7 19668.4 19794.4 7844.3 8012.0 8032.9 8051.8 8089.8 905.9 906.4 921.4 924.4 942.6 27270.7 27288.2 27310.2 27582.4 27853.4 959.2 961.3 1073.0 1097.0 1162.6 11227.4 14483.1 14781.3 14886.4 14901.7 314237.0 317905.0 318276.0 318371.0 320460.0 50371.2 51946.7 52287.5 52716.2 52879.2 1409.0 1409.2 1415.6 1421.3 1422.4 23518.0 26423.2 26927.5 27691.9 28136.3 51264.2 51786.7 51911.0 51954.7 52054.5 257464.0 259458.0 259915.0 260278.0 261328.0 32391.7 32749.5 32821.5 32960.3 33280.0 42323.6 42484.4 43691.6 43870.6 43912.1 35259.0 36137.0 36193.6 36462.6 36892.2 35513.6 35939.5 36212.8 36222.5 36383.5 36091.5 37019.4 37399.3 37443.6 37531.6 30254.7 32357.7 32474.2 32514.0 32596.3 24225.5 24295.1 24535.6 24556.9 24561.6 03:02:34 INFO - 2015-11-21 03:02:34,112 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,113 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27696.18 Median:2485.46 stddev:94848.32 (3816.1%) stddev-sans-first:95092.17 03:02:34 INFO - 2015-11-21 03:02:34,114 DEBUG : BROWSER_OUTPUT: Values: 352.8 355.3 356.1 359.9 360.2 14718.1 14976.6 17373.2 17947.7 18836.7 11877.4 12186.0 15306.3 18247.3 18526.8 4448.1 4500.8 4519.8 4563.2 4576.5 3483.4 3689.8 4360.3 4437.3 4714.6 4770.3 4784.1 4790.3 4823.2 4825.7 4495.2 4564.7 4752.0 4804.3 4813.8 4023.6 4039.3 4099.1 4125.8 4126.4 13175.9 13351.8 13408.5 13435.6 13617.8 1868.0 1883.3 1958.4 1992.8 2012.7 9389.0 9523.2 9526.8 9644.5 9692.8 1512.0 1521.5 1531.0 1560.5 1608.8 58787.0 59932.4 60234.1 60875.4 61121.4 6657.2 6662.0 6680.0 6680.7 6703.6 7648.6 7697.6 7716.3 7745.0 7767.1 5275.1 5286.6 5489.9 5695.8 5713.3 6101.9 6105.1 6122.8 6173.2 6186.4 2977.6 2985.7 2993.6 2996.5 3023.8 1035.9 1046.8 1067.4 1083.1 1108.7 426.1 431.6 458.5 460.3 479.8 10467.5 11574.1 11582.1 12147.8 12202.6 446.9 451.1 455.9 457.9 469.1 5220.4 6327.7 6437.3 6525.2 6535.2 569562.0 573616.0 583558.0 584703.0 585118.0 68548.0 71946.6 72209.0 72433.6 74286.0 487.2 491.5 495.0 495.6 497.0 10430.9 11036.4 11120.2 11134.3 11149.1 33186.2 33332.3 33357.0 33847.0 34323.8 43672.6 44410.0 44444.8 47838.8 48847.5 6210.4 6358.7 6447.5 6530.9 6539.5 11358.5 11770.4 11813.9 11814.8 12033.1 9797.5 10186.8 10219.3 10272.2 10362.2 9732.7 9778.9 9889.9 9952.9 10193.6 9101.5 9413.7 10120.9 10566.6 10783.2 6220.5 6426.6 6429.4 6507.4 6540.0 9916.6 10223.9 10335.3 10411.2 10412.7 03:02:34 INFO - 2015-11-21 03:02:34,114 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,114 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5392.17 Median:6524.62 stddev:2802.40 (43.0%) stddev-sans-first:2793.69 03:02:34 INFO - 2015-11-21 03:02:34,115 DEBUG : BROWSER_OUTPUT: Values: 1337.0 1496.9 1546.8 1657.0 1831.5 6923.5 7564.4 7706.8 7745.2 7765.0 7533.8 7754.5 7771.1 7771.3 7931.4 2218.8 2234.6 2244.5 2256.7 2256.9 2270.4 2293.2 2305.8 2321.9 2324.7 2208.7 2210.1 2221.9 2222.5 2248.2 2187.4 2195.6 2223.6 2235.5 2248.3 2240.7 2249.5 2262.3 2267.2 2270.0 6973.5 7019.9 7605.5 7633.6 7738.5 4508.9 4620.3 4623.2 4626.9 4638.7 2796.6 2809.6 2834.6 2854.2 2927.2 835.4 860.4 863.3 884.5 886.8 10289.4 10299.5 10373.4 10380.3 10474.9 4276.5 4283.6 4326.4 4339.1 4351.4 8991.1 9027.1 9110.2 9112.8 9116.0 4779.7 4801.8 4807.1 4832.1 4832.7 4368.3 4395.6 4395.8 4403.3 4412.4 3521.4 3531.9 3549.3 3622.9 3640.3 1112.7 1134.1 1135.9 1138.8 1140.4 1285.6 1309.2 1321.8 1324.9 1327.2 7194.9 7242.1 7262.2 7283.1 7291.1 422.1 437.7 438.5 440.5 441.8 5371.1 5783.6 5827.2 5841.2 5847.2 8087.3 8895.0 8985.6 9015.3 9031.1 8773.4 8918.2 8920.4 8985.7 9021.7 7211.2 7314.8 7321.0 7412.9 7431.6 7008.8 7051.6 7061.9 7093.3 7124.1 8332.2 8340.8 8347.6 8447.7 8459.7 8117.0 8505.7 8570.9 8604.2 8655.4 7039.3 7052.6 7122.0 7125.2 7154.7 7512.8 7534.8 7571.4 7571.4 7645.7 7086.6 7093.0 7100.1 7112.4 7138.1 6837.2 6932.2 6933.4 7013.6 7074.0 7117.8 7142.8 7150.4 7193.0 7224.7 6383.4 6434.6 6452.8 6459.9 6522.5 6455.7 6526.8 6568.9 6569.2 6592.7 03:02:34 INFO - 2015-11-21 03:02:34,116 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,116 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5332.46 Median:6024.00 stddev:1602.01 (26.6%) stddev-sans-first:1561.73 03:02:34 INFO - 2015-11-21 03:02:34,117 DEBUG : BROWSER_OUTPUT: Values: 321.2 325.5 325.6 335.7 338.5 6012.7 6038.2 6059.6 6093.4 6143.3 5772.8 5955.1 5961.5 5968.1 6034.6 4630.5 4636.4 4640.8 4687.0 4696.5 4614.4 4628.6 4645.7 4692.5 4707.2 4512.5 4565.2 4620.8 4625.4 4628.2 4583.2 4595.2 4599.1 4614.6 4626.9 3938.6 3939.8 3983.0 3987.4 3998.8 5859.0 5870.3 5881.2 5888.0 5913.4 5074.2 5254.8 5298.9 5321.8 5332.3 6303.8 6315.1 6370.9 6378.4 6392.1 4418.2 4421.0 4438.1 4448.3 4455.5 6387.2 6518.5 6537.3 6546.4 6676.5 4482.1 4515.0 4522.7 4525.3 4534.6 4568.9 4613.4 4616.9 4619.2 4620.0 5278.4 5305.0 5320.1 5325.1 5331.0 6230.4 6246.6 6330.7 6335.8 6392.0 1596.8 1657.0 1658.1 1669.2 1685.1 1012.4 1027.6 1050.1 1051.0 1078.7 5983.6 5995.7 6036.6 6039.8 6063.3 6435.6 6441.4 6567.6 6567.6 6573.3 6003.0 6005.2 6009.3 6013.4 6083.1 3571.1 3612.0 3622.9 3633.6 3661.0 6441.7 6649.4 6711.5 6724.6 6733.0 6712.8 6737.4 6748.5 6793.2 6891.6 6688.3 6724.5 6751.1 6754.2 6759.6 6391.7 6612.0 6676.7 6682.4 6739.3 6474.7 6517.7 6564.0 6592.9 6596.3 6703.7 6712.8 6758.4 6813.1 6832.0 4398.3 4416.9 4442.6 4445.7 4450.3 6515.4 6587.7 6608.9 6609.4 6675.7 6417.7 6488.8 6508.7 6513.3 6535.5 6410.8 6512.5 6516.0 6521.4 6523.6 6187.7 6211.3 6263.6 6308.3 6327.6 6359.0 6439.5 6445.5 6454.9 6455.6 6060.3 6254.2 6314.4 6327.7 6340.9 03:02:34 INFO - 2015-11-21 03:02:34,117 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,117 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13601.15 Median:25740.72 stddev:16847.16 (65.4%) stddev-sans-first:16866.78 03:02:34 INFO - 2015-11-21 03:02:34,117 DEBUG : BROWSER_OUTPUT: Values: 750.7 754.7 793.8 811.7 823.8 13998.9 14303.0 14337.5 14390.6 14409.4 12421.8 12861.6 13005.3 13187.4 13305.9 891.3 900.4 912.6 913.4 914.3 882.6 901.9 902.0 902.5 908.2 923.3 933.3 943.4 943.8 945.1 918.5 923.6 926.8 928.2 932.7 655.7 685.7 687.0 690.5 694.3 12593.7 12651.3 12746.4 12773.0 12782.0 9925.4 10016.9 10076.3 10359.3 10632.1 8224.7 8269.5 8388.7 8421.8 8512.3 3175.4 3234.5 3235.4 3293.3 3323.9 42698.6 42991.1 48545.0 50214.0 50568.2 9061.6 9205.1 9226.7 9320.3 9586.8 19391.7 19404.8 19419.3 19423.2 19459.6 7098.8 7121.5 7215.2 7300.9 7498.4 3794.8 3827.5 3846.1 3870.9 3970.9 2984.5 3008.3 3027.8 3030.9 3041.2 396.0 401.1 404.2 421.7 421.8 476.0 491.8 583.8 622.7 639.8 7737.2 7857.3 7971.6 8037.5 8074.9 520.0 576.2 576.4 588.5 610.8 3594.5 3865.9 3974.1 4056.5 4164.8 62595.1 62848.0 62922.0 63156.7 63202.0 54402.0 55063.2 55281.9 55299.2 55640.0 43710.6 45697.8 50096.7 50587.5 50961.5 7705.7 7954.3 7956.2 7992.4 8046.4 31372.1 35623.5 35654.5 36557.8 36592.6 42101.4 44822.6 45060.0 45460.3 45613.1 7306.8 7415.7 7551.6 7746.5 7789.7 11067.3 11087.2 11319.3 11355.5 11482.5 10142.7 10193.2 10252.0 10314.1 10328.7 10353.5 10452.0 10459.6 10509.4 10599.5 10274.9 10282.0 10282.8 10311.6 10316.9 7508.2 7612.8 7879.8 7905.6 8177.0 7712.5 7746.9 7775.2 7969.6 7975.3 03:02:34 INFO - 2015-11-21 03:02:34,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:02:34 INFO - 2015-11-21 03:02:34,119 DEBUG : BROWSER_OUTPUT: 03:02:34 INFO - 2015-11-21 03:02:34,764 INFO : Browser exited with error code: 0 03:02:34 INFO - 2015-11-21 03:02:34,791 INFO : Completed test dromaeo_css (00:18:34) 03:02:34 INFO - 2015-11-21 03:02:34,792 INFO : Starting test kraken 03:02:34 INFO - 2015-11-21 03:02:34,792 DEBUG : operating with platform_type : mac_ 03:02:34 INFO - 2015-11-21 03:02:34,792 INFO : Initialising browser for kraken test... 03:02:34 INFO - 2015-11-21 03:02:34,805 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpZGZ9LP/profile http://localhost:49271/getInfo.html 03:02:37 INFO - 2015-11-21 03:02:37,033 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:02:37 INFO - 2015-11-21 03:02:37,033 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:02:37 INFO - 2015-11-21 03:02:37,033 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:02:37 INFO - 2015-11-21 03:02:37,033 DEBUG : BROWSER_OUTPUT: __metrics 03:02:37 INFO - 2015-11-21 03:02:37,049 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:02:37 INFO - 2015-11-21 03:02:37,721 INFO : Browser initialized. 03:02:37 INFO - 2015-11-21 03:02:37,722 INFO : Running cycle 1/1 for kraken test... 03:02:37 INFO - 2015-11-21 03:02:37,722 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpZGZ9LP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:02:49 INFO - 2015-11-21 03:02:49,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 199467008 03:02:49 INFO - 2015-11-21 03:02:49,631 DEBUG : BROWSER_OUTPUT: 03:02:52 INFO - 2015-11-21 03:02:52,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 03:02:52 INFO - 2015-11-21 03:02:52,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 263593984 03:02:52 INFO - 2015-11-21 03:02:52,777 DEBUG : BROWSER_OUTPUT: 03:02:55 INFO - 2015-11-21 03:02:55,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 03:02:55 INFO - 2015-11-21 03:02:55,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 277135360 03:02:55 INFO - 2015-11-21 03:02:55,994 DEBUG : BROWSER_OUTPUT: 03:02:58 INFO - 2015-11-21 03:02:58,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 03:02:59 INFO - 2015-11-21 03:02:59,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 263380992 03:02:59 INFO - 2015-11-21 03:02:59,416 DEBUG : BROWSER_OUTPUT: 03:03:01 INFO - 2015-11-21 03:03:01,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 03:03:02 INFO - 2015-11-21 03:03:02,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 263962624 03:03:02 INFO - 2015-11-21 03:03:02,061 DEBUG : BROWSER_OUTPUT: 03:03:04 INFO - 2015-11-21 03:03:04,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:03:04 INFO - 2015-11-21 03:03:04,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 263639040 03:03:04 INFO - 2015-11-21 03:03:04,809 DEBUG : BROWSER_OUTPUT: 03:03:07 INFO - 2015-11-21 03:03:07,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 03:03:08 INFO - 2015-11-21 03:03:08,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 264114176 03:03:08 INFO - 2015-11-21 03:03:08,436 DEBUG : BROWSER_OUTPUT: 03:03:11 INFO - 2015-11-21 03:03:11,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 03:03:12 INFO - 2015-11-21 03:03:12,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 264994816 03:03:12 INFO - 2015-11-21 03:03:12,133 DEBUG : BROWSER_OUTPUT: 03:03:14 INFO - 2015-11-21 03:03:14,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 03:03:15 INFO - 2015-11-21 03:03:15,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 265216000 03:03:15 INFO - 2015-11-21 03:03:15,575 DEBUG : BROWSER_OUTPUT: 03:03:17 INFO - 2015-11-21 03:03:17,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:03:17 INFO - 2015-11-21 03:03:17,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 299065344 03:03:17 INFO - 2015-11-21 03:03:17,753 DEBUG : BROWSER_OUTPUT: 03:03:19 INFO - 2015-11-21 03:03:19,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:03:20 INFO - 2015-11-21 03:03:20,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 300224512 03:03:20 INFO - 2015-11-21 03:03:20,167 DEBUG : BROWSER_OUTPUT: 03:03:22 INFO - 2015-11-21 03:03:22,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:03:22 INFO - 2015-11-21 03:03:22,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 305545216 03:03:22 INFO - 2015-11-21 03:03:22,799 DEBUG : BROWSER_OUTPUT: 03:03:25 INFO - 2015-11-21 03:03:25,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:03:25 INFO - 2015-11-21 03:03:25,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 307462144 03:03:25 INFO - 2015-11-21 03:03:25,872 DEBUG : BROWSER_OUTPUT: 03:03:28 INFO - 2015-11-21 03:03:28,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:03:28 INFO - 2015-11-21 03:03:28,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 308432896 03:03:28 INFO - 2015-11-21 03:03:28,947 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 03:03:30 INFO - 2015-11-21 03:03:30,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 366817280 03:03:30 INFO - 2015-11-21 03:03:30,903 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,903 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:03:30 INFO - 2015-11-21 03:03:30,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:03:30 INFO - 2015-11-21 03:03:30,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:03:30 INFO - 2015-11-21 03:03:30,904 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:03:30 INFO - 2015-11-21 03:03:30,904 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;107;104;106;108;108;97;107;98;107 03:03:30 INFO - 2015-11-21 03:03:30,904 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;160;153;124;145;124;157;168;126 03:03:30 INFO - 2015-11-21 03:03:30,905 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;162;162;162;162;162;162;161 03:03:30 INFO - 2015-11-21 03:03:30,905 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;81;77;120;69;69;69;71;115;65 03:03:30 INFO - 2015-11-21 03:03:30,905 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;98;135;87;90;89;126;86;87;130 03:03:30 INFO - 2015-11-21 03:03:30,905 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;114;122;115;120;115;120;122;120;120 03:03:30 INFO - 2015-11-21 03:03:30,905 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;124;125;124;123;125;124;124;124;123 03:03:30 INFO - 2015-11-21 03:03:30,906 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;102;100;101;104;99;104;99;102;100 03:03:30 INFO - 2015-11-21 03:03:30,906 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;62;63;63;69;63;64;71;57;57 03:03:30 INFO - 2015-11-21 03:03:30,907 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;63;67;64;65;64;65;65;65 03:03:30 INFO - 2015-11-21 03:03:30,907 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;81;82;82;82;82;82;83;87 03:03:30 INFO - 2015-11-21 03:03:30,908 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;119;125;116;127;125;126;117;119;117 03:03:30 INFO - 2015-11-21 03:03:30,908 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;144;144;142;141;141;142;141;142;131 03:03:30 INFO - 2015-11-21 03:03:30,908 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;67;67;68;69;67;68;67 03:03:30 INFO - 2015-11-21 03:03:30,908 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:03:30 INFO - 2015-11-21 03:03:30,908 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:03:30 INFO - 2015-11-21 03:03:30,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: __startTimestamp1448103810902__endTimestamp 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,909 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:104.80 Median:107.50 stddev:4.02 (3.7%) stddev-sans-first:4.24 03:03:30 INFO - 2015-11-21 03:03:30,910 DEBUG : BROWSER_OUTPUT: Values: 106.0 107.0 104.0 106.0 108.0 108.0 97.0 107.0 98.0 107.0 03:03:30 INFO - 2015-11-21 03:03:30,910 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,910 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:153.00 stddev:16.61 (10.9%) stddev-sans-first:17.30 03:03:30 INFO - 2015-11-21 03:03:30,910 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 160.0 153.0 124.0 145.0 124.0 157.0 168.0 126.0 03:03:30 INFO - 2015-11-21 03:03:30,910 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,910 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 03:03:30 INFO - 2015-11-21 03:03:30,911 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 162.0 162.0 162.0 162.0 162.0 162.0 161.0 03:03:30 INFO - 2015-11-21 03:03:30,911 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,911 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:70.00 stddev:19.69 (28.1%) stddev-sans-first:20.84 03:03:30 INFO - 2015-11-21 03:03:30,911 DEBUG : BROWSER_OUTPUT: Values: 78.0 81.0 77.0 120.0 69.0 69.0 69.0 71.0 115.0 65.0 03:03:30 INFO - 2015-11-21 03:03:30,911 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:87.00 stddev:19.67 (22.6%) stddev-sans-first:20.84 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: Values: 100.0 98.0 135.0 87.0 90.0 89.0 126.0 86.0 87.0 130.0 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:120.00 stddev:3.03 (2.5%) stddev-sans-first:3.12 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: Values: 121.0 114.0 122.0 115.0 120.0 115.0 120.0 122.0 120.0 120.0 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,912 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.10 Median:124.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 03:03:30 INFO - 2015-11-21 03:03:30,914 DEBUG : BROWSER_OUTPUT: Values: 125.0 124.0 125.0 124.0 123.0 125.0 124.0 124.0 124.0 123.0 03:03:30 INFO - 2015-11-21 03:03:30,914 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,914 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:101.10 Median:103.00 stddev:1.85 (1.8%) stddev-sans-first:1.92 03:03:30 INFO - 2015-11-21 03:03:30,914 DEBUG : BROWSER_OUTPUT: Values: 100.0 102.0 100.0 101.0 104.0 99.0 104.0 99.0 102.0 100.0 03:03:30 INFO - 2015-11-21 03:03:30,914 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,915 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:4.51 (7.2%) stddev-sans-first:4.66 03:03:30 INFO - 2015-11-21 03:03:30,915 DEBUG : BROWSER_OUTPUT: Values: 60.0 62.0 63.0 63.0 69.0 63.0 64.0 71.0 57.0 57.0 03:03:30 INFO - 2015-11-21 03:03:30,915 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,915 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 03:03:30 INFO - 2015-11-21 03:03:30,915 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 63.0 67.0 64.0 65.0 64.0 65.0 65.0 65.0 03:03:30 INFO - 2015-11-21 03:03:30,915 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:1.65 (2.0%) stddev-sans-first:1.74 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 81.0 82.0 82.0 82.0 82.0 82.0 83.0 87.0 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:122.00 stddev:4.31 (3.5%) stddev-sans-first:4.44 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 125.0 116.0 127.0 125.0 126.0 117.0 119.0 117.0 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,916 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:142.00 stddev:4.82 (3.4%) stddev-sans-first:3.89 03:03:30 INFO - 2015-11-21 03:03:30,917 DEBUG : BROWSER_OUTPUT: Values: 131.0 144.0 144.0 142.0 141.0 141.0 142.0 141.0 142.0 131.0 03:03:30 INFO - 2015-11-21 03:03:30,917 DEBUG : BROWSER_OUTPUT: 03:03:30 INFO - 2015-11-21 03:03:30,917 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 03:03:30 INFO - 2015-11-21 03:03:30,917 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 67.0 67.0 68.0 69.0 67.0 68.0 67.0 03:03:30 INFO - 2015-11-21 03:03:30,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:03:30 INFO - 2015-11-21 03:03:30,917 DEBUG : BROWSER_OUTPUT: 03:03:31 INFO - 2015-11-21 03:03:31,556 INFO : Browser exited with error code: 0 03:03:31 INFO - 2015-11-21 03:03:31,604 INFO : Completed test kraken (00:00:56) 03:03:31 INFO - 2015-11-21 03:03:31,605 INFO : Starting test v8_7 03:03:31 INFO - 2015-11-21 03:03:31,605 DEBUG : operating with platform_type : mac_ 03:03:31 INFO - 2015-11-21 03:03:31,605 INFO : Initialising browser for v8_7 test... 03:03:31 INFO - 2015-11-21 03:03:31,618 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmp6kugXx/profile http://localhost:49271/getInfo.html 03:03:33 INFO - 2015-11-21 03:03:33,757 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:03:33 INFO - 2015-11-21 03:03:33,758 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:03:33 INFO - 2015-11-21 03:03:33,758 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:03:33 INFO - 2015-11-21 03:03:33,758 DEBUG : BROWSER_OUTPUT: __metrics 03:03:33 INFO - 2015-11-21 03:03:33,765 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:03:34 INFO - 2015-11-21 03:03:34,412 INFO : Browser initialized. 03:03:34 INFO - 2015-11-21 03:03:34,413 INFO : Running cycle 1/1 for v8_7 test... 03:03:34 INFO - 2015-11-21 03:03:34,413 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmp6kugXx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:03:46 INFO - 2015-11-21 03:03:46,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 198889472 03:03:46 INFO - 2015-11-21 03:03:46,243 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/v8_7/run.html (next: http://localhost:49271/tests/v8_7/run.html) 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 524283904 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: |0;Richards;166.00265604249668 03:04:07 INFO - 2015-11-21 03:04:07,913 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;200.8435428800964 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |2;Encrypt;330.1419610432486 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5747.126436781609 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1015.2284263959391 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |5;Earley;671.1409395973154 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |6;Boyer;12822.784810126583 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |7;RegExp;29823.529411764706 03:04:07 INFO - 2015-11-21 03:04:07,914 DEBUG : BROWSER_OUTPUT: |8;Splay;592.4170616113744 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5819.767441860465 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: __startTimestamp1448103847911__endTimestamp 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,915 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: Values: 166.0 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:200.84 Median:200.84 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: Values: 200.8 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:330.14 Median:330.14 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: Values: 330.1 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5747.13 Median:5747.13 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: Values: 5747.1 03:04:07 INFO - 2015-11-21 03:04:07,916 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1015.23 Median:1015.23 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: Values: 1015.2 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:671.14 Median:671.14 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: Values: 671.1 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12822.78 Median:12822.78 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: Values: 12822.8 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29823.53 Median:29823.53 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: Values: 29823.5 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.42 Median:592.42 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,917 DEBUG : BROWSER_OUTPUT: Values: 592.4 03:04:07 INFO - 2015-11-21 03:04:07,918 DEBUG : BROWSER_OUTPUT: 03:04:07 INFO - 2015-11-21 03:04:07,918 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5819.77 Median:5819.77 stddev:0.00 (0.0%) 03:04:07 INFO - 2015-11-21 03:04:07,918 DEBUG : BROWSER_OUTPUT: Values: 5819.8 03:04:07 INFO - 2015-11-21 03:04:07,918 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:04:07 INFO - 2015-11-21 03:04:07,918 DEBUG : BROWSER_OUTPUT: 03:04:08 INFO - 2015-11-21 03:04:08,547 INFO : Browser exited with error code: 0 03:04:08 INFO - 2015-11-21 03:04:08,566 INFO : Completed test v8_7 (00:00:36) 03:04:08 INFO - 2015-11-21 03:04:08,572 INFO : Completed test suite (00:20:08) 03:04:08 INFO - 2015-11-21 03:04:08,573 DEBUG : Working with test: dromaeo_css 03:04:08 INFO - 2015-11-21 03:04:08,573 DEBUG : Generating results file: dromaeo_css 03:04:08 INFO - 2015-11-21 03:04:08,574 DEBUG : Working with test: kraken 03:04:08 INFO - 2015-11-21 03:04:08,574 DEBUG : Generating results file: kraken 03:04:08 INFO - 2015-11-21 03:04:08,574 INFO : javascript benchmark 03:04:08 INFO - 2015-11-21 03:04:08,574 DEBUG : Working with test: v8_7 03:04:08 INFO - 2015-11-21 03:04:08,574 DEBUG : Generating results file: v8_7 03:04:08 INFO - 2015-11-21 03:04:08,575 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:04:08 INFO - 2015-11-21 03:04:08,718 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:04:08 INFO - 2015-11-21 03:04:08,718 DEBUG : process_Request line: dromaeo_css 6588.90 graph.html#tests=[[72,52,55]] 03:04:08 INFO - 2015-11-21 03:04:08,718 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:04:08 INFO - 2015-11-21 03:04:08,829 DEBUG : process_Request line: kraken 1477.30 graph.html#tests=[[232,52,55]] 03:04:08 INFO - 2015-11-21 03:04:08,829 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:04:08 INFO - 2015-11-21 03:04:08,858 DEBUG : process_Request line: v8_7 20149.04 graph.html#tests=[[230,52,55]] 03:04:08 INFO - 2015-11-21 03:04:08,859 INFO : javascript benchmark 03:04:08 INFO - 2015-11-21 03:04:08,861 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [352.7759872480975, 355.27878406834134, 356.0866377741094, 359.92621512589915, 360.18418282589937, 14718.116912985228, 14976.550703478886, 17373.218205180765, 17947.730784038235, 18836.717449238273, 11877.406129693523, 12186.02511799056, 15306.311215995307, 18247.270109195615, 18526.81473185268, 4448.11037792442, 4500.797464114123, 4519.7740112994215, 4563.201439748047, 4576.4737055238575, 3483.372992861284, 3689.8339574719066, 4360.28055370865, 4437.267850804614, 4714.552117548845, 4770.332153498513, 4784.138855006097, 4790.257510085925, 4823.20417131173, 4825.734584597846, 4495.235809912323, 4564.748938808364, 4752.002079563313, 4804.303376010494, 4813.807447702087, 4023.5976402359825, 4039.272930872442, 4099.118689481776, 4125.814338354781, 4126.42230087788, 13175.934120329433, 13351.799723004162, 13408.46366145353, 13435.596932092052, 13617.795733064011, 1867.953301167468, 1883.3314173468495, 1958.3733205374144, 1992.7816576229286, 2012.667909794882, 9389.0, 9523.238140948708, 9526.761830954212, 9644.469554174517, 9692.75768105796, 1511.9697606047816, 1521.4903007492503, 1530.9770353444596, 1560.5084398414576, 1608.750643650236, 58787.0, 59932.400675993114, 60234.09648855271, 60875.39124608786, 61121.38878611202, 6657.234418041987, 6662.0, 6680.0, 6680.665966701646, 6703.597784132968, 7648.579328137006, 7697.6151192441275, 7716.344110750537, 7744.961275193588, 7767.106782719947, 5275.076861549213, 5286.60350473716, 5489.945100548944, 5695.800646977336, 5713.342965558931, 6101.877962440726, 6105.145279660851, 6122.755089796358, 6173.197484327009, 6186.381361863868, 2977.5980242667397, 2985.671576126624, 2993.5659329397117, 2996.460637085302, 3023.7883348165856, 1035.8549803027581, 1046.7697106636529, 1067.3755852826184, 1083.0523292119397, 1108.6784832398675, 426.10517912384364, 431.58567774935784, 458.51397518629693, 460.28885372100183, 479.79608666316676, 10467.476626168662, 11574.131940104357, 11582.131340149353, 12147.757044859054, 12202.633920982385, 446.9195544801902, 451.1405772004337, 455.8769132334251, 457.8557754307383, 469.1414711078718, 5220.425753167148, 6327.651979141099, 6437.259715132726, 6525.2169739631545, 6535.183102112236, 569562.0, 573616.0, 583558.0, 584703.0, 585118.0, 68548.0, 71946.64026679833, 72209.0, 72433.6378318105, 74286.0, 487.2483422097554, 491.5134017322825, 494.9752512374367, 495.60351718624236, 496.990060198794, 10430.947845260725, 11036.448177591248, 11120.165987550805, 11134.27627204229, 11149.108071354434, 33186.17034574155, 33332.33335333231, 33357.0, 33847.0, 34323.828380857936, 43672.56327436812, 44410.0, 44444.777776112205, 47838.76080619574, 48847.5115248843, 6210.441060304413, 6358.682065896779, 6447.451966582706, 6530.869382612416, 6539.476841852736, 11358.54565817358, 11770.411479426166, 11813.881861181279, 11814.82277765817, 12033.097517686034, 9797.461139637104, 10186.847197292194, 10219.335743176669, 10272.22958278147, 10362.171026318027, 9732.659356922473, 9778.85331720039, 9889.901100989186, 9952.850707239253, 10193.643222487473, 9101.453912765255, 9413.670521531987, 10120.949395252977, 10566.630167944393, 10783.245172837826, 6220.533459990609, 6426.614403135827, 6429.38920802523, 6507.381798729113, 6540.0, 9916.553755081182, 10223.948880255848, 10335.328203666737, 10411.219158562986, 10412.68761937143], "dojo.html": [3219.323941972186, 3224.3228921926393, 3273.3126043530874, 3283.3433313337323, 3306.12387717255, 5335.839924802252, 5361.222622719703, 5363.168708850125, 5364.624476286662, 5373.838784836456, 5280.867978300545, 5314.043472175007, 5321.893562128756, 5355.866103347418, 5384.542313903323, 4943.085529177114, 4950.603951683875, 5010.874728131789, 5018.272350509174, 5071.898562028758, 4956.231784073457, 4971.229459433794, 5008.148614735485, 5030.195168772997, 5047.066292735837, 5108.259302401149, 5137.486251374851, 5148.0476111919415, 5162.174052151657, 5173.275741396207, 4837.129316722989, 5063.544281014726, 5095.210242412432, 5102.566281866046, 5136.845894623168, 4876.731779752112, 4971.45314015458, 4986.626003049786, 5000.1999680051385, 5016.849494515171, 5248.685078895241, 5309.973450132763, 5359.3032905722, 5403.135498320289, 5419.620626556142, 5360.249565060894, 5450.345958484968, 5740.741666625012, 5755.654660720328, 5816.651000939914, 5635.943640563582, 5699.145128230757, 5714.285714285715, 5728.054870946289, 5761.251037365158, 5408.134698448269, 5429.8099566515775, 5435.239066530688, 5436.728163591844, 5438.782448702087, 5600.747966341524, 5716.971415142898, 5796.8550786229835, 5910.0, 5940.257467816523, 5329.227262047059, 5419.756110975016, 5498.422665620053, 5504.532114770209, 5532.419095994943, 5707.0583353747, 5756.510696590753, 5777.913331300034, 5782.971085144547, 5783.248177736951, 5407.242985981966, 5525.198846167284, 5564.137558678412, 5644.97177514118, 5717.0, 5451.3458384994055, 5498.285222920995, 5585.636933599303, 5604.159376093618, 5633.8309850704545, 4412.977935110304, 4449.555044495524, 4451.532589078165, 4460.442444694413, 4467.30756732707, 3969.702272329587, 4039.5152581690386, 4045.8179381927885, 4046.393041043867, 4091.1408604192857, 5234.555062819627, 5285.709285989307, 5322.2548843161985, 5342.1185504392115, 5362.51737343641, 5676.0, 5693.743781529841, 5724.341700704473, 5755.050416681284, 5756.769729210785, 5146.0, 5190.506901844319, 5223.373195216598, 5232.0, 5310.840674779763, 4841.588464980446, 4938.037082768898, 4953.356063711694, 4954.826581069718, 4976.253561965734, 5798.275215598051, 5800.796972105956, 5883.852903677443, 5889.23439952812, 5894.0274854648505, 5460.31746031746, 5558.944410555842, 5574.693391863487, 5762.4525670061275, 5785.27684039495, 5784.2769653793275, 5847.06446968483, 5860.179574859609, 5861.589688721919, 5881.088431293157, 5712.485876271156, 5713.628614140068, 5723.627964182481, 5732.512736417451, 5791.247137872049, 5323.201519772065, 5350.143976963667, 5437.265969094122, 5808.332041815245, 5867.794627188028, 5389.407165211745, 5399.78400863961, 5470.507654311131, 5497.587680924026, 5506.256655351476, 5510.972445137749, 5555.3333599966645, 5575.080111781511, 5604.159376093618, 5605.5515558756015, 5250.789968401221, 5351.9464805351445, 5357.946420535744, 5437.0, 5456.0, 5403.594730395157, 5467.07059799827, 5546.36216835053, 5550.250716153268, 5574.358948720786, 5303.761330740203, 5401.540869026177, 5500.339959204761, 5525.613207075627, 5530.7511161997], "mootools.html": [1336.9866301336997, 1496.8952173347864, 1546.8143822741272, 1657.0, 1831.4505648305505, 6923.515353925227, 7564.432667549928, 7706.845863082735, 7745.225477452252, 7764.96117519413, 7533.84932301355, 7754.495957762756, 7771.145174030867, 7771.261730135628, 7931.405144614148, 2218.7892150245743, 2234.6312858378346, 2244.494988627562, 2256.6727824465524, 2256.875871827057, 2270.375646697155, 2293.243229734192, 2305.7578954209816, 2321.907123715058, 2324.732655744594, 2208.712867327245, 2210.10490751246, 2221.9333419997424, 2222.5332680137108, 2248.15694114707, 2187.3656639574506, 2195.6047911375945, 2223.566404551113, 2235.508188198602, 2248.303026061926, 2240.7199100112484, 2249.4713742270555, 2262.2760716570706, 2267.172482044042, 2270.0, 6973.546719463218, 7019.92980070203, 7605.505642133299, 7633.618319084079, 7738.535687858746, 4508.887277818048, 4620.330052142454, 4623.214053610895, 4626.86119416418, 4638.744869032202, 2796.6084748135277, 2809.6487939007625, 2834.6031555582235, 2854.200823769348, 2927.209653393572, 835.3943391041507, 860.4450129666393, 863.2748491267365, 884.4914174349775, 886.8403687336277, 10289.382637041801, 10299.485025748758, 10373.429461379621, 10380.273380863267, 10474.947625261824, 4276.5295817460055, 4283.635890949305, 4326.437563116775, 4339.1104823511105, 4351.412559304516, 8991.14584114508, 9027.14242146995, 9110.225630821455, 9112.772180695536, 9115.954420227856, 4779.665423420327, 4801.831935882227, 4807.062622788522, 4832.081904438145, 4832.661713680009, 4368.301071828492, 4395.582419670126, 4395.7582332972, 4403.251447253911, 4412.4043254160915, 3521.436570148764, 3531.911702207465, 3549.290141971616, 3622.855085796539, 3640.2537479816574, 1112.7329440934118, 1134.1153899958047, 1135.8807325230732, 1138.7950168969498, 1140.372794962767, 1285.607889593683, 1309.18830325199, 1321.8149459075737, 1324.8675132486674, 1327.2434712213944, 7194.928050719531, 7242.058532390755, 7262.237465066198, 7283.089613798275, 7291.125064992235, 422.07565431704467, 437.6848668958345, 438.52639149718226, 440.5286343612368, 441.7835260722223, 5371.060064488699, 5783.566232532493, 5827.155062515912, 5841.153032810219, 5847.152162936351, 8087.272145506932, 8894.955525222333, 8985.640574377083, 9015.27877769777, 9031.142041506046, 8773.38586298953, 8918.152775486318, 8920.375573709778, 8985.685501007563, 9021.729348119436, 7211.170715367695, 7314.817129571697, 7321.0116634254755, 7412.851742965218, 7431.628418579049, 7008.7546935857, 7051.612161331176, 7061.929380706332, 7093.32613401726, 7124.145102587515, 8332.208440198172, 8340.791480213044, 8347.582620869054, 8447.704330348408, 8459.746207613782, 8116.959415202886, 8505.702300419704, 8570.871436928326, 8604.225619694258, 8655.3508486865, 7039.260877607778, 7052.576845389293, 7122.038524799293, 7125.216226215009, 7154.678039488132, 7512.812179695551, 7534.773956781305, 7571.3942884568005, 7571.432142589438, 7645.694172233271, 7086.645667716697, 7093.042439270633, 7100.147982242164, 7112.431005519649, 7138.143422789299, 6837.247902730795, 6932.202796678245, 6933.37599616037, 7013.614251216232, 7073.964630176816, 7117.786466405809, 7142.785716428515, 7150.392216661642, 7193.028941092885, 7224.74713385029, 6383.425491705769, 6434.613923164625, 6452.838679033061, 6459.935400645933, 6522.478201743754, 6455.741770329134, 6526.771562995273, 6568.868622627616, 6569.178852643419, 6592.670366481752], "ext.html": [560.3583896438578, 560.7112337146369, 566.8384510414531, 577.2697537614918, 577.8728679690472, 32426.18934526635, 33022.0, 39410.408843867364, 39435.80282098585, 39883.20233595326, 41529.37705934406, 42329.788351058276, 42800.14399712004, 43216.13567728644, 43239.0, 8412.537310447922, 9005.45967241966, 9091.727248182566, 9111.088891110901, 9221.538923053855, 8501.787455313635, 10799.83800242997, 10935.398553079578, 10997.780044399107, 11058.557657693682, 10650.946745266263, 10658.520366583483, 10701.83947240792, 10789.352638841694, 10800.081993030602, 7529.247075292427, 8824.117588241188, 10693.358398496077, 10965.725856853564, 11051.613193538227, 10594.788104237949, 10748.193885458622, 10825.729356766065, 10831.783364332749, 10848.728781780439, 39559.60440395588, 39771.8011409944, 40161.39757903634, 40214.59785402138, 40293.59706402928, 2977.836219007954, 3063.6936306369407, 3109.70457806508, 3431.9485207721905, 3611.404118320474, 26910.73089269102, 27944.0, 27950.860245698845, 28224.717752822413, 28884.8555757222, 2353.646952957053, 2359.893804778789, 2428.854268743881, 2503.0613519930025, 2508.5735424977797, 280477.0, 281974.0, 284674.0, 286287.0, 406984.9650751757, 49889.75055124774, 61271.38728612746, 62420.0, 62425.68787156035, 62468.37531624625, 57216.71391643015, 57745.422545774, 57811.421885780604, 57831.71084144552, 58353.0, 16486.917565412336, 16524.0, 16823.831761682228, 16864.241109150116, 16907.070111144007, 13328.733425331438, 13435.19388836673, 13662.385192666354, 13680.110792798436, 13782.379792909143, 18564.164612592194, 19528.049733463926, 19628.70556941647, 19668.40994770159, 19794.40616781499, 7844.254795794391, 8011.959940200379, 8032.919670803334, 8051.838963220703, 8089.757307280674, 905.8505346617734, 906.3519583497831, 921.3780698028804, 924.408378637659, 942.561708805395, 27270.727292727217, 27288.181354559394, 27310.180694579194, 27582.44835103327, 27853.442931141668, 959.2182371367453, 961.2838435365558, 1072.973175670599, 1096.9725756855983, 1162.581470670558, 11227.38249396291, 14483.068624513162, 14781.26093695311, 14886.404543818342, 14901.701965960838, 314237.0, 317905.0, 318276.0, 318371.0, 320460.0, 50371.24443133356, 51946.740266298424, 52287.47712522902, 52716.20925686118, 52879.20681189785, 1408.9577312680635, 1409.1615488784157, 1415.6036309833264, 1421.2609443089536, 1422.395481920159, 23518.0, 26423.207303780917, 26927.461450771265, 27691.861540692167, 28136.29659258453, 51264.23103653523, 51786.741066294424, 51911.0, 51954.74022629863, 52054.479455204964, 257464.0, 259458.0, 259915.0, 260278.0, 261328.0, 32391.676083238865, 32749.50875736818, 32821.507677385336, 32960.340793184485, 33280.00159995204, 42323.57676423196, 42484.36273455839, 43691.56308436875, 43870.56129438665, 43912.121757565306, 35259.0, 36137.0, 36193.63806361903, 36462.63537364592, 36892.155392229746, 35513.644863552065, 35939.46090808692, 36212.818935905154, 36222.45666314955, 36383.45424818683, 36091.45862812112, 37019.44470832994, 37399.252014959005, 37443.6255637451, 37531.62468375391, 30254.697453025186, 32357.676423236408, 32474.188145296557, 32514.0, 32596.34807303793, 24225.51548969046, 24295.149669761475, 24535.631965520173, 24556.877215613807, 24561.63157552674], "prototype.html": [321.1841921519341, 325.514982675813, 325.6320357995465, 335.68613346521005, 338.47029398990577, 6012.669303188323, 6038.245219347582, 6059.636421814695, 6093.390660933905, 6143.26280846298, 5772.826815195541, 5955.106733989904, 5961.493273071794, 5968.1346204800275, 6034.577579569432, 4630.536946305359, 4636.4436267647925, 4640.83757068501, 4686.9531304687025, 4696.483386827446, 4614.353990441324, 4628.583427491525, 4645.721256724607, 4692.5072867348945, 4707.176244157259, 4512.526184750587, 4565.178267911774, 4620.815167393317, 4625.444946606412, 4628.1669299526075, 4583.152116858392, 4595.195840727876, 4599.149157405891, 4614.630829533629, 4626.930596041062, 3938.6258305460933, 3939.8424063037446, 3982.960170398288, 3987.4218238355566, 3998.7600743955454, 5859.0, 5870.295564532241, 5881.206037184968, 5887.999040163182, 5913.438223368773, 5074.213496907985, 5254.816081437131, 5298.947010529922, 5321.760520776575, 5332.306800115999, 6303.842403939892, 6315.115883776229, 6370.904436433457, 6378.425941665226, 6392.105105285264, 4418.160549495586, 4421.049474363027, 4438.134563760068, 4448.288273876196, 4455.46534415869, 6387.201599800025, 6518.543701940866, 6537.280899101095, 6546.44355229806, 6676.499262555328, 4482.125985432875, 4514.977425112854, 4522.706024108423, 4525.343825145335, 4534.614557762561, 4568.88577785558, 4613.3771940787565, 4616.861494155113, 4619.214733495314, 4620.029793743284, 5278.392984806719, 5305.018571564273, 5320.095583750772, 5325.068113080196, 5330.9733451332495, 6230.408111229426, 6246.625202487774, 6330.746770129143, 6335.809925702236, 6391.9680401598625, 1596.8003999500063, 1657.0471978612345, 1658.0797657300313, 1669.2071266148482, 1685.1153144599184, 1012.448215722433, 1027.6249169053242, 1050.054950544516, 1051.0, 1078.7195329214303, 5983.551233657406, 5995.700214989233, 6036.63780173191, 6039.758409663565, 6063.272407311063, 6435.581687190412, 6441.420272175433, 6567.573107747981, 6567.573107747981, 6573.342665733484, 6003.0, 6005.249343832021, 6009.278886533644, 6013.428724271274, 6083.11794789753, 3571.1072231942017, 3611.963880361163, 3622.945655815165, 3633.6184700606586, 3661.0481274868725, 6441.67791610427, 6649.401553860176, 6711.530192886548, 6724.562903411263, 6733.0, 6712.832179195461, 6737.393634572912, 6748.460123190133, 6793.150856142982, 6891.586504809728, 6688.264290928091, 6724.495662825308, 6751.054852320679, 6754.18949726036, 6759.5944243344575, 6391.6804159792755, 6612.0, 6676.732930682912, 6682.365175308338, 6739.292374300824, 6474.741010359533, 6517.73929042833, 6564.0, 6592.90110648331, 6596.340365963365, 6703.698333575098, 6712.798616041527, 6758.42553382968, 6813.080234168324, 6832.0, 4398.296272596497, 4416.889577760582, 4442.555744425532, 4445.666575006822, 4450.287953927356, 6515.381038801306, 6587.736490540325, 6608.900866486911, 6609.405153536012, 6675.732970681119, 6417.711202995783, 6488.772892948913, 6508.707108180049, 6513.250976137615, 6535.477161826947, 6410.839729006812, 6512.511561632802, 6516.0, 6521.445677117308, 6523.575967562093, 6187.659678717714, 6211.254649442096, 6263.6241825490615, 6308.306086330592, 6327.588706734047, 6359.0, 6439.484841212598, 6445.452136568444, 6454.903176452263, 6455.580387274812, 6060.272767267956, 6254.21822272216, 6314.368563143649, 6327.746890124527, 6340.873182536416], "yui.html": [750.6659536506257, 754.6566312327891, 793.7579038393295, 811.7361857396346, 823.8475881961836, 13998.860011399884, 14303.0, 14337.498187563424, 14390.568282951503, 14409.351579178936, 12421.751564968718, 12861.614151575444, 13005.284709340982, 13187.406566704498, 13305.866941330609, 891.2558014058253, 900.3697411811726, 912.552849103941, 913.3789023464042, 914.3005600715425, 882.5984177199359, 901.9278457723399, 901.9549022548879, 902.5171533229724, 908.2416182487631, 923.3167456082484, 933.2580598424269, 943.4103685196752, 943.7876477792511, 945.1021529546923, 918.4581097152678, 923.5936188077225, 926.8007378413673, 928.2342067794096, 932.7061975477736, 655.7245956698198, 685.7291369908858, 686.9866946254285, 690.4648897104734, 694.2918223412141, 12593.748125037448, 12651.304178270191, 12746.426410811535, 12773.042021848398, 12782.041346898926, 9925.404475731408, 10016.89983100167, 10076.294659373847, 10359.326643768207, 10632.149428045737, 8224.712135075304, 8269.503829770172, 8388.748337549883, 8421.83156336876, 8512.276456501204, 3175.4442972479956, 3234.514822776579, 3235.3529294141267, 3293.324868401996, 3323.933521329584, 42698.57301426977, 42991.14017719628, 48545.0, 50214.0, 50568.24147637789, 9061.592228349607, 9205.079492050741, 9226.723198304062, 9320.254379649612, 9586.808263834684, 19391.709124362864, 19404.805951940583, 19419.32032378888, 19423.223071077282, 19459.610807784047, 7098.751543695946, 7121.501494895308, 7215.170255420694, 7300.926990730131, 7498.3626391756225, 3794.7912864792147, 3827.483289755903, 3846.076941534012, 3870.8645197417954, 3970.8808735737975, 2984.522476403765, 3008.3080891395102, 3027.819150531295, 3030.8787648494254, 3041.2092855857636, 395.96832253419655, 401.12554630904907, 404.17951558336625, 421.71534214405153, 421.8186179942593, 475.96668233224034, 491.7983924650551, 583.7664934026424, 622.6668732228236, 639.7824739588469, 7737.187595302412, 7857.253560911704, 7971.601419929097, 8037.477563958441, 8074.878876816852, 519.9584033277329, 576.1904524143584, 576.3861487515783, 588.4615576747314, 610.8014895159091, 3594.4967704521387, 3865.9226815464094, 3974.125692347679, 4056.492938382702, 4164.8125834337525, 62595.061074083926, 62848.0, 62922.0, 63156.68421657954, 63202.0, 54402.0, 55063.174052389244, 55281.89436211334, 55299.170512442346, 55640.0, 43710.56289437129, 45697.7715111429, 50096.745646446, 50587.49412505901, 50961.49038509642, 7705.730299439717, 7954.284114429498, 7956.2043795619975, 7992.36061115121, 8046.396520260887, 31372.05883823489, 35623.46564801478, 35654.465183022796, 36557.817210913774, 36592.63407365999, 42101.36847947344, 44822.551774481835, 45060.0, 45460.318095227936, 45613.08773824571, 7306.780796576111, 7415.703371865065, 7551.584662843597, 7746.450709857938, 7789.6884124636645, 11067.312159954397, 11087.22389432732, 11319.264247823865, 11355.457021852106, 11482.540698371971, 10142.695719128438, 10193.184545236216, 10252.0, 10314.123299519624, 10328.741781455523, 10353.482325883526, 10452.0, 10459.633912813015, 10509.421981791074, 10599.523021464207, 10274.897251027394, 10282.0, 10282.76606807188, 10311.587536498757, 10316.948415257875, 7508.249175082667, 7612.7716168515035, 7879.763607091796, 7905.56519391439, 8176.959115204386, 7712.498687585289, 7746.92253077462, 7775.183605721318, 7969.561674107747, 7975.322097621535]}, "summary": {"suite": 6588.9046092574945, "subtests": {"jquery.html": {"filtered": 6691.865241527101, "value": 6691.865241527101}, "dojo.html": {"filtered": 5271.89289499051, "value": 5271.89289499051}, "mootools.html": {"filtered": 4335.540571110365, "value": 4335.540571110365}, "ext.html": {"filtered": 18625.432959045622, "value": 18625.432959045622}, "prototype.html": {"filtered": 4806.553772352577, "value": 4806.553772352577}, "yui.html": {"filtered": 5975.0810654982215, "value": 5975.0810654982215}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0016"}, "testrun": {"date": 1448102640, "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": "20151121004041", "branch": "Mozilla-Aurora", "revision": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0], "ai-astar": [106.0, 107.0, 104.0, 106.0, 108.0, 108.0, 97.0, 107.0, 98.0, 107.0], "imaging-gaussian-blur": [121.0, 114.0, 122.0, 115.0, 120.0, 115.0, 120.0, 122.0, 120.0, 120.0], "audio-beat-detection": [153.0, 130.0, 160.0, 153.0, 124.0, 145.0, 124.0, 157.0, 168.0, 126.0], "json-stringify-tinderbox": [65.0, 64.0, 63.0, 67.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0], "stanford-crypto-pbkdf2": [131.0, 144.0, 144.0, 142.0, 141.0, 141.0, 142.0, 141.0, 142.0, 131.0], "json-parse-financial": [60.0, 62.0, 63.0, 63.0, 69.0, 63.0, 64.0, 71.0, 57.0, 57.0], "stanford-crypto-sha256-iterative": [68.0, 68.0, 69.0, 67.0, 67.0, 68.0, 69.0, 67.0, 68.0, 67.0], "audio-fft": [78.0, 81.0, 77.0, 120.0, 69.0, 69.0, 69.0, 71.0, 115.0, 65.0], "imaging-darkroom": [125.0, 124.0, 125.0, 124.0, 123.0, 125.0, 124.0, 124.0, 124.0, 123.0], "stanford-crypto-ccm": [118.0, 119.0, 125.0, 116.0, 127.0, 125.0, 126.0, 117.0, 119.0, 117.0], "audio-oscillator": [100.0, 98.0, 135.0, 87.0, 90.0, 89.0, 126.0, 86.0, 87.0, 130.0], "stanford-crypto-aes": [82.0, 82.0, 81.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 87.0], "imaging-desaturate": [100.0, 102.0, 100.0, 101.0, 104.0, 99.0, 104.0, 99.0, 102.0, 100.0]}, "summary": {"suite": 1477.3000000000002, "subtests": {"audio-fft": {"filtered": 81.4, "value": 81.4}, "stanford-crypto-pbkdf2": {"filtered": 139.9, "value": 139.9}, "audio-beat-detection": {"filtered": 144.0, "value": 144.0}, "stanford-crypto-ccm": {"filtered": 120.9, "value": 120.9}, "imaging-darkroom": {"filtered": 124.1, "value": 124.1}, "json-parse-financial": {"filtered": 62.9, "value": 62.9}, "audio-oscillator": {"filtered": 102.8, "value": 102.8}, "ai-astar": {"filtered": 104.8, "value": 104.8}, "audio-dft": {"filtered": 161.5, "value": 161.5}, "stanford-crypto-sha256-iterative": {"filtered": 67.8, "value": 67.8}, "json-stringify-tinderbox": {"filtered": 64.7, "value": 64.7}, "imaging-gaussian-blur": {"filtered": 118.9, "value": 118.9}, "stanford-crypto-aes": {"filtered": 82.5, "value": 82.5}, "imaging-desaturate": {"filtered": 101.1, "value": 101.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0016"}, "testrun": {"date": 1448102640, "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": "20151121004041", "branch": "Mozilla-Aurora", "revision": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa"}}, {"talos_counters": {}, "results": {"DeltaBlue": [200.8435428800964], "Encrypt": [330.1419610432486], "NavierStokes": [5819.767441860465], "Decrypt": [5747.126436781609], "Splay": [592.4170616113744], "Richards": [166.00265604249668], "RegExp": [29823.529411764706], "Earley": [671.1409395973154], "Boyer": [12822.784810126583], "RayTrace": [1015.2284263959391]}, "summary": {"suite": 20149.035846242637, "subtests": {"DeltaBlue": {"filtered": 329.20152199999995, "value": 329.20152199999995}, "Encrypt": {"filtered": 806.2622489999997, "value": 806.2622489999997}, "NavierStokes": {"filtered": 254.99300699300684, "value": 254.99300699300684}, "Decrypt": {"filtered": 46.31549399999997, "value": 46.31549399999997}, "Splay": {"filtered": 137.55680799999996, "value": 137.55680799999996}, "RegExp": {"filtered": 30.545848126232723, "value": 30.545848126232723}, "Richards": {"filtered": 212.659248, "value": 212.659248}, "Earley": {"filtered": 993.0298700000002, "value": 993.0298700000002}, "Boyer": {"filtered": 51.974903257650524, "value": 51.974903257650524}, "RayTrace": {"filtered": 728.8891649999999, "value": 728.8891649999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0016"}, "testrun": {"date": 1448102640, "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": "20151121004041", "branch": "Mozilla-Aurora", "revision": "1802aa83ee3df1f1f85de08d2c0c7fbb345f7dfa"}}] 03:04:08 INFO - RETURN: dromaeo_css: 6588.90 03:04:08 INFO - RETURN: kraken: 1477.30 03:04:08 INFO - RETURN: v8_7: 20149.04 03:04:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20149.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1477.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6588.90"}}} 03:04:08 INFO - Return code: 0 03:04:08 INFO - # TBPL SUCCESS # 03:04:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:08 INFO - 2015-11-21 03:04:08.987 screenresolution[1667:11226] starting screenresolution argv=screenresolution get 03:04:08 INFO - 2015-11-21 03:04:08.992 screenresolution[1667:11226] Display 0: 1600x1200x32@60 03:04:08 INFO - 2015-11-21 03:04:08.998 screenresolution[1668:11229] starting screenresolution argv=screenresolution list 03:04:09 INFO - Available Modes on Display 0 03:04:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:09 INFO - Intel HD Graphics 3000: 03:04:09 INFO - Chipset Model: Intel HD Graphics 3000 03:04:09 INFO - Type: GPU 03:04:09 INFO - Bus: Built-In 03:04:09 INFO - VRAM (Total): 512 MB 03:04:09 INFO - VRAM (Dynamic, Max): 10 03:04:09 INFO - Vendor: Intel (0x8086) 03:04:09 INFO - Device ID: 0x0116 03:04:09 INFO - Revision ID: 0x0009 03:04:09 INFO - Displays: 03:04:09 INFO - Display: 03:04:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:09 INFO - Display Serial Number: 1600x1200 60 03:04:09 INFO - Main Display: Yes 03:04:09 INFO - Mirror: Off 03:04:09 INFO - Online: Yes 03:04:09 INFO - Rotation: Supported 03:04:09 INFO - Return code: 0 03:04:09 INFO - Running post-action listener: _resource_record_post_action 03:04:09 INFO - Running post-run listener: _resource_record_post_run 03:04:10 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 39248896; Write bytes: 687051776; Read time: 4186; Write time: 55634 03:04:10 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 337775104; Write bytes: 333789184; Read time: 32552; Write time: 7122 03:04:10 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 37323776; Write bytes: 342154240; Read time: 3912; Write time: 47331 03:04:10 INFO - Running post-run listener: _upload_blobber_files 03:04:10 INFO - Blob upload gear active. 03:04:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:04:10 INFO - Copying logs to upload dir... 03:04:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1361.782373 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 41 secs) (at 2015-11-21 03:04:10.400683) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 03:04:10.404290) ========= 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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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/ruC71JEHS3yucot64EuxBg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009876 build_url: 'https://queue.taskcluster.net/v1/task/ruC71JEHS3yucot64EuxBg/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-11-21 03:04:10.425582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:04:10.425906) ========= 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.YSKLOq0NWo/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.50LMgSfZrg/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.004735 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:04:10.475863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 03:04:10.476202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 03:04:10.476617) ========= ========= Total master_lag: 0.88 =========