builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0099 starttime: 1446695134.36 results: success (0) buildid: 20151104182235 builduid: 60bcb8104e1b4f7fb4b9530a4c1863c5 revision: 3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.364470) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.365039) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.365372) ========= 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.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.006082 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.446633) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.446975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.492404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.492821) ========= 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.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.014086 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.562339) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.562662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.563080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.563391) ========= 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.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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-04 19:45:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.3M=0s 2015-11-04 19:45:34 (26.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.766407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.766781) ========= 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.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.123132 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:34.905999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-04 19:45:34.906372) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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-04 19:45:34,997 truncating revision to first 12 chars 2015-11-04 19:45:34,998 Setting DEBUG logging. 2015-11-04 19:45:34,998 attempt 1/10 2015-11-04 19:45:34,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3111b73e96d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-04 19:45:36,041 unpacking tar archive at: mozilla-inbound-3111b73e96d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.357701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-04 19:45:36.283919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:36.284235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:36.300216) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:36.300611) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 19:45:36.301118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-04 19:45:36.301565) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:45:36 INFO - MultiFileLogger online at 20151104 19:45:36 in /builds/slave/test 19:45:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:45:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:45:36 INFO - {'append_to_log': False, 19:45:36 INFO - 'base_work_dir': '/builds/slave/test', 19:45:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:45:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:45:36 INFO - 'branch': 'Mozilla-Inbound', 19:45:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:45:36 INFO - 'config_files': ('talos/mac_config.py',), 19:45:36 INFO - 'default_actions': ('clobber', 19:45:36 INFO - 'read-buildbot-config', 19:45:36 INFO - 'download-and-extract', 19:45:36 INFO - 'populate-webroot', 19:45:36 INFO - 'create-virtualenv', 19:45:36 INFO - 'install', 19:45:36 INFO - 'run-tests'), 19:45:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:45:36 INFO - 'download_minidump_stackwalk': True, 19:45:36 INFO - 'download_symbols': 'ondemand', 19:45:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:45:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:45:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:45:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:45:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:45:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:45:36 INFO - 'installer_path': 'installer.exe', 19:45:36 INFO - 'log_level': 'info', 19:45:36 INFO - 'log_name': 'talos', 19:45:36 INFO - 'log_to_console': True, 19:45:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:45:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:45:36 INFO - 'opt_config_files': (), 19:45:36 INFO - 'pip_index': False, 19:45:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:45:36 INFO - 'cmd': ('bash', 19:45:36 INFO - '-c', 19:45:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:45:36 INFO - 'enabled': True, 19:45:36 INFO - 'halt_on_failure': False, 19:45:36 INFO - 'name': 'check_screen_resolution'},), 19:45:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:45:36 INFO - 'cmd': ('bash', 19:45:36 INFO - '-c', 19:45:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:45:36 INFO - 'enabled': True, 19:45:36 INFO - 'halt_on_failure': False, 19:45:36 INFO - 'name': 'check_screen_resolution'},), 19:45:36 INFO - 'run_cmd_checks_enabled': True, 19:45:36 INFO - 'sps_profile': False, 19:45:36 INFO - 'sps_profile_interval': 0, 19:45:36 INFO - 'suite': 'dromaeojs-e10s', 19:45:36 INFO - 'system_bits': '64', 19:45:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:45:36 INFO - 'title': 't-yosemite-r5-0099', 19:45:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:45:36 INFO - 'use_talos_json': True, 19:45:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:45:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:45:36 INFO - 'work_dir': 'build'} 19:45:36 INFO - ##### 19:45:36 INFO - ##### Running clobber step. 19:45:36 INFO - ##### 19:45:36 INFO - Running pre-action listener: _resource_record_pre_action 19:45:36 INFO - Running main action method: clobber 19:45:36 INFO - rmtree: /builds/slave/test/build 19:45:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:45:39 INFO - Running post-action listener: _resource_record_post_action 19:45:39 INFO - ##### 19:45:39 INFO - ##### Running read-buildbot-config step. 19:45:39 INFO - ##### 19:45:39 INFO - Running pre-action listener: _resource_record_pre_action 19:45:39 INFO - Running main action method: read_buildbot_config 19:45:39 INFO - Using buildbot properties: 19:45:39 INFO - { 19:45:39 INFO - "properties": { 19:45:39 INFO - "buildnumber": 36, 19:45:39 INFO - "product": "firefox", 19:45:39 INFO - "script_repo_revision": "production", 19:45:39 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 19:45:39 INFO - "repository": "", 19:45:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 19:45:39 INFO - "buildid": "20151104182235", 19:45:39 INFO - "slavename": "t-yosemite-r5-0099", 19:45:39 INFO - "pgo_build": "False", 19:45:39 INFO - "basedir": "/builds/slave/test", 19:45:39 INFO - "project": "", 19:45:39 INFO - "platform": "yosemite", 19:45:39 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:45:39 INFO - "slavebuilddir": "test", 19:45:39 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 19:45:39 INFO - "branch": "mozilla-inbound", 19:45:39 INFO - "repo_path": "integration/mozilla-inbound", 19:45:39 INFO - "stage_platform": "macosx64", 19:45:39 INFO - "builduid": "60bcb8104e1b4f7fb4b9530a4c1863c5", 19:45:39 INFO - "revision": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166" 19:45:39 INFO - }, 19:45:39 INFO - "sourcestamp": { 19:45:39 INFO - "repository": "", 19:45:39 INFO - "hasPatch": false, 19:45:39 INFO - "project": "", 19:45:39 INFO - "branch": "mozilla-inbound-macosx64-talos", 19:45:39 INFO - "changes": [ 19:45:39 INFO - { 19:45:39 INFO - "category": null, 19:45:39 INFO - "files": [ 19:45:39 INFO - { 19:45:39 INFO - "url": null, 19:45:39 INFO - "name": "https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:45:39 INFO - } 19:45:39 INFO - ], 19:45:39 INFO - "repository": "", 19:45:39 INFO - "rev": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166", 19:45:39 INFO - "who": "gwright@mozilla.com", 19:45:39 INFO - "when": 1446695107, 19:45:39 INFO - "number": 6622935, 19:45:39 INFO - "comments": "Bug 1111892 - Ensure gdk_ungrab_pointer is always called in the correct process r=jimm", 19:45:39 INFO - "project": "", 19:45:39 INFO - "at": "Wed 04 Nov 2015 19:45:07", 19:45:39 INFO - "branch": "mozilla-inbound-macosx64-talos", 19:45:39 INFO - "revlink": "", 19:45:39 INFO - "properties": [ 19:45:39 INFO - [ 19:45:39 INFO - "buildid", 19:45:39 INFO - "20151104182235", 19:45:39 INFO - "Change" 19:45:39 INFO - ], 19:45:39 INFO - [ 19:45:39 INFO - "builduid", 19:45:39 INFO - "60bcb8104e1b4f7fb4b9530a4c1863c5", 19:45:39 INFO - "Change" 19:45:39 INFO - ], 19:45:39 INFO - [ 19:45:39 INFO - "pgo_build", 19:45:39 INFO - "False", 19:45:39 INFO - "Change" 19:45:39 INFO - ] 19:45:39 INFO - ], 19:45:39 INFO - "revision": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166" 19:45:39 INFO - } 19:45:39 INFO - ], 19:45:39 INFO - "revision": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166" 19:45:39 INFO - } 19:45:39 INFO - } 19:45:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:45:39 INFO - Running post-action listener: _resource_record_post_action 19:45:39 INFO - ##### 19:45:39 INFO - ##### Running download-and-extract step. 19:45:39 INFO - ##### 19:45:39 INFO - Running pre-action listener: _resource_record_pre_action 19:45:39 INFO - Running main action method: download_and_extract 19:45:39 INFO - mkdir: /builds/slave/test/build/tests 19:45: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')]} 19:45:39 INFO - https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/test_packages.json 19:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/test_packages.json 19:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:45:40 INFO - Downloaded 1149 bytes. 19:45:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:45:40 INFO - Using the following test package requirements: 19:45:40 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:45:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:45:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'jsshell-mac.zip'], 19:45:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:45:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:45:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:45:40 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:45:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:45:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:45:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:45:40 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:45:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:40 INFO - https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:45:42 INFO - Downloaded 17458599 bytes. 19:45:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 19:45:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:45:47 INFO - Return code: 0 19:45:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:47 INFO - https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:45:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:45:50 INFO - Downloaded 17458599 bytes. 19:45:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 19:45:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:45:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:45:56 INFO - Return code: 0 19:45: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')]} 19:45:56 INFO - https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:45:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:45:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:45:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:45:57 INFO - Downloaded 11131307 bytes. 19:45:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 19:45:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:45:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:45:57 INFO - Return code: 0 19:45: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')]} 19:45:57 INFO - https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:45:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:45:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:45:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 19:46:02 INFO - Downloaded 108694844 bytes. 19:46:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:46:02 INFO - mkdir: /builds/slave/test/properties 19:46:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:46:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:46:02 INFO - Contents: 19:46:02 INFO - build_url:https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:46:02 INFO - Running post-action listener: _resource_record_post_action 19:46:02 INFO - Running post-action listener: set_extra_try_arguments 19:46:02 INFO - ##### 19:46:02 INFO - ##### Running populate-webroot step. 19:46:02 INFO - ##### 19:46:02 INFO - Running pre-action listener: _resource_record_pre_action 19:46:02 INFO - Running main action method: populate_webroot 19:46:02 INFO - Guessing talos json url... 19:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:02 INFO - https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 19:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 19:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 19:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 19:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 19:46:02 INFO - Downloaded 111 bytes. 19:46:02 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 19:46:02 INFO - Contents: 19:46:02 INFO - 20151104182235 19:46:02 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166 19:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:02 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/3111b73e96/testing/talos/talos.json 19:46:02 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/3111b73e96/testing/talos/talos.json to /builds/slave/test/build/talos.json 19:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/3111b73e96/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 19:46:03 INFO - Downloaded 4264 bytes. 19:46:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:46:03 INFO - '../fennec_ids.txt'], 19:46:03 INFO - 'tests': ['tcheck2']}, 19:46:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:03 INFO - '--tppagecycles', 19:46:03 INFO - '7'], 19:46:03 INFO - 'tests': ['tsvgm']}}, 19:46:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:46:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'tests': ['damp', 'tps']}, 19:46:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['damp', 'tps']}, 19:46:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:46:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:03 INFO - 'other': {'tests': ['a11yr', 19:46:03 INFO - 'ts_paint', 19:46:03 INFO - 'tpaint', 19:46:03 INFO - 'sessionrestore', 19:46:03 INFO - 'sessionrestore_no_auto_restore']}, 19:46:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['a11yr', 19:46:03 INFO - 'ts_paint', 19:46:03 INFO - 'tpaint', 19:46:03 INFO - 'sessionrestore', 19:46:03 INFO - 'sessionrestore_no_auto_restore']}, 19:46:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['a11yr', 19:46:03 INFO - 'ts_paint', 19:46:03 INFO - 'tpaint', 19:46:03 INFO - 'sessionrestore', 19:46:03 INFO - 'sessionrestore_no_auto_restore']}, 19:46:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['a11yr', 19:46:03 INFO - 'ts_paint', 19:46:03 INFO - 'tpaint', 19:46:03 INFO - 'sessionrestore', 19:46:03 INFO - 'sessionrestore_no_auto_restore']}, 19:46:03 INFO - 'other_l64': {'tests': ['a11yr', 19:46:03 INFO - 'ts_paint', 19:46:03 INFO - 'tpaint', 19:46:03 INFO - 'sessionrestore', 19:46:03 INFO - 'sessionrestore_no_auto_restore']}, 19:46:03 INFO - 'other_nol64': {'tests': ['a11yr', 19:46:03 INFO - 'ts_paint', 19:46:03 INFO - 'tpaint', 19:46:03 INFO - 'sessionrestore', 19:46:03 INFO - 'sessionrestore_no_auto_restore']}, 19:46:03 INFO - 'svgr': {'tests': ['tsvgx', 19:46:03 INFO - 'tsvgr_opacity', 19:46:03 INFO - 'tart', 19:46:03 INFO - 'tscrollx', 19:46:03 INFO - 'cart']}, 19:46:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['tsvgx', 19:46:03 INFO - 'tsvgr_opacity', 19:46:03 INFO - 'tart', 19:46:03 INFO - 'tscrollx', 19:46:03 INFO - 'cart']}, 19:46:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'tests': ['tp5o']}, 19:46:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'talos_options': ['--e10s'], 19:46:03 INFO - 'tests': ['tp5o']}, 19:46:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'talos_options': ['--xperf_path', 19:46:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:03 INFO - 'tests': ['tp5n']}, 19:46:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:03 INFO - 'talos_options': ['--e10s', 19:46:03 INFO - '--xperf_path', 19:46:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 19:46:03 INFO - 'C:/slave/talos-data/talos/xperf.config'], 19:46:03 INFO - 'tests': ['tp5n']}}, 19:46:03 INFO - 'talos.zip': {'path': '', 19:46:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:03 INFO - Running post-action listener: _resource_record_post_action 19:46:03 INFO - ##### 19:46:03 INFO - ##### Running create-virtualenv step. 19:46:03 INFO - ##### 19:46:03 INFO - Running pre-action listener: _resource_record_pre_action 19:46:03 INFO - Running main action method: create_virtualenv 19:46:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:46:03 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 19:46:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:46:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:03 INFO - Using real prefix '/tools/python27' 19:46:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:46:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:08 INFO - Installing pip.................done. 19:46:08 INFO - Return code: 0 19:46:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:46:08 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')]} 19:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:08 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')]} 19:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:08 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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:08 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 19:46:08 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 19:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:08 INFO - 'HOME': '/Users/cltbld', 19:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:08 INFO - 'LOGNAME': 'cltbld', 19:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:08 INFO - 'MOZ_NO_REMOTE': '1', 19:46:08 INFO - 'NO_EM_RESTART': '1', 19:46:08 INFO - 'PAGER': '/bin/cat', 19:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:08 INFO - 'PWD': '/builds/slave/test', 19:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:08 INFO - 'SHELL': '/bin/bash', 19:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:08 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:08 INFO - 'USER': 'cltbld', 19:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:08 INFO - 'XPC_FLAGS': '0x0', 19:46:08 INFO - 'XPC_SERVICE_NAME': '0', 19:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:09 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 19:46:09 INFO - Cleaning up... 19:46:09 INFO - Return code: 0 19:46:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:09 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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:09 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 19:46:09 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 19:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:09 INFO - 'HOME': '/Users/cltbld', 19:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:09 INFO - 'LOGNAME': 'cltbld', 19:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:09 INFO - 'MOZ_NO_REMOTE': '1', 19:46:09 INFO - 'NO_EM_RESTART': '1', 19:46:09 INFO - 'PAGER': '/bin/cat', 19:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:09 INFO - 'PWD': '/builds/slave/test', 19:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:09 INFO - 'SHELL': '/bin/bash', 19:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:09 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:09 INFO - 'USER': 'cltbld', 19:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:09 INFO - 'XPC_FLAGS': '0x0', 19:46:09 INFO - 'XPC_SERVICE_NAME': '0', 19:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:10 INFO - Downloading/unpacking psutil>=0.7.1 19:46:10 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 19:46:10 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 19:46:10 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 19:46:10 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 19:46:10 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 19:46:10 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 19:46:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:46:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:13 INFO - Installing collected packages: psutil 19:46:13 INFO - Running setup.py install for psutil 19:46:13 INFO - building 'psutil._psutil_osx' extension 19:46:13 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 19:46:15 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 19:46:15 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 19:46:15 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 19:46:15 INFO - building 'psutil._psutil_posix' extension 19:46:15 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 19:46:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:46:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:46:15 INFO - ^ 19:46:15 INFO - 1 warning generated. 19:46:15 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 19:46:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:15 INFO - Successfully installed psutil 19:46:15 INFO - Cleaning up... 19:46:16 INFO - Return code: 0 19:46:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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', '--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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:16 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 19:46:16 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 19:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:16 INFO - 'HOME': '/Users/cltbld', 19:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:16 INFO - 'LOGNAME': 'cltbld', 19:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:16 INFO - 'MOZ_NO_REMOTE': '1', 19:46:16 INFO - 'NO_EM_RESTART': '1', 19:46:16 INFO - 'PAGER': '/bin/cat', 19:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:16 INFO - 'PWD': '/builds/slave/test', 19:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:16 INFO - 'SHELL': '/bin/bash', 19:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:16 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:16 INFO - 'USER': 'cltbld', 19:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:16 INFO - 'XPC_FLAGS': '0x0', 19:46:16 INFO - 'XPC_SERVICE_NAME': '0', 19:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:46:16 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 19:46:16 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 19:46:16 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 19:46:16 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 19:46:16 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 19:46:16 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 19:46:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:46:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:46:19 INFO - Installing collected packages: mozsystemmonitor 19:46:19 INFO - Running setup.py install for mozsystemmonitor 19:46:19 INFO - Successfully installed mozsystemmonitor 19:46:19 INFO - Cleaning up... 19:46:19 INFO - Return code: 0 19:46:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:19 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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:19 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 19:46:19 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 19:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:19 INFO - 'HOME': '/Users/cltbld', 19:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:19 INFO - 'LOGNAME': 'cltbld', 19:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:19 INFO - 'MOZ_NO_REMOTE': '1', 19:46:19 INFO - 'NO_EM_RESTART': '1', 19:46:19 INFO - 'PAGER': '/bin/cat', 19:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:19 INFO - 'PWD': '/builds/slave/test', 19:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:19 INFO - 'SHELL': '/bin/bash', 19:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:19 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:19 INFO - 'USER': 'cltbld', 19:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:19 INFO - 'XPC_FLAGS': '0x0', 19:46:19 INFO - 'XPC_SERVICE_NAME': '0', 19:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:19 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 19:46:19 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 19:46:19 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 19:46:19 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 19:46:19 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 19:46:19 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 19:46:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46:22 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 19:46:22 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 19:46:22 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 19:46:22 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 19:46:22 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 19:46:22 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 19:46:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:46:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:23 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 19:46:23 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 19:46:23 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 19:46:23 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 19:46:23 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 19:46:23 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 19:46:23 INFO - Downloading docopt-0.6.1.tar.gz 19:46:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:24 INFO - Running setup.py install for blobuploader 19:46:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:46:24 INFO - Running setup.py install for requests 19:46:24 INFO - Running setup.py install for docopt 19:46:25 INFO - Successfully installed blobuploader requests docopt 19:46:25 INFO - Cleaning up... 19:46:25 INFO - Return code: 0 19:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:25 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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:25 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 19:46:25 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 19:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:25 INFO - 'HOME': '/Users/cltbld', 19:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:25 INFO - 'LOGNAME': 'cltbld', 19:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:25 INFO - 'MOZ_NO_REMOTE': '1', 19:46:25 INFO - 'NO_EM_RESTART': '1', 19:46:25 INFO - 'PAGER': '/bin/cat', 19:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:25 INFO - 'PWD': '/builds/slave/test', 19:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:25 INFO - 'SHELL': '/bin/bash', 19:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:25 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:25 INFO - 'USER': 'cltbld', 19:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:25 INFO - 'XPC_FLAGS': '0x0', 19:46:25 INFO - 'XPC_SERVICE_NAME': '0', 19:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:25 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-gq6JrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:25 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-GMwT6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:25 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-rWTr_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-1qJgdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-H46jEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-3DevcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-CwWuCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-f44HJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-ddNSKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:26 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-8R74kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-kTfXuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-yTJnZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-IuHj3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-uaUrR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-EAoovN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-Fi_wla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:27 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-X7Y2_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:28 INFO - Running setup.py install for manifestparser 19:46:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:46:28 INFO - Running setup.py install for mozcrash 19:46:28 INFO - Running setup.py install for mozdebug 19:46:28 INFO - Running setup.py install for mozdevice 19:46:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:46:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:46:28 INFO - Running setup.py install for mozfile 19:46:29 INFO - Running setup.py install for mozhttpd 19:46:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozinfo 19:46:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozInstall 19:46:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozleak 19:46:29 INFO - Running setup.py install for mozlog 19:46:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for moznetwork 19:46:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for mozprocess 19:46:30 INFO - Running setup.py install for mozprofile 19:46:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for mozrunner 19:46:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for mozscreenshot 19:46:31 INFO - Running setup.py install for moztest 19:46:31 INFO - Running setup.py install for mozversion 19:46:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:46:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:31 INFO - Cleaning up... 19:46:31 INFO - Return code: 0 19:46:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:31 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 19:46:31 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 19:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:31 INFO - 'HOME': '/Users/cltbld', 19:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:31 INFO - 'LOGNAME': 'cltbld', 19:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:31 INFO - 'MOZ_NO_REMOTE': '1', 19:46:31 INFO - 'NO_EM_RESTART': '1', 19:46:31 INFO - 'PAGER': '/bin/cat', 19:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:31 INFO - 'PWD': '/builds/slave/test', 19:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:31 INFO - 'SHELL': '/bin/bash', 19:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:31 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:31 INFO - 'USER': 'cltbld', 19:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:31 INFO - 'XPC_FLAGS': '0x0', 19:46:31 INFO - 'XPC_SERVICE_NAME': '0', 19:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:31 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-cYGtRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:31 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:31 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-TpOuIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-wkmD_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-AByEvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-tUHw_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-xyaH9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-f4MU4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-JNHQcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:32 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-ymkmV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:33 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-zuQnYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:33 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-EJIR5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:33 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-U9rSo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:33 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-zj4aij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:33 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-VbnCoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:33 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-l_dHmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:34 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)) 19:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:34 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-XbiYms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:34 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)) 19:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:34 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-GEYiu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:34 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)) 19:46:34 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)) 19:46:34 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)) 19:46:34 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)) 19:46:34 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:34 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:46:34 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 19:46:34 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 19:46:34 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 19:46:34 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 19:46:34 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 19:46:34 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 19:46:37 INFO - Downloading blessings-1.5.1.tar.gz 19:46:37 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 19:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:46:37 INFO - Installing collected packages: blessings 19:46:37 INFO - Running setup.py install for blessings 19:46:37 INFO - Successfully installed blessings 19:46:37 INFO - Cleaning up... 19:46:37 INFO - Return code: 0 19:46:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:37 INFO - Reading from file tmpfile_stdout 19:46:37 INFO - Current package versions: 19:46:37 INFO - blessings == 1.5.1 19:46:37 INFO - blobuploader == 1.2.4 19:46:37 INFO - docopt == 0.6.1 19:46:37 INFO - manifestparser == 1.1 19:46:37 INFO - mozInstall == 1.12 19:46:37 INFO - mozcrash == 0.16 19:46:37 INFO - mozdebug == 0.1 19:46:37 INFO - mozdevice == 0.47 19:46:37 INFO - mozfile == 1.2 19:46:37 INFO - mozhttpd == 0.7 19:46:37 INFO - mozinfo == 0.9 19:46:37 INFO - mozleak == 0.1 19:46:37 INFO - mozlog == 3.0 19:46:37 INFO - moznetwork == 0.27 19:46:37 INFO - mozprocess == 0.22 19:46:37 INFO - mozprofile == 0.27 19:46:37 INFO - mozrunner == 6.11 19:46:37 INFO - mozscreenshot == 0.1 19:46:37 INFO - mozsystemmonitor == 0.0 19:46:37 INFO - moztest == 0.7 19:46:37 INFO - mozversion == 1.4 19:46:37 INFO - psutil == 3.1.1 19:46:37 INFO - requests == 1.2.3 19:46:37 INFO - wsgiref == 0.1.2 19:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x102036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa642725d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, '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.SLHYtREuBu/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.VAjhfS8krP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 19:46:37 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 19:46:37 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 19:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:37 INFO - 'HOME': '/Users/cltbld', 19:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:37 INFO - 'LOGNAME': 'cltbld', 19:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:37 INFO - 'MOZ_NO_REMOTE': '1', 19:46:37 INFO - 'NO_EM_RESTART': '1', 19:46:37 INFO - 'PAGER': '/bin/cat', 19:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:37 INFO - 'PWD': '/builds/slave/test', 19:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:37 INFO - 'SHELL': '/bin/bash', 19:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:46:37 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:37 INFO - 'USER': 'cltbld', 19:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:37 INFO - 'XPC_FLAGS': '0x0', 19:46:37 INFO - 'XPC_SERVICE_NAME': '0', 19:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 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)) 19:46:38 INFO - Cleaning up... 19:46:38 INFO - Return code: 0 19:46:38 INFO - Running post-action listener: _resource_record_post_action 19:46:38 INFO - Running post-action listener: _start_resource_monitoring 19:46:38 INFO - Starting resource monitoring. 19:46:38 INFO - ##### 19:46:38 INFO - ##### Running install step. 19:46:38 INFO - ##### 19:46:38 INFO - Running pre-action listener: _resource_record_pre_action 19:46:38 INFO - Running main action method: install 19:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:38 INFO - Reading from file tmpfile_stdout 19:46:38 INFO - Detecting whether we're running mozinstall >=1.0... 19:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:46:38 INFO - Reading from file tmpfile_stdout 19:46:38 INFO - Output received: 19:46:38 INFO - Usage: mozinstall [options] installer 19:46:38 INFO - Options: 19:46:38 INFO - -h, --help show this help message and exit 19:46:38 INFO - -d DEST, --destination=DEST 19:46:38 INFO - Directory to install application into. [default: 19:46:38 INFO - "/builds/slave/test"] 19:46:38 INFO - --app=APP Application being installed. [default: firefox] 19:46:38 INFO - mkdir: /builds/slave/test/build/application 19:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:47:21 INFO - Reading from file tmpfile_stdout 19:47:21 INFO - Output received: 19:47:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:47:21 INFO - Running post-action listener: _resource_record_post_action 19:47:21 INFO - ##### 19:47:21 INFO - ##### Running run-tests step. 19:47:21 INFO - ##### 19:47:21 INFO - Running pre-action listener: _resource_record_pre_action 19:47:21 INFO - Running main action method: run_tests 19:47:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:22 INFO - 2015-11-04 19:47:22.005 screenresolution[1631:7652] starting screenresolution argv=screenresolution get 19:47:22 INFO - 2015-11-04 19:47:22.009 screenresolution[1631:7652] Display 0: 1600x1200x32@60 19:47:22 INFO - 2015-11-04 19:47:22.016 screenresolution[1632:7654] starting screenresolution argv=screenresolution list 19:47:22 INFO - Available Modes on Display 0 19:47:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:22 INFO - Intel HD Graphics 3000: 19:47:22 INFO - Chipset Model: Intel HD Graphics 3000 19:47:22 INFO - Type: GPU 19:47:22 INFO - Bus: Built-In 19:47:22 INFO - VRAM (Total): 512 MB 19:47:22 INFO - VRAM (Dynamic, Max): 10 19:47:22 INFO - Vendor: Intel (0x8086) 19:47:22 INFO - Device ID: 0x0116 19:47:22 INFO - Revision ID: 0x0009 19:47:22 INFO - Displays: 19:47:22 INFO - Display: 19:47:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:22 INFO - Display Serial Number: 1600x1200 60 19:47:22 INFO - Main Display: Yes 19:47:22 INFO - Mirror: Off 19:47:22 INFO - Online: Yes 19:47:22 INFO - Rotation: Supported 19:47:22 INFO - Return code: 0 19:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:47:22 INFO - Python 2.7.3 19:47:22 INFO - Return code: 0 19:47:22 INFO - grabbing minidump binary from tooltool 19:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:22 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 0x101feb9f0>, '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 0x101d4acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fb5990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:47:22 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 19:47:22 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 19:47:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:22 INFO - Return code: 0 19:47:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:47:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:47:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:47:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:47:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0099', '--webServer', 'localhost'] in /builds/slave/test/build 19:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0099 --webServer localhost 19:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLHYtREuBu/Render', 19:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:22 INFO - 'HOME': '/Users/cltbld', 19:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:22 INFO - 'LOGNAME': 'cltbld', 19:47:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:47:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:22 INFO - 'MOZ_NO_REMOTE': '1', 19:47:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:47:22 INFO - 'NO_EM_RESTART': '1', 19:47:22 INFO - 'PAGER': '/bin/cat', 19:47:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:22 INFO - 'PWD': '/builds/slave/test', 19:47:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:22 INFO - 'SHELL': '/bin/bash', 19:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VAjhfS8krP/Listeners', 19:47:22 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 19:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:22 INFO - 'USER': 'cltbld', 19:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:22 INFO - 'XPC_FLAGS': '0x0', 19:47:22 INFO - 'XPC_SERVICE_NAME': '0', 19:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:47:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0099', '--webServer', 'localhost'] with output_timeout 3600 19:47:22 INFO - mozversion INFO | application_buildid: 20151104182235 19:47:22 INFO - mozversion INFO | application_changeset: 3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166 19:47:22 INFO - mozversion INFO | application_display_name: Nightly 19:47:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:22 INFO - mozversion INFO | application_name: Firefox 19:47:22 INFO - mozversion INFO | application_remotingname: firefox 19:47:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:47:22 INFO - mozversion INFO | application_vendor: Mozilla 19:47:22 INFO - mozversion INFO | application_version: 45.0a1 19:47:22 INFO - mozversion INFO | platform_buildid: 20151104182235 19:47:22 INFO - mozversion INFO | platform_changeset: 3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166 19:47:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:47:22 INFO - mozversion INFO | platform_version: 45.0a1 19:47:22 INFO - 2015-11-04 19:47:22,771 DEBUG : using testdate: 1446695242 19:47:22 INFO - 2015-11-04 19:47:22,771 DEBUG : actual date: 1446695242 19:47:22 INFO - 2015-11-04 19:47:22,820 INFO : starting webserver on 'localhost:49273' 19:47:22 INFO - 2015-11-04 19:47:22,821 INFO : Starting test suite t-yosemite-r5-0099.e 19:47:22 INFO - 2015-11-04 19:47:22,821 INFO : Starting test dromaeo_css 19:47:22 INFO - 2015-11-04 19:47:22,821 DEBUG : operating with platform_type : mac_ 19:47:22 INFO - 2015-11-04 19:47:22,822 INFO : Initialising browser for dromaeo_css test... 19:47:22 INFO - 2015-11-04 19:47:22,852 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmplsN258/profile http://localhost:49273/getInfo.html 19:47:26 INFO - 2015-11-04 19:47:26,684 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:47:26 INFO - 2015-11-04 19:47:26,684 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:47:26 INFO - 2015-11-04 19:47:26,684 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:47:26 INFO - 2015-11-04 19:47:26,684 DEBUG : BROWSER_OUTPUT: __metrics 19:47:27 INFO - 2015-11-04 19:47:27,395 INFO : Browser initialized. 19:47:27 INFO - 2015-11-04 19:47:27,396 INFO : Running cycle 1/1 for dromaeo_css test... 19:47:27 INFO - 2015-11-04 19:47:27,396 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmplsN258/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:47:39 INFO - 2015-11-04 19:47:39,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 233234432 19:47:39 INFO - 2015-11-04 19:47:39,596 DEBUG : BROWSER_OUTPUT: 19:48:29 INFO - 2015-11-04 19:48:29,463 DEBUG : BROWSER_OUTPUT: 1446695309455 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] 19:50:40 INFO - 2015-11-04 19:50:40,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 19:50:41 INFO - 2015-11-04 19:50:41,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 256266240 19:50:41 INFO - 2015-11-04 19:50:41,268 DEBUG : BROWSER_OUTPUT: 19:53:43 INFO - 2015-11-04 19:53:43,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 19:53:43 INFO - 2015-11-04 19:53:43,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 263368704 19:53:43 INFO - 2015-11-04 19:53:43,887 DEBUG : BROWSER_OUTPUT: 19:56:45 INFO - 2015-11-04 19:56:45,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 19:56:46 INFO - 2015-11-04 19:56:46,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 266563584 19:56:46 INFO - 2015-11-04 19:56:46,212 DEBUG : BROWSER_OUTPUT: 19:59:47 INFO - 2015-11-04 19:59:47,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 19:59:48 INFO - 2015-11-04 19:59:48,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 270929920 19:59:48 INFO - 2015-11-04 19:59:48,541 DEBUG : BROWSER_OUTPUT: 20:02:51 INFO - 2015-11-04 20:02:51,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 20:02:51 INFO - 2015-11-04 20:02:51,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 276705280 20:02:51 INFO - 2015-11-04 20:02:51,798 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 20:05:54 INFO - 2015-11-04 20:05:54,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 281595904 20:05:54 INFO - 2015-11-04 20:05:54,332 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,333 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:54 INFO - 2015-11-04 20:05:54,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:54 INFO - 2015-11-04 20:05:54,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:54 INFO - 2015-11-04 20:05:54,333 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:54 INFO - 2015-11-04 20:05:54,333 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2569.2934443028166;2618.1491015419983;2652.4297276085636;2664.280644226059;2686.7716244119247;4334.783260836962;4500.437445319335;4523.954760452394;4585.380973568567;4614.723116613001;4328.329108988104;4337.652987760979;4428.313611390232;4450.599446049855;4514.841980530682;4085.12169883475;4262.126264115849;4267.381229721688;4277.165952639237;4300.440942677447;3991.800409979504;4301.548337424557;4312.396264522969;4337.934930976038;4383.649308055364;4081.2245673321972;4193.077522944947;4199.664026877843;4240.936385954213;4320.5895439933;4210.6841986851105;4214.115035842477;4248.660107191417;4252.659787217046;4261.339492378686;4152.6055024772595;4197.328427451593;4200.6429453496185;4215.725977811432;4225.873223803291;4277.251480990814;4296.806643701041;4326.740395576244;4374.803133858984;4462.3752674625575;4777.450593181759;4837.32277481153;4848.539388758062;4848.587870031051;4881.438634557;4798.712077275374;4904.0191961607825;4905.043516514245;4906.092372911023;4955.6531042826655;4337.262665346899;4373.584509471627;4388.692791504628;4424.75663838492;4517.841875534341;4830.4444988826735;4840.83057093;4932.1122198004705;4934.7285899275885;4974.253861920741;4573.519780423074;4715;4722.150012997693;4742.051589682008;4750.477447480775;4617.0996655651825;4617.653675974316;4640.512746161672;4653.837115700934;4768.76156192196;4554.339620755039;4656.976715116402;4663.626909847204;4703.6942598730975;4709.458412282563;4574.4968053514085;4616.16908956391;4640.23436133041;4647;4723.7638118093955;3544.521489598871;3591.569011718558;3614.584322802859;3648.0150359402815;3658.487811706363;3271.787333823294;3276.45938420158;3336.2326664867214;3348.464245720722;3377.189474526096;4229.365595160689;4375.365571992107;4419;4454.5990860822685;4540.432445944257;4766.142094423037;4800.159972004885;4829.782659780319;4871.098846713369;4893.902121957541;4454.532274111171;4491.618212451913;4521.434820647419;4558.156741002925;4559.954400455953;4110.897227569275;4125.50493940729;4213.220554197484;4241.151769646083;4253.298205796071;4868.78090485929;4884.5603895649565;4887.291342755351;4889.511048895082;4990.451050384382;4843.152448321459;4852.733099679552;4859.538343857328;4899.31409602663;4938.950610493849;4682.0869930364615;4736.952630473789;4749.857504274877;4779.880502987314;4897.706137631753;4698.7415692137265;4772.642051846056;4777.976110119427;4786.832460863992;4827.468978412442;4649.0469453761225;4821.734804585782;4836.854894353175;4838.419389673261;4891.682040667345;4614.653900957374;4615.607673347803;4677.32178834074;4705.6000239979985;4744.359511465908;4618.261078227468;4632.9305060424795;4639.907201856012;4687.32033855096;4687.835925742583;4262.147570485853;4362.236608593547;4564.360989461545;4565.223911935045;4620.006698559691;4540.636749060001;4579.267317229227;4765.070811191785;4772.570468657837;4802.231642937113;4518.231900576976;4571.428571428572;4582.450105987303;4585.747783871919;4613.008203236321 20:05:54 INFO - 2015-11-04 20:05:54,333 DEBUG : BROWSER_OUTPUT: |1;ext.html;437.6127127492168;453.99319010214845;467.8081986385583;476.36881132499434;493.12470365101916;30401.23996900076;31698.20754481139;31845.885394011184;31889.84055079727;32127.35745285093;34826;35565;35680.28639427217;35686.46470302947;36287;7540.84918301635;7736.961315193416;7760.185180556045;7766;7860.724874629389;7531.510451820614;7536.623168841536;7647.961760191219;7666.38668906489;7702.6918923243;7569.053868266466;7686.769396918102;7689.923100769005;7690.384769218477;7709.730159444421;7540.886886696704;7669.501482403626;7678.0786305643405;7678.654460549233;7696.730614428496;7461.477696561243;7575.772726818149;7587.734429294948;7599.848003039963;7607.505512141693;32946.3410731784;33349.6665033349;33353.66646333554;33379.833100834585;33418;2297.862128272309;2353.211674089182;2463.4334103156375;2601.6357709920626;2913.3008078061325;22744.65883011756;22836;23660.64509032366;23862.284131476084;24007.27978160658;1936.390037138311;1956.0415396455635;1973.4474347182668;1974.8716333438424;1983.3157560641555;225882;227170;227724;230733;231236;35091;35692;35826.820865895505;36136;36183.276334473165;34342;34848.82575587106;34864.47703284453;34872.12819679528;35307.29385412329;11356;11483.13876459269;11519;11522.596709115141;11526.36604986717;8947.552622368856;9014.278857691368;9033.141851524095;9119.224865886474;9140.223081038186;11618;11702.88297117018;11716.70708232301;11744.471498782576;11788.351640659846;5181.316072276525;5336.679799211982;5447.1829225616475;5450.155225939986;5458.1266997280245;755.8526087412902;769.9114601820862;783.3419927261015;812.3460614205621;887.6050157679899;22890;23469.647955280685;23490.177843775386;23824.64263036056;23947.16184933519;807.6284908941952;847.9279261262739;860.9354298427643;884.5046773806689;923.6536298887917;11848.644540663794;11981;12096.27422354644;12194.878051219373;12218.20581662189;271639;277007;280789;283241;285174;45000.77499612481;45368;45382.09235815265;45976.31035534403;45982;1151.1021403305435;1152.8731839497648;1159.9826002609968;1160.8026635471822;1160.9361485118231;23581.764182358642;25761.227163185133;26822.597661035492;26865.865670671523;27305.180844574694;44519.55480445283;44564.55435445734;44925;45067.54932450633;45345.31982020338;226594;228352;228624;230528;231845;31643;31709.207269817518;34859.128521787155;35910.461343079354;36829.815850920575;37264.813675931444;38377.61622383852;38530.2293954125;38701.80649096736;40566.39150412687;31306;32201.194970124998;32469.51295730613;32785.91818268172;32802;31178.387890179987;32450.83774581112;34309.313813723085;34469.482957756154;34739.478907816905;32135.357292853543;33265;33324.33351332911;33934.49098263479;33938.49092263568;26222.86888565621;27965.580516291866;28700.712992869805;28748.281292967844;28804.711952880203;21107.683384749547;21256.574868502234;21348.14607415686;21367.14531418726;21570.784292156877 20:05:54 INFO - 2015-11-04 20:05:54,334 DEBUG : BROWSER_OUTPUT: |2;jquery.html;274.8337255960145;278.25844125405797;280.18186894268734;282.2618851702797;286.5701447828257;11940.86561776632;14008;14604.853951460482;14655.267236638152;14817.777733333982;14693.265336733173;14800.851991480082;15336.693266134671;15427.228638568055;15436.536903892873;4315.201687687772;4323.178596066738;4379.321205213197;4434.4678638563255;4447.11057788442;4431.135928493945;4440.7335559866515;4443.688941774077;4475.328700694906;4482.417285752864;3118.1736839737487;3265.306122448982;4392.275274579706;4438.400815889846;4652.395188625491;4810.5670489656095;4815.277708343741;4818.807247710122;4833.854984350458;4890.706557606555;4057.066874618825;4067.1052368478886;4114.218298523271;4138.813753381105;4188.874333769992;17433.12834358277;17439.65120697579;17767.46697599074;17919;18038.90980545102;1631.906622562874;1649.2331066054223;1662.393226472341;1763.7354396840449;2021.2319318658963;7325.890111648329;10642.62750803726;10873;10964.451777411097;11288.492017859217;1280.1550976355654;1315.526410492222;1370.2463644995212;1393.1989106263838;1435.060035676623;47256.291155632694;49095.50904490945;49579.25631115536;49954.50045499535;50225.24662130071;5294.179402192666;5334.253204551366;5362.410134885159;5365.973170134124;5380.219868119101;5965.791197308074;6043.214382130383;6050.031994880798;6054.122152287981;6062.484688801413;4287.871363859027;4313.352997050468;4337.522872484024;4366.214081465367;4366.476022877275;4595.035042641083;4620.052889157714;4625.7687115644085;4626.444826620827;4630.189716799614;2372.003758421467;2383.6305372667266;2405.54294684013;2430.3073624017425;2441.5361081394476;841.8232171244107;847.4195176304252;860.3031544449017;872.5506364222431;917.788908551037;313.01400588147516;334.0846081736026;352.4273056283539;377.94519794630173;384.6038580262334;8037.638306276232;8450.61972211252;8576.614052367659;8585.141485851365;8704.782380440412;335.82872734904885;338.5243732555714;339.9439092549751;348.0914812339791;360.475508135662;4458.5318541553315;4674.570674700325;4695.600873925686;4730.053989202173;4792;455308;456874;469448;473909;474450;55690.16464753032;59248.70375648094;60270.39729602648;60568;61428.38571614316;398.47799382808614;409.56995155087037;410.1591736939263;412.11601115607453;417.0574501626346;8852.867206992029;9000;9034;9106.225970792291;9108.954455227682;28978.420431591672;29863;29972.550411743407;30310.090697279116;30463;41190.908864604055;41337.79331103325;41478.37782433326;41797;41864.581354187285;4933.457319694759;5025.447200807981;5042.647014708935;5045.445001049955;5126.410462796826;9390.906090939003;9403.858942115738;9590.328676992543;9598.520073996133;9750.804983900423;8110.229528194812;8239.176082391952;8364.3726720495;8390.832183356177;8412.915870841458;7942.801429964066;8012.919870801217;8036.678532858854;8175.632096555788;8283.710070147516;8228.25945664893;8506.319494440306;8527.317814574943;8608.78478038054;8622.61198246093;4928.778204980857;4977.626677999092;4985.202367621163;4987.12725273083;4987.950120498748;1762.841344279021;2874.7843911706286;8044.149845535677;8184.8363032737825;8467.53428561435 20:05:54 INFO - 2015-11-04 20:05:54,337 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1124.263607337194;1129.4860838318566;1279.079063074586;1414.6746248362876;1516.173685341489;5199;5346.11789054806;5367.248585198071;5510.090835012218;5674.09214525676;5980.671063091529;6121.173641558388;6134.294556126047;6144.262688477378;6240.3759624037575;1729.835665611768;1756.5432987423299;1761.1722490429477;1767.7171652535596;1779.8487128594086;1729.5848996240939;1756.034181200341;1760.5158581390092;1760.8415242628162;1799.1364145210307;1714.8799584029123;1738.3307426640772;1747.2836137183758;1760.5158581390156;1763.8588912887003;1697.864170866334;1720.1571230097225;1728.3864228198934;1729.4379326718868;1729.9567510812267;1711.2898147268868;1727.3090763694497;1727.7149270370373;1729.5762538178226;1732.3157352845556;6187.8243133804435;6198.411150940653;6221.284552276501;6221.844453888643;6272.905906411407;3622.130688634735;3703.4259689748133;3705.8702945397054;3710.9628903710886;3761.097336639214;2029.4520479470607;2054.7123402723632;2208.9889550552307;2252.076648574077;2374.1334412939327;689.4518857508293;700.7092056796474;700.9228984811666;743.1602289412983;745.2882497215146;7942.801429964239;7959.681612735483;7968.960155199187;8049.51702897828;8074.4347895647325;3328.201231704422;3370.831458427118;3403.914902127417;3433.7081348085194;3462.4113900636953;7090.397316228075;7099.3965512930945;7120.00639820851;7188.245234250433;7204.459665525106;3802.0304822270145;3810.3522401191863;3822.7324087314178;3855.8264878080554;3858.3633700439673;3429.554157959499;3488.8081155536183;3517.261375111204;3531.417316142859;3535.222251104753;2956.2461572298926;2957.1276473440385;2982.806117602349;2991.147522955947;2999.115260997967;906.3836591117971;913;915.716128000322;917.7797328641078;919.2048877720857;1029.0327092532996;1052.1740433759462;1064.8722153341648;1069.390447444949;1082.7996820588216;5874.588778785529;5875.882482350329;5921.200637913913;5939.910901336397;5983.132445795335;331.45475692486207;339.8895359008332;967.709687093869;996.8604395384652;1013.1793247469574;4627.259638457898;4686.671932964659;4690.53094690535;4708.105459962596;4721.173794586002;6592.637404942774;6821.045053692388;7143.214246432888;7149.142102947576;7413.59225242606;7087.362137407658;7172.605506697182;7182.784516464514;7193.136823581203;7332.743353982692;5743.712814359265;5822.534197264209;5856.882862342729;5858.150568167677;5892.351841297454;5594;5716.514096301861;5759.769609215752;5775.036487594238;5822.854428639318;6325.05124231369;6516.706748196438;6537.640429776408;6656.500762442739;6679.0649309097735;6564.9671751640935;6694.899576506259;6704.128463299739;6809.761658341934;6810.216825064983;5204.427512973645;5251.606129540376;5308.416074231909;5330.253764473055;5352.9732351338;5927.673977931255;5971.313298970674;5997.0404735242155;6015.248093988252;6021.879562408815;5555.472230138131;5615.568030152285;5658.801941932013;5667.762487131201;5701.942980570141;5412.079946409041;5530.640508366943;5533.529649979797;5553.305836770403;5589.965856316594;5530.778768849201;5601.355844077983;5602.887942241214;5662.292213473316;5681.4034526374135;5087.4403815581;5134.383873935151;5136.948630513796;5153.613478989016;5186.559142472932;5215.713135777569;5241.240020196974;5241.292425522658;5300.1519756838725;5308.601854860824 20:05:54 INFO - 2015-11-04 20:05:54,339 DEBUG : BROWSER_OUTPUT: |4;prototype.html;255.59871002526035;258.11080826552535;265.675875431973;265.9454811763587;266.0329701534922;5049.469805670397;5112.233165025248;5136.332276804015;5162.38051433828;5223.529882310591;5062.341895553582;5115.7697903594335;5130.897382052357;5169.534741873231;5175.171972484403;3959.623835735615;3976.940345894814;4023.2154729827694;4025.8188381522755;4050.0684842486244;3959.584243654418;3976.065624578222;4019.678425725935;4032.8790136295956;4046.008727861678;3937.2125574884994;3951.3677811550156;4022.6781857451333;4028;4042.514898212204;3998.10042740384;4013.337799263118;4034.576369481221;4036.616521430474;4056.553779084298;3423.6576342365815;3424.383610950028;3461.9826900865587;3466.341395134916;3472.9305413891834;4765.833195838164;4818.229083346683;4857.247126695333;4879.829205977774;5080.77136528857;4315.395844581761;4364.454443194601;4367.279398899178;4379.146066517031;4385.539518350591;5280.339957505312;5282.97358513205;5367.329083864517;5371.060064488738;5372.650777699437;3609.3322735294055;3614.7108231341695;3619.927601447983;3676.191237927652;3679.632036796299;5452.40023597404;5622.072358060874;5633.521150702154;5637.154426835967;5684.8863022739315;3730.813459327023;3735.458358537997;3779.7732136071922;3794.6015668354976;3795.2788970095594;3792.829322680486;3797.240551889633;3805.6194380562274;3865.6520913117956;3878.8448462061765;4400.669949753717;4435.933460998088;4436.0906014267;4461.308497182942;4470.195364834296;5002;5196.714180720021;5373.140297552372;5426.213199086111;5426.647267927651;1347.0570600579633;1354.1468874608934;1354.9390277437342;1374.0725010617793;1374.752544541992;879.3580686099183;894.6779159502574;895.8969718482327;896.6010125494092;915.9404638698463;5014.6991180529285;5029.899402012013;5050.696958182521;5094.465081166498;5095.184770436712;5466.3713672928125;5529.004779139794;5534.225208470817;5553.972230138824;5634.746436410372;5100.6429549931145;5143.691378517301;5143.7685304161405;5149.76826042829;5151.6136289778415;3017.125033740235;3041.057272245611;3064.6628870824193;3110.673379295187;3140.0579826052094;5592.5805564582815;5608.439156084359;5611.438856114356;5715.1713001614535;5728.971355143198;5701.2018317435595;5707.258056452634;5738.167965644958;5791.536677065825;5794.072948328248;5614.831555053192;5640.407757185437;5647.350554686182;5711.428857114339;5721.313442386857;5484.396716361117;5653.660780353192;5661.46216109469;5672.631278966854;5762.250907382014;5497.8075767347955;5611;5629.605927585029;5644.379118297066;5657.745401457027;5695.202671625892;5782.913256301243;5788.594798364074;5791;5858.062709966385;3542.7165826733285;3567.5897271814074;3586.2648157128247;3589.2462582857893;3637.5271214741915;5549.334079910436;5575.526080283222;5610.326760788732;5726.770929162787;5727.770889164553;5346.1713434417725;5438.9122175565835;5462.153366228241;5462.562994960314;5469.699166545878;5433.8369848904595;5442.891142177055;5475.917861232005;5494.2033405155225;5505.146702261156;5209.47905209476;5279.762410691451;5319.840404787863;5328.280682107866;5380.569554435558;5412.431694672003;5491.917621235764;5498.285222920995;5563.721813909369;5568.610197286151;5379.515843574097;5391.568674506108;5395.109806881977;5396.109641909041;5437.40188579248 20:05:54 INFO - 2015-11-04 20:05:54,342 DEBUG : BROWSER_OUTPUT: |5;yui.html;564.2157401212313;598.9490893274074;611.3825036712918;635.3900255754475;640.433216603306;10784.191185661068;11479.368634725086;11503.539858405653;11579.42102894854;11700.707482312935;10663.200259980495;10766.300190487613;10801.13590912727;10976.670699879016;11103.72240693983;743.2975837833236;748.3788455581881;760.1752098972621;761.7905076104088;769.5075151902759;751.5265382808823;758.9848203035936;761.1931352766086;771.2441807029115;771.5178013741412;789.5065584009993;796.036795477473;796.4305521552089;799.9440039197259;800.9959950200241;789.9763007109796;790.4229912164095;790.7667238164755;794.4161041634394;802.8073262417007;583.7898356591623;583.8686295583502;584.1733946465746;586.7564960541371;595.6396380189966;10328.741781455448;10469.895301046969;10477.16649586327;10478.947605262001;10538.947305263502;7975.2423519765525;8140.5115693058015;8153.510789352598;8331.50010999336;8645.178708022728;7173.605451700155;7307.232740562217;7392.408607311402;7659.846803063908;7702.730404435874;2576.3172759218824;2596.6234895939983;2648.205538338491;2758.7930905181993;2807.354308509054;34282.971510854964;35449.64550354489;35722.82138589316;39738.20523589541;40073.39889901654;6921.169459664872;7116.964415177891;7228.457865660096;7275.126984761757;7313.926860731431;15467.5359739208;15525.922370388076;15638.139902305482;15672.373105075898;15767.526974190563;5715.971420142872;5741.081426971665;5886.352501224862;6016.458518733248;6075.088736689444;3039.3921215756936;3072.6312842459047;3074.3851229754137;3123.8594263257755;3171.873125074971;2253.1550668499312;2271.2391348897972;2299.5171014086895;2308.988455057714;2320.083566991063;343.2911038705066;344.720776171302;345.6854262621003;351.8029903254135;351.9348920449725;371.7973704331146;451.7560517320676;470.13025902080875;499.96750211236156;513.3916309173641;6236.314005459396;6631.734730610818;6681.498887583353;6836.418904393083;7292.380147687506;390.3695531716314;401.2416532753099;409.09793904440636;410.8089738271718;429.34739196421265;3093.767967402454;3115.1744787631296;3119.8752049918203;3146.4179126861604;3185.267388500658;50752.746236268584;50918.23622645663;50920.23619645708;51249.74375128175;51824.740876296135;42984;43910.56089439065;44606.776966114965;44611.77694111509;45191.322130168075;34472.655273447446;35820.46269305963;38551.22897542034;39178.804105979856;41281.380779288935;6584.275729669636;6729.73081076771;6806.6256355900905;6852.657367131723;6933.2720064392515;28747.5687864678;29820.403591928472;30000;30251.394972100876;30513.542296865122;35933.1016724584;36349.636503634625;36894.446583300734;39910.800445997585;40205;5994.13085102649;6079;6156.107364432221;6166.414190651881;6270.310265870659;9025.323100767337;9317.254619630548;9327.673531426368;9383.249340052917;9628.277879159232;8646.697365592174;8873.64505419776;8916.55417229123;9376.57805398745;9408.717738467856;8672.78318042054;8883.644654213758;8941.284697224077;8953.597088130919;9391.248700104112;8518.616662250337;8588.914110859061;8602.827943441222;8625.266852317623;9010.927486677969;7210.1708303545765;7323.816904577428;7507.849843003219;7684.923150768421;7740.187280335484;6687.431568316748;6962.338577835098;7092.751753688803;7525.134609519975;7858.921410785819 20:05:54 INFO - 2015-11-04 20:05:54,343 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:54 INFO - 2015-11-04 20:05:54,343 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:05:54 INFO - 2015-11-04 20:05:54,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 20:05:54 INFO - 2015-11-04 20:05:54,343 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:05:54 INFO - 2015-11-04 20:05:54,343 DEBUG : BROWSER_OUTPUT: __startTimestamp1446696354327__endTimestamp 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4449.44 Median:4574.50 stddev:478.85 (10.5%) stddev-sans-first:457.04 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: Values: 2569.3 2618.1 2652.4 2664.3 2686.8 4334.8 4500.4 4524.0 4585.4 4614.7 4328.3 4337.7 4428.3 4450.6 4514.8 4085.1 4262.1 4267.4 4277.2 4300.4 3991.8 4301.5 4312.4 4337.9 4383.6 4081.2 4193.1 4199.7 4240.9 4320.6 4210.7 4214.1 4248.7 4252.7 4261.3 4152.6 4197.3 4200.6 4215.7 4225.9 4277.3 4296.8 4326.7 4374.8 4462.4 4777.5 4837.3 4848.5 4848.6 4881.4 4798.7 4904.0 4905.0 4906.1 4955.7 4337.3 4373.6 4388.7 4424.8 4517.8 4830.4 4840.8 4932.1 4934.7 4974.3 4573.5 4715.0 4722.2 4742.1 4750.5 4617.1 4617.7 4640.5 4653.8 4768.8 4554.3 4657.0 4663.6 4703.7 4709.5 4574.5 4616.2 4640.2 4647.0 4723.8 3544.5 3591.6 3614.6 3648.0 3658.5 3271.8 3276.5 3336.2 3348.5 3377.2 4229.4 4375.4 4419.0 4454.6 4540.4 4766.1 4800.2 4829.8 4871.1 4893.9 4454.5 4491.6 4521.4 4558.2 4560.0 4110.9 4125.5 4213.2 4241.2 4253.3 4868.8 4884.6 4887.3 4889.5 4990.5 4843.2 4852.7 4859.5 4899.3 4939.0 4682.1 4737.0 4749.9 4779.9 4897.7 4698.7 4772.6 4778.0 4786.8 4827.5 4649.0 4821.7 4836.9 4838.4 4891.7 4614.7 4615.6 4677.3 4705.6 4744.4 4618.3 4632.9 4639.9 4687.3 4687.8 4262.1 4362.2 4564.4 4565.2 4620.0 4540.6 4579.3 4765.1 4772.6 4802.2 4518.2 4571.4 4582.5 4585.7 4613.0 20:05:54 INFO - 2015-11-04 20:05:54,344 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,345 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38581.61 Median:33398.92 stddev:64541.72 (193.2%) stddev-sans-first:64659.23 20:05:54 INFO - 2015-11-04 20:05:54,345 DEBUG : BROWSER_OUTPUT: Values: 437.6 454.0 467.8 476.4 493.1 30401.2 31698.2 31845.9 31889.8 32127.4 34826.0 35565.0 35680.3 35686.5 36287.0 7540.8 7737.0 7760.2 7766.0 7860.7 7531.5 7536.6 7648.0 7666.4 7702.7 7569.1 7686.8 7689.9 7690.4 7709.7 7540.9 7669.5 7678.1 7678.7 7696.7 7461.5 7575.8 7587.7 7599.8 7607.5 32946.3 33349.7 33353.7 33379.8 33418.0 2297.9 2353.2 2463.4 2601.6 2913.3 22744.7 22836.0 23660.6 23862.3 24007.3 1936.4 1956.0 1973.4 1974.9 1983.3 225882.0 227170.0 227724.0 230733.0 231236.0 35091.0 35692.0 35826.8 36136.0 36183.3 34342.0 34848.8 34864.5 34872.1 35307.3 11356.0 11483.1 11519.0 11522.6 11526.4 8947.6 9014.3 9033.1 9119.2 9140.2 11618.0 11702.9 11716.7 11744.5 11788.4 5181.3 5336.7 5447.2 5450.2 5458.1 755.9 769.9 783.3 812.3 887.6 22890.0 23469.6 23490.2 23824.6 23947.2 807.6 847.9 860.9 884.5 923.7 11848.6 11981.0 12096.3 12194.9 12218.2 271639.0 277007.0 280789.0 283241.0 285174.0 45000.8 45368.0 45382.1 45976.3 45982.0 1151.1 1152.9 1160.0 1160.8 1160.9 23581.8 25761.2 26822.6 26865.9 27305.2 44519.6 44564.6 44925.0 45067.5 45345.3 226594.0 228352.0 228624.0 230528.0 231845.0 31643.0 31709.2 34859.1 35910.5 36829.8 37264.8 38377.6 38530.2 38701.8 40566.4 31306.0 32201.2 32469.5 32785.9 32802.0 31178.4 32450.8 34309.3 34469.5 34739.5 32135.4 33265.0 33324.3 33934.5 33938.5 26222.9 27965.6 28700.7 28748.3 28804.7 21107.7 21256.6 21348.1 21367.1 21570.8 20:05:54 INFO - 2015-11-04 20:05:54,345 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,345 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22931.33 Median:229895.21 stddev:76315.19 (33.2%) stddev-sans-first:76510.31 20:05:54 INFO - 2015-11-04 20:05:54,346 DEBUG : BROWSER_OUTPUT: Values: 274.8 278.3 280.2 282.3 286.6 11940.9 14008.0 14604.9 14655.3 14817.8 14693.3 14800.9 15336.7 15427.2 15436.5 4315.2 4323.2 4379.3 4434.5 4447.1 4431.1 4440.7 4443.7 4475.3 4482.4 3118.2 3265.3 4392.3 4438.4 4652.4 4810.6 4815.3 4818.8 4833.9 4890.7 4057.1 4067.1 4114.2 4138.8 4188.9 17433.1 17439.7 17767.5 17919.0 18038.9 1631.9 1649.2 1662.4 1763.7 2021.2 7325.9 10642.6 10873.0 10964.5 11288.5 1280.2 1315.5 1370.2 1393.2 1435.1 47256.3 49095.5 49579.3 49954.5 50225.2 5294.2 5334.3 5362.4 5366.0 5380.2 5965.8 6043.2 6050.0 6054.1 6062.5 4287.9 4313.4 4337.5 4366.2 4366.5 4595.0 4620.1 4625.8 4626.4 4630.2 2372.0 2383.6 2405.5 2430.3 2441.5 841.8 847.4 860.3 872.6 917.8 313.0 334.1 352.4 377.9 384.6 8037.6 8450.6 8576.6 8585.1 8704.8 335.8 338.5 339.9 348.1 360.5 4458.5 4674.6 4695.6 4730.1 4792.0 455308.0 456874.0 469448.0 473909.0 474450.0 55690.2 59248.7 60270.4 60568.0 61428.4 398.5 409.6 410.2 412.1 417.1 8852.9 9000.0 9034.0 9106.2 9109.0 28978.4 29863.0 29972.6 30310.1 30463.0 41190.9 41337.8 41478.4 41797.0 41864.6 4933.5 5025.4 5042.6 5045.4 5126.4 9390.9 9403.9 9590.3 9598.5 9750.8 8110.2 8239.2 8364.4 8390.8 8412.9 7942.8 8012.9 8036.7 8175.6 8283.7 8228.3 8506.3 8527.3 8608.8 8622.6 4928.8 4977.6 4985.2 4987.1 4988.0 1762.8 2874.8 8044.1 8184.8 8467.5 20:05:54 INFO - 2015-11-04 20:05:54,347 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,347 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4278.57 Median:5389.66 stddev:2193.32 (40.7%) stddev-sans-first:2186.66 20:05:54 INFO - 2015-11-04 20:05:54,348 DEBUG : BROWSER_OUTPUT: Values: 1124.3 1129.5 1279.1 1414.7 1516.2 5199.0 5346.1 5367.2 5510.1 5674.1 5980.7 6121.2 6134.3 6144.3 6240.4 1729.8 1756.5 1761.2 1767.7 1779.8 1729.6 1756.0 1760.5 1760.8 1799.1 1714.9 1738.3 1747.3 1760.5 1763.9 1697.9 1720.2 1728.4 1729.4 1730.0 1711.3 1727.3 1727.7 1729.6 1732.3 6187.8 6198.4 6221.3 6221.8 6272.9 3622.1 3703.4 3705.9 3711.0 3761.1 2029.5 2054.7 2209.0 2252.1 2374.1 689.5 700.7 700.9 743.2 745.3 7942.8 7959.7 7969.0 8049.5 8074.4 3328.2 3370.8 3403.9 3433.7 3462.4 7090.4 7099.4 7120.0 7188.2 7204.5 3802.0 3810.4 3822.7 3855.8 3858.4 3429.6 3488.8 3517.3 3531.4 3535.2 2956.2 2957.1 2982.8 2991.1 2999.1 906.4 913.0 915.7 917.8 919.2 1029.0 1052.2 1064.9 1069.4 1082.8 5874.6 5875.9 5921.2 5939.9 5983.1 331.5 339.9 967.7 996.9 1013.2 4627.3 4686.7 4690.5 4708.1 4721.2 6592.6 6821.0 7143.2 7149.1 7413.6 7087.4 7172.6 7182.8 7193.1 7332.7 5743.7 5822.5 5856.9 5858.2 5892.4 5594.0 5716.5 5759.8 5775.0 5822.9 6325.1 6516.7 6537.6 6656.5 6679.1 6565.0 6694.9 6704.1 6809.8 6810.2 5204.4 5251.6 5308.4 5330.3 5353.0 5927.7 5971.3 5997.0 6015.2 6021.9 5555.5 5615.6 5658.8 5667.8 5701.9 5412.1 5530.6 5533.5 5553.3 5590.0 5530.8 5601.4 5602.9 5662.3 5681.4 5087.4 5134.4 5136.9 5153.6 5186.6 5215.7 5241.2 5241.3 5300.2 5308.6 20:05:54 INFO - 2015-11-04 20:05:54,349 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,349 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4518.77 Median:5150.69 stddev:1366.79 (26.5%) stddev-sans-first:1332.64 20:05:54 INFO - 2015-11-04 20:05:54,350 DEBUG : BROWSER_OUTPUT: Values: 255.6 258.1 265.7 265.9 266.0 5049.5 5112.2 5136.3 5162.4 5223.5 5062.3 5115.8 5130.9 5169.5 5175.2 3959.6 3976.9 4023.2 4025.8 4050.1 3959.6 3976.1 4019.7 4032.9 4046.0 3937.2 3951.4 4022.7 4028.0 4042.5 3998.1 4013.3 4034.6 4036.6 4056.6 3423.7 3424.4 3462.0 3466.3 3472.9 4765.8 4818.2 4857.2 4879.8 5080.8 4315.4 4364.5 4367.3 4379.1 4385.5 5280.3 5283.0 5367.3 5371.1 5372.7 3609.3 3614.7 3619.9 3676.2 3679.6 5452.4 5622.1 5633.5 5637.2 5684.9 3730.8 3735.5 3779.8 3794.6 3795.3 3792.8 3797.2 3805.6 3865.7 3878.8 4400.7 4435.9 4436.1 4461.3 4470.2 5002.0 5196.7 5373.1 5426.2 5426.6 1347.1 1354.1 1354.9 1374.1 1374.8 879.4 894.7 895.9 896.6 915.9 5014.7 5029.9 5050.7 5094.5 5095.2 5466.4 5529.0 5534.2 5554.0 5634.7 5100.6 5143.7 5143.8 5149.8 5151.6 3017.1 3041.1 3064.7 3110.7 3140.1 5592.6 5608.4 5611.4 5715.2 5729.0 5701.2 5707.3 5738.2 5791.5 5794.1 5614.8 5640.4 5647.4 5711.4 5721.3 5484.4 5653.7 5661.5 5672.6 5762.3 5497.8 5611.0 5629.6 5644.4 5657.7 5695.2 5782.9 5788.6 5791.0 5858.1 3542.7 3567.6 3586.3 3589.2 3637.5 5549.3 5575.5 5610.3 5726.8 5727.8 5346.2 5438.9 5462.2 5462.6 5469.7 5433.8 5442.9 5475.9 5494.2 5505.1 5209.5 5279.8 5319.8 5328.3 5380.6 5412.4 5491.9 5498.3 5563.7 5568.6 5379.5 5391.6 5395.1 5396.1 5437.4 20:05:54 INFO - 2015-11-04 20:05:54,350 DEBUG : BROWSER_OUTPUT: 20:05:54 INFO - 2015-11-04 20:05:54,350 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11173.35 Median:585.46 stddev:13614.89 (2325.5%) stddev-sans-first:13629.77 20:05:54 INFO - 2015-11-04 20:05:54,352 DEBUG : BROWSER_OUTPUT: Values: 564.2 598.9 611.4 635.4 640.4 10784.2 11479.4 11503.5 11579.4 11700.7 10663.2 10766.3 10801.1 10976.7 11103.7 743.3 748.4 760.2 761.8 769.5 751.5 759.0 761.2 771.2 771.5 789.5 796.0 796.4 799.9 801.0 790.0 790.4 790.8 794.4 802.8 583.8 583.9 584.2 586.8 595.6 10328.7 10469.9 10477.2 10478.9 10538.9 7975.2 8140.5 8153.5 8331.5 8645.2 7173.6 7307.2 7392.4 7659.8 7702.7 2576.3 2596.6 2648.2 2758.8 2807.4 34283.0 35449.6 35722.8 39738.2 40073.4 6921.2 7117.0 7228.5 7275.1 7313.9 15467.5 15525.9 15638.1 15672.4 15767.5 5716.0 5741.1 5886.4 6016.5 6075.1 3039.4 3072.6 3074.4 3123.9 3171.9 2253.2 2271.2 2299.5 2309.0 2320.1 343.3 344.7 345.7 351.8 351.9 371.8 451.8 470.1 500.0 513.4 6236.3 6631.7 6681.5 6836.4 7292.4 390.4 401.2 409.1 410.8 429.3 3093.8 3115.2 3119.9 3146.4 3185.3 50752.7 50918.2 50920.2 51249.7 51824.7 42984.0 43910.6 44606.8 44611.8 45191.3 34472.7 35820.5 38551.2 39178.8 41281.4 6584.3 6729.7 6806.6 6852.7 6933.3 28747.6 29820.4 30000.0 30251.4 30513.5 35933.1 36349.6 36894.4 39910.8 40205.0 5994.1 6079.0 6156.1 6166.4 6270.3 9025.3 9317.3 9327.7 9383.2 9628.3 8646.7 8873.6 8916.6 9376.6 9408.7 8672.8 8883.6 8941.3 8953.6 9391.2 8518.6 8588.9 8602.8 8625.3 9010.9 7210.2 7323.8 7507.8 7684.9 7740.2 6687.4 6962.3 7092.8 7525.1 7858.9 20:05:54 INFO - 2015-11-04 20:05:54,352 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:54 INFO - 2015-11-04 20:05:54,352 DEBUG : BROWSER_OUTPUT: 20:05:55 INFO - 2015-11-04 20:05:55,052 INFO : Browser exited with error code: 0 20:05:55 INFO - 2015-11-04 20:05:55,086 INFO : Completed test dromaeo_css (00:18:32) 20:05:55 INFO - 2015-11-04 20:05:55,086 INFO : Starting test kraken 20:05:55 INFO - 2015-11-04 20:05:55,086 DEBUG : operating with platform_type : mac_ 20:05:55 INFO - 2015-11-04 20:05:55,087 INFO : Initialising browser for kraken test... 20:05:55 INFO - 2015-11-04 20:05:55,103 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpNroS0j/profile http://localhost:49273/getInfo.html 20:05:58 INFO - 2015-11-04 20:05:58,343 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:58 INFO - 2015-11-04 20:05:58,344 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:58 INFO - 2015-11-04 20:05:58,344 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:05:58 INFO - 2015-11-04 20:05:58,344 DEBUG : BROWSER_OUTPUT: __metrics 20:05:59 INFO - 2015-11-04 20:05:59,117 INFO : Browser initialized. 20:05:59 INFO - 2015-11-04 20:05:59,118 INFO : Running cycle 1/1 for kraken test... 20:05:59 INFO - 2015-11-04 20:05:59,118 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpNroS0j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:06:11 INFO - 2015-11-04 20:06:11,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 232738816 20:06:11 INFO - 2015-11-04 20:06:11,269 DEBUG : BROWSER_OUTPUT: 20:06:14 INFO - 2015-11-04 20:06:14,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:14 INFO - 2015-11-04 20:06:14,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 251686912 20:06:14 INFO - 2015-11-04 20:06:14,842 DEBUG : BROWSER_OUTPUT: 20:06:17 INFO - 2015-11-04 20:06:17,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 20:06:18 INFO - 2015-11-04 20:06:18,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 260018176 20:06:18 INFO - 2015-11-04 20:06:18,595 DEBUG : BROWSER_OUTPUT: 20:06:22 INFO - 2015-11-04 20:06:22,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 20:06:22 INFO - 2015-11-04 20:06:22,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 259166208 20:06:22 INFO - 2015-11-04 20:06:22,602 DEBUG : BROWSER_OUTPUT: 20:06:24 INFO - 2015-11-04 20:06:24,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 20:06:25 INFO - 2015-11-04 20:06:25,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 259567616 20:06:25 INFO - 2015-11-04 20:06:25,439 DEBUG : BROWSER_OUTPUT: 20:06:27 INFO - 2015-11-04 20:06:27,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:28 INFO - 2015-11-04 20:06:28,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 260313088 20:06:28 INFO - 2015-11-04 20:06:28,477 DEBUG : BROWSER_OUTPUT: 20:06:32 INFO - 2015-11-04 20:06:32,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:32 INFO - 2015-11-04 20:06:32,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 257949696 20:06:32 INFO - 2015-11-04 20:06:32,672 DEBUG : BROWSER_OUTPUT: 20:06:36 INFO - 2015-11-04 20:06:36,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:37 INFO - 2015-11-04 20:06:37,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 258789376 20:06:37 INFO - 2015-11-04 20:06:37,030 DEBUG : BROWSER_OUTPUT: 20:06:40 INFO - 2015-11-04 20:06:40,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 20:06:41 INFO - 2015-11-04 20:06:41,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 257855488 20:06:41 INFO - 2015-11-04 20:06:41,067 DEBUG : BROWSER_OUTPUT: 20:06:42 INFO - 2015-11-04 20:06:42,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:06:43 INFO - 2015-11-04 20:06:43,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 259432448 20:06:43 INFO - 2015-11-04 20:06:43,440 DEBUG : BROWSER_OUTPUT: 20:06:45 INFO - 2015-11-04 20:06:45,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:06:46 INFO - 2015-11-04 20:06:46,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 260063232 20:06:46 INFO - 2015-11-04 20:06:46,123 DEBUG : BROWSER_OUTPUT: 20:06:48 INFO - 2015-11-04 20:06:48,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:06:49 INFO - 2015-11-04 20:06:49,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 260128768 20:06:49 INFO - 2015-11-04 20:06:49,160 DEBUG : BROWSER_OUTPUT: 20:06:52 INFO - 2015-11-04 20:06:52,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:06:52 INFO - 2015-11-04 20:06:52,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 259997696 20:06:52 INFO - 2015-11-04 20:06:52,812 DEBUG : BROWSER_OUTPUT: 20:06:55 INFO - 2015-11-04 20:06:55,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:06:56 INFO - 2015-11-04 20:06:56,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 259911680 20:06:56 INFO - 2015-11-04 20:06:56,475 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 20:06:58 INFO - 2015-11-04 20:06:58,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 260734976 20:06:58 INFO - 2015-11-04 20:06:58,687 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,687 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:06:58 INFO - 2015-11-04 20:06:58,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:06:58 INFO - 2015-11-04 20:06:58,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:06:58 INFO - 2015-11-04 20:06:58,688 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:06:58 INFO - 2015-11-04 20:06:58,688 DEBUG : BROWSER_OUTPUT: |0;ai-astar;135;131;143;142;143;154;142;138;134;136 20:06:58 INFO - 2015-11-04 20:06:58,688 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;188;172;192;205;171;198;197;164;206;164 20:06:58 INFO - 2015-11-04 20:06:58,688 DEBUG : BROWSER_OUTPUT: |2;audio-dft;204;216;210;210;210;211;211;212;203;209 20:06:58 INFO - 2015-11-04 20:06:58,689 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;90;100;151;84;90;91;90;117;86 20:06:58 INFO - 2015-11-04 20:06:58,689 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;109;159;111;114;115;157;114;117;161 20:06:58 INFO - 2015-11-04 20:06:58,689 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;139;158;157;158;151;157;151;150;156;151 20:06:58 INFO - 2015-11-04 20:06:58,689 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;165;165;165;164;164;166;168;164;159;164 20:06:58 INFO - 2015-11-04 20:06:58,689 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;133;136;138;139;139;141;136;135;135;133 20:06:58 INFO - 2015-11-04 20:06:58,690 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;76;77;80;80;80;87;79;81 20:06:58 INFO - 2015-11-04 20:06:58,690 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;82;83;89;86;88;90;88;89;85 20:06:58 INFO - 2015-11-04 20:06:58,691 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;106;112;115;114;113;114;112;116;116;118 20:06:58 INFO - 2015-11-04 20:06:58,692 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;168;173;161;167;159;173;166;169;158;170 20:06:58 INFO - 2015-11-04 20:06:58,692 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;187;203;185;196;186;179;204;199;200;196 20:06:58 INFO - 2015-11-04 20:06:58,692 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;84;92;93;94;91;93;93;94;91 20:06:58 INFO - 2015-11-04 20:06:58,692 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:06:58 INFO - 2015-11-04 20:06:58,692 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:06:58 INFO - 2015-11-04 20:06:58,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,759 20:06:58 INFO - 2015-11-04 20:06:58,693 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:06:58 INFO - 2015-11-04 20:06:58,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1446696418686__endTimestamp 20:06:58 INFO - 2015-11-04 20:06:58,693 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:06:58 INFO - 2015-11-04 20:06:58,694 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:06:58 INFO - 2015-11-04 20:06:58,694 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,694 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:139.80 Median:142.00 stddev:6.53 (4.6%) stddev-sans-first:6.69 20:06:58 INFO - 2015-11-04 20:06:58,694 DEBUG : BROWSER_OUTPUT: Values: 135.0 131.0 143.0 142.0 143.0 154.0 142.0 138.0 134.0 136.0 20:06:58 INFO - 2015-11-04 20:06:58,694 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,696 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:185.70 Median:194.50 stddev:16.51 (8.5%) stddev-sans-first:17.49 20:06:58 INFO - 2015-11-04 20:06:58,696 DEBUG : BROWSER_OUTPUT: Values: 188.0 172.0 192.0 205.0 171.0 198.0 197.0 164.0 206.0 164.0 20:06:58 INFO - 2015-11-04 20:06:58,696 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,696 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:209.60 Median:210.50 stddev:3.75 (1.8%) stddev-sans-first:3.38 20:06:58 INFO - 2015-11-04 20:06:58,696 DEBUG : BROWSER_OUTPUT: Values: 204.0 216.0 210.0 210.0 210.0 211.0 211.0 212.0 203.0 209.0 20:06:58 INFO - 2015-11-04 20:06:58,696 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,697 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.60 Median:88.00 stddev:21.59 (24.5%) stddev-sans-first:21.57 20:06:58 INFO - 2015-11-04 20:06:58,697 DEBUG : BROWSER_OUTPUT: Values: 77.0 90.0 100.0 151.0 84.0 90.0 91.0 90.0 117.0 86.0 20:06:58 INFO - 2015-11-04 20:06:58,697 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,697 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:125.80 Median:116.00 stddev:23.34 (20.1%) stddev-sans-first:22.97 20:06:58 INFO - 2015-11-04 20:06:58,697 DEBUG : BROWSER_OUTPUT: Values: 101.0 109.0 159.0 111.0 114.0 115.0 157.0 114.0 117.0 161.0 20:06:58 INFO - 2015-11-04 20:06:58,698 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,698 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:152.80 Median:156.50 stddev:5.85 (3.7%) stddev-sans-first:3.46 20:06:58 INFO - 2015-11-04 20:06:58,698 DEBUG : BROWSER_OUTPUT: Values: 139.0 158.0 157.0 158.0 151.0 157.0 151.0 150.0 156.0 151.0 20:06:58 INFO - 2015-11-04 20:06:58,698 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,698 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:164.40 Median:165.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 20:06:58 INFO - 2015-11-04 20:06:58,699 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 165.0 164.0 164.0 166.0 168.0 164.0 159.0 164.0 20:06:58 INFO - 2015-11-04 20:06:58,699 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,699 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:136.50 Median:137.00 stddev:2.68 (2.0%) stddev-sans-first:2.52 20:06:58 INFO - 2015-11-04 20:06:58,699 DEBUG : BROWSER_OUTPUT: Values: 133.0 136.0 138.0 139.0 139.0 141.0 136.0 135.0 135.0 133.0 20:06:58 INFO - 2015-11-04 20:06:58,699 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,699 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:78.70 Median:80.00 stddev:4.00 (5.0%) stddev-sans-first:3.67 20:06:58 INFO - 2015-11-04 20:06:58,700 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 76.0 77.0 80.0 80.0 80.0 87.0 79.0 81.0 20:06:58 INFO - 2015-11-04 20:06:58,700 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,700 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.70 Median:88.00 stddev:4.06 (4.6%) stddev-sans-first:2.83 20:06:58 INFO - 2015-11-04 20:06:58,700 DEBUG : BROWSER_OUTPUT: Values: 77.0 82.0 83.0 89.0 86.0 88.0 90.0 88.0 89.0 85.0 20:06:58 INFO - 2015-11-04 20:06:58,700 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,700 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:113.60 Median:114.50 stddev:3.27 (2.9%) stddev-sans-first:2.01 20:06:58 INFO - 2015-11-04 20:06:58,701 DEBUG : BROWSER_OUTPUT: Values: 106.0 112.0 115.0 114.0 113.0 114.0 112.0 116.0 116.0 118.0 20:06:58 INFO - 2015-11-04 20:06:58,701 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,701 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:166.40 Median:168.50 stddev:5.42 (3.2%) stddev-sans-first:5.72 20:06:58 INFO - 2015-11-04 20:06:58,701 DEBUG : BROWSER_OUTPUT: Values: 168.0 173.0 161.0 167.0 159.0 173.0 166.0 169.0 158.0 170.0 20:06:58 INFO - 2015-11-04 20:06:58,701 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,701 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.50 Median:197.50 stddev:8.61 (4.4%) stddev-sans-first:8.80 20:06:58 INFO - 2015-11-04 20:06:58,702 DEBUG : BROWSER_OUTPUT: Values: 187.0 203.0 185.0 196.0 186.0 179.0 204.0 199.0 200.0 196.0 20:06:58 INFO - 2015-11-04 20:06:58,702 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2015-11-04 20:06:58,703 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:90.70 Median:93.00 stddev:4.22 (4.5%) stddev-sans-first:3.08 20:06:58 INFO - 2015-11-04 20:06:58,704 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 92.0 93.0 94.0 91.0 93.0 93.0 94.0 91.0 20:06:58 INFO - 2015-11-04 20:06:58,704 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:06:58 INFO - 2015-11-04 20:06:58,704 DEBUG : BROWSER_OUTPUT: 20:06:59 INFO - 2015-11-04 20:06:59,470 INFO : Browser exited with error code: 0 20:06:59 INFO - 2015-11-04 20:06:59,527 INFO : Completed test kraken (00:01:04) 20:06:59 INFO - 2015-11-04 20:06:59,527 INFO : Starting test v8_7 20:06:59 INFO - 2015-11-04 20:06:59,527 DEBUG : operating with platform_type : mac_ 20:06:59 INFO - 2015-11-04 20:06:59,527 INFO : Initialising browser for v8_7 test... 20:06:59 INFO - 2015-11-04 20:06:59,542 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpoZSnud/profile http://localhost:49273/getInfo.html 20:07:02 INFO - 2015-11-04 20:07:02,678 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:07:02 INFO - 2015-11-04 20:07:02,678 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:07:02 INFO - 2015-11-04 20:07:02,678 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:07:02 INFO - 2015-11-04 20:07:02,679 DEBUG : BROWSER_OUTPUT: __metrics 20:07:03 INFO - 2015-11-04 20:07:03,488 INFO : Browser initialized. 20:07:03 INFO - 2015-11-04 20:07:03,489 INFO : Running cycle 1/1 for v8_7 test... 20:07:03 INFO - 2015-11-04 20:07:03,489 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpoZSnud/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:07:15 INFO - 2015-11-04 20:07:15,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 233099264 20:07:15 INFO - 2015-11-04 20:07:15,652 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/v8_7/run.html (next: http://localhost:49273/tests/v8_7/run.html) 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 253308928 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:07:38 INFO - 2015-11-04 20:07:38,564 DEBUG : BROWSER_OUTPUT: |0;Richards;897.6660682226212 20:07:38 INFO - 2015-11-04 20:07:38,565 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;239.52095808383234 20:07:38 INFO - 2015-11-04 20:07:38,565 DEBUG : BROWSER_OUTPUT: |2;Encrypt;392.31071008238524 20:07:38 INFO - 2015-11-04 20:07:38,565 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6903.448275862069 20:07:38 INFO - 2015-11-04 20:07:38,565 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1381.2154696132598 20:07:38 INFO - 2015-11-04 20:07:38,566 DEBUG : BROWSER_OUTPUT: |5;Earley;972.7626459143969 20:07:38 INFO - 2015-11-04 20:07:38,566 DEBUG : BROWSER_OUTPUT: |6;Boyer;15796.875 20:07:38 INFO - 2015-11-04 20:07:38,566 DEBUG : BROWSER_OUTPUT: |7;RegExp;35508.771929824565 20:07:38 INFO - 2015-11-04 20:07:38,566 DEBUG : BROWSER_OUTPUT: |8;Splay;877.3006134969326 20:07:38 INFO - 2015-11-04 20:07:38,566 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7042.2535211267605 20:07:38 INFO - 2015-11-04 20:07:38,566 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:07:38 INFO - 2015-11-04 20:07:38,567 DEBUG : BROWSER_OUTPUT: __startTimestamp1446696458563__endTimestamp 20:07:38 INFO - 2015-11-04 20:07:38,567 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,567 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:07:38 INFO - 2015-11-04 20:07:38,567 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:07:38 INFO - 2015-11-04 20:07:38,567 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,568 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:897.67 Median:897.67 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,568 DEBUG : BROWSER_OUTPUT: Values: 897.7 20:07:38 INFO - 2015-11-04 20:07:38,568 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,568 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:239.52 Median:239.52 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,568 DEBUG : BROWSER_OUTPUT: Values: 239.5 20:07:38 INFO - 2015-11-04 20:07:38,568 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,569 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:392.31 Median:392.31 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,569 DEBUG : BROWSER_OUTPUT: Values: 392.3 20:07:38 INFO - 2015-11-04 20:07:38,569 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,569 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6903.45 Median:6903.45 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,569 DEBUG : BROWSER_OUTPUT: Values: 6903.4 20:07:38 INFO - 2015-11-04 20:07:38,570 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,571 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1381.22 Median:1381.22 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,571 DEBUG : BROWSER_OUTPUT: Values: 1381.2 20:07:38 INFO - 2015-11-04 20:07:38,571 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,571 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:972.76 Median:972.76 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,572 DEBUG : BROWSER_OUTPUT: Values: 972.8 20:07:38 INFO - 2015-11-04 20:07:38,572 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,572 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15796.88 Median:15796.88 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,572 DEBUG : BROWSER_OUTPUT: Values: 15796.9 20:07:38 INFO - 2015-11-04 20:07:38,572 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,572 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35508.77 Median:35508.77 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: Values: 35508.8 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:877.30 Median:877.30 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: Values: 877.3 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7042.25 Median:7042.25 stddev:0.00 (0.0%) 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: Values: 7042.3 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:07:38 INFO - 2015-11-04 20:07:38,573 DEBUG : BROWSER_OUTPUT: 20:07:39 INFO - 2015-11-04 20:07:39,331 INFO : Browser exited with error code: 0 20:07:39 INFO - 2015-11-04 20:07:39,355 INFO : Completed test v8_7 (00:00:39) 20:07:39 INFO - 2015-11-04 20:07:39,484 INFO : Completed test suite (00:20:16) 20:07:39 INFO - 2015-11-04 20:07:39,485 DEBUG : Working with test: dromaeo_css 20:07:39 INFO - 2015-11-04 20:07:39,485 DEBUG : Generating results file: dromaeo_css 20:07:39 INFO - 2015-11-04 20:07:39,485 DEBUG : Working with test: kraken 20:07:39 INFO - 2015-11-04 20:07:39,486 DEBUG : Generating results file: kraken 20:07:39 INFO - 2015-11-04 20:07:39,486 INFO : javascript benchmark 20:07:39 INFO - 2015-11-04 20:07:39,486 DEBUG : Working with test: v8_7 20:07:39 INFO - 2015-11-04 20:07:39,486 DEBUG : Generating results file: v8_7 20:07:39 INFO - 2015-11-04 20:07:39,486 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:39 INFO - 2015-11-04 20:07:39,612 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 20:07:39 INFO - 2015-11-04 20:07:39,612 DEBUG : process_Request line: dromaeo_css 5459.31 graph.html#tests=[[72,63,57]] 20:07:39 INFO - 2015-11-04 20:07:39,612 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:39 INFO - 2015-11-04 20:07:39,715 DEBUG : process_Request line: kraken 1940.80 graph.html#tests=[[232,63,57]] 20:07:39 INFO - 2015-11-04 20:07:39,715 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:39 INFO - 2015-11-04 20:07:39,752 DEBUG : process_Request line: v8_7 13714.27 graph.html#tests=[[230,63,57]] 20:07:39 INFO - 2015-11-04 20:07:39,753 INFO : javascript benchmark 20:07:39 INFO - 2015-11-04 20:07:39,755 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [274.8337255960145, 278.25844125405797, 280.18186894268734, 282.2618851702797, 286.5701447828257, 11940.86561776632, 14008.0, 14604.853951460482, 14655.267236638152, 14817.777733333982, 14693.265336733173, 14800.851991480082, 15336.693266134671, 15427.228638568055, 15436.536903892873, 4315.201687687772, 4323.178596066738, 4379.321205213197, 4434.4678638563255, 4447.11057788442, 4431.135928493945, 4440.7335559866515, 4443.688941774077, 4475.328700694906, 4482.417285752864, 3118.1736839737487, 3265.306122448982, 4392.275274579706, 4438.400815889846, 4652.395188625491, 4810.5670489656095, 4815.277708343741, 4818.807247710122, 4833.854984350458, 4890.706557606555, 4057.066874618825, 4067.1052368478886, 4114.218298523271, 4138.813753381105, 4188.874333769992, 17433.12834358277, 17439.65120697579, 17767.46697599074, 17919.0, 18038.90980545102, 1631.906622562874, 1649.2331066054223, 1662.393226472341, 1763.7354396840449, 2021.2319318658963, 7325.890111648329, 10642.62750803726, 10873.0, 10964.451777411097, 11288.492017859217, 1280.1550976355654, 1315.526410492222, 1370.2463644995212, 1393.1989106263838, 1435.060035676623, 47256.291155632694, 49095.50904490945, 49579.25631115536, 49954.50045499535, 50225.24662130071, 5294.179402192666, 5334.253204551366, 5362.410134885159, 5365.973170134124, 5380.219868119101, 5965.791197308074, 6043.214382130383, 6050.031994880798, 6054.122152287981, 6062.484688801413, 4287.871363859027, 4313.352997050468, 4337.522872484024, 4366.214081465367, 4366.476022877275, 4595.035042641083, 4620.052889157714, 4625.7687115644085, 4626.444826620827, 4630.189716799614, 2372.003758421467, 2383.6305372667266, 2405.54294684013, 2430.3073624017425, 2441.5361081394476, 841.8232171244107, 847.4195176304252, 860.3031544449017, 872.5506364222431, 917.788908551037, 313.01400588147516, 334.0846081736026, 352.4273056283539, 377.94519794630173, 384.6038580262334, 8037.638306276232, 8450.61972211252, 8576.614052367659, 8585.141485851365, 8704.782380440412, 335.82872734904885, 338.5243732555714, 339.9439092549751, 348.0914812339791, 360.475508135662, 4458.5318541553315, 4674.570674700325, 4695.600873925686, 4730.053989202173, 4792.0, 455308.0, 456874.0, 469448.0, 473909.0, 474450.0, 55690.16464753032, 59248.70375648094, 60270.39729602648, 60568.0, 61428.38571614316, 398.47799382808614, 409.56995155087037, 410.1591736939263, 412.11601115607453, 417.0574501626346, 8852.867206992029, 9000.0, 9034.0, 9106.225970792291, 9108.954455227682, 28978.420431591672, 29863.0, 29972.550411743407, 30310.090697279116, 30463.0, 41190.908864604055, 41337.79331103325, 41478.37782433326, 41797.0, 41864.581354187285, 4933.457319694759, 5025.447200807981, 5042.647014708935, 5045.445001049955, 5126.410462796826, 9390.906090939003, 9403.858942115738, 9590.328676992543, 9598.520073996133, 9750.804983900423, 8110.229528194812, 8239.176082391952, 8364.3726720495, 8390.832183356177, 8412.915870841458, 7942.801429964066, 8012.919870801217, 8036.678532858854, 8175.632096555788, 8283.710070147516, 8228.25945664893, 8506.319494440306, 8527.317814574943, 8608.78478038054, 8622.61198246093, 4928.778204980857, 4977.626677999092, 4985.202367621163, 4987.12725273083, 4987.950120498748, 1762.841344279021, 2874.7843911706286, 8044.149845535677, 8184.8363032737825, 8467.53428561435], "dojo.html": [2569.2934443028166, 2618.1491015419983, 2652.4297276085636, 2664.280644226059, 2686.7716244119247, 4334.783260836962, 4500.437445319335, 4523.954760452394, 4585.380973568567, 4614.723116613001, 4328.329108988104, 4337.652987760979, 4428.313611390232, 4450.599446049855, 4514.841980530682, 4085.12169883475, 4262.126264115849, 4267.381229721688, 4277.165952639237, 4300.440942677447, 3991.800409979504, 4301.548337424557, 4312.396264522969, 4337.934930976038, 4383.649308055364, 4081.2245673321972, 4193.077522944947, 4199.664026877843, 4240.936385954213, 4320.5895439933, 4210.6841986851105, 4214.115035842477, 4248.660107191417, 4252.659787217046, 4261.339492378686, 4152.6055024772595, 4197.328427451593, 4200.6429453496185, 4215.725977811432, 4225.873223803291, 4277.251480990814, 4296.806643701041, 4326.740395576244, 4374.803133858984, 4462.3752674625575, 4777.450593181759, 4837.32277481153, 4848.539388758062, 4848.587870031051, 4881.438634557, 4798.712077275374, 4904.0191961607825, 4905.043516514245, 4906.092372911023, 4955.6531042826655, 4337.262665346899, 4373.584509471627, 4388.692791504628, 4424.75663838492, 4517.841875534341, 4830.4444988826735, 4840.83057093, 4932.1122198004705, 4934.7285899275885, 4974.253861920741, 4573.519780423074, 4715.0, 4722.150012997693, 4742.051589682008, 4750.477447480775, 4617.0996655651825, 4617.653675974316, 4640.512746161672, 4653.837115700934, 4768.76156192196, 4554.339620755039, 4656.976715116402, 4663.626909847204, 4703.6942598730975, 4709.458412282563, 4574.4968053514085, 4616.16908956391, 4640.23436133041, 4647.0, 4723.7638118093955, 3544.521489598871, 3591.569011718558, 3614.584322802859, 3648.0150359402815, 3658.487811706363, 3271.787333823294, 3276.45938420158, 3336.2326664867214, 3348.464245720722, 3377.189474526096, 4229.365595160689, 4375.365571992107, 4419.0, 4454.5990860822685, 4540.432445944257, 4766.142094423037, 4800.159972004885, 4829.782659780319, 4871.098846713369, 4893.902121957541, 4454.532274111171, 4491.618212451913, 4521.434820647419, 4558.156741002925, 4559.954400455953, 4110.897227569275, 4125.50493940729, 4213.220554197484, 4241.151769646083, 4253.298205796071, 4868.78090485929, 4884.5603895649565, 4887.291342755351, 4889.511048895082, 4990.451050384382, 4843.152448321459, 4852.733099679552, 4859.538343857328, 4899.31409602663, 4938.950610493849, 4682.0869930364615, 4736.952630473789, 4749.857504274877, 4779.880502987314, 4897.706137631753, 4698.7415692137265, 4772.642051846056, 4777.976110119427, 4786.832460863992, 4827.468978412442, 4649.0469453761225, 4821.734804585782, 4836.854894353175, 4838.419389673261, 4891.682040667345, 4614.653900957374, 4615.607673347803, 4677.32178834074, 4705.6000239979985, 4744.359511465908, 4618.261078227468, 4632.9305060424795, 4639.907201856012, 4687.32033855096, 4687.835925742583, 4262.147570485853, 4362.236608593547, 4564.360989461545, 4565.223911935045, 4620.006698559691, 4540.636749060001, 4579.267317229227, 4765.070811191785, 4772.570468657837, 4802.231642937113, 4518.231900576976, 4571.428571428572, 4582.450105987303, 4585.747783871919, 4613.008203236321], "mootools.html": [1124.263607337194, 1129.4860838318566, 1279.079063074586, 1414.6746248362876, 1516.173685341489, 5199.0, 5346.11789054806, 5367.248585198071, 5510.090835012218, 5674.09214525676, 5980.671063091529, 6121.173641558388, 6134.294556126047, 6144.262688477378, 6240.3759624037575, 1729.835665611768, 1756.5432987423299, 1761.1722490429477, 1767.7171652535596, 1779.8487128594086, 1729.5848996240939, 1756.034181200341, 1760.5158581390092, 1760.8415242628162, 1799.1364145210307, 1714.8799584029123, 1738.3307426640772, 1747.2836137183758, 1760.5158581390156, 1763.8588912887003, 1697.864170866334, 1720.1571230097225, 1728.3864228198934, 1729.4379326718868, 1729.9567510812267, 1711.2898147268868, 1727.3090763694497, 1727.7149270370373, 1729.5762538178226, 1732.3157352845556, 6187.8243133804435, 6198.411150940653, 6221.284552276501, 6221.844453888643, 6272.905906411407, 3622.130688634735, 3703.4259689748133, 3705.8702945397054, 3710.9628903710886, 3761.097336639214, 2029.4520479470607, 2054.7123402723632, 2208.9889550552307, 2252.076648574077, 2374.1334412939327, 689.4518857508293, 700.7092056796474, 700.9228984811666, 743.1602289412983, 745.2882497215146, 7942.801429964239, 7959.681612735483, 7968.960155199187, 8049.51702897828, 8074.4347895647325, 3328.201231704422, 3370.831458427118, 3403.914902127417, 3433.7081348085194, 3462.4113900636953, 7090.397316228075, 7099.3965512930945, 7120.00639820851, 7188.245234250433, 7204.459665525106, 3802.0304822270145, 3810.3522401191863, 3822.7324087314178, 3855.8264878080554, 3858.3633700439673, 3429.554157959499, 3488.8081155536183, 3517.261375111204, 3531.417316142859, 3535.222251104753, 2956.2461572298926, 2957.1276473440385, 2982.806117602349, 2991.147522955947, 2999.115260997967, 906.3836591117971, 913.0, 915.716128000322, 917.7797328641078, 919.2048877720857, 1029.0327092532996, 1052.1740433759462, 1064.8722153341648, 1069.390447444949, 1082.7996820588216, 5874.588778785529, 5875.882482350329, 5921.200637913913, 5939.910901336397, 5983.132445795335, 331.45475692486207, 339.8895359008332, 967.709687093869, 996.8604395384652, 1013.1793247469574, 4627.259638457898, 4686.671932964659, 4690.53094690535, 4708.105459962596, 4721.173794586002, 6592.637404942774, 6821.045053692388, 7143.214246432888, 7149.142102947576, 7413.59225242606, 7087.362137407658, 7172.605506697182, 7182.784516464514, 7193.136823581203, 7332.743353982692, 5743.712814359265, 5822.534197264209, 5856.882862342729, 5858.150568167677, 5892.351841297454, 5594.0, 5716.514096301861, 5759.769609215752, 5775.036487594238, 5822.854428639318, 6325.05124231369, 6516.706748196438, 6537.640429776408, 6656.500762442739, 6679.0649309097735, 6564.9671751640935, 6694.899576506259, 6704.128463299739, 6809.761658341934, 6810.216825064983, 5204.427512973645, 5251.606129540376, 5308.416074231909, 5330.253764473055, 5352.9732351338, 5927.673977931255, 5971.313298970674, 5997.0404735242155, 6015.248093988252, 6021.879562408815, 5555.472230138131, 5615.568030152285, 5658.801941932013, 5667.762487131201, 5701.942980570141, 5412.079946409041, 5530.640508366943, 5533.529649979797, 5553.305836770403, 5589.965856316594, 5530.778768849201, 5601.355844077983, 5602.887942241214, 5662.292213473316, 5681.4034526374135, 5087.4403815581, 5134.383873935151, 5136.948630513796, 5153.613478989016, 5186.559142472932, 5215.713135777569, 5241.240020196974, 5241.292425522658, 5300.1519756838725, 5308.601854860824], "ext.html": [437.6127127492168, 453.99319010214845, 467.8081986385583, 476.36881132499434, 493.12470365101916, 30401.23996900076, 31698.20754481139, 31845.885394011184, 31889.84055079727, 32127.35745285093, 34826.0, 35565.0, 35680.28639427217, 35686.46470302947, 36287.0, 7540.84918301635, 7736.961315193416, 7760.185180556045, 7766.0, 7860.724874629389, 7531.510451820614, 7536.623168841536, 7647.961760191219, 7666.38668906489, 7702.6918923243, 7569.053868266466, 7686.769396918102, 7689.923100769005, 7690.384769218477, 7709.730159444421, 7540.886886696704, 7669.501482403626, 7678.0786305643405, 7678.654460549233, 7696.730614428496, 7461.477696561243, 7575.772726818149, 7587.734429294948, 7599.848003039963, 7607.505512141693, 32946.3410731784, 33349.6665033349, 33353.66646333554, 33379.833100834585, 33418.0, 2297.862128272309, 2353.211674089182, 2463.4334103156375, 2601.6357709920626, 2913.3008078061325, 22744.65883011756, 22836.0, 23660.64509032366, 23862.284131476084, 24007.27978160658, 1936.390037138311, 1956.0415396455635, 1973.4474347182668, 1974.8716333438424, 1983.3157560641555, 225882.0, 227170.0, 227724.0, 230733.0, 231236.0, 35091.0, 35692.0, 35826.820865895505, 36136.0, 36183.276334473165, 34342.0, 34848.82575587106, 34864.47703284453, 34872.12819679528, 35307.29385412329, 11356.0, 11483.13876459269, 11519.0, 11522.596709115141, 11526.36604986717, 8947.552622368856, 9014.278857691368, 9033.141851524095, 9119.224865886474, 9140.223081038186, 11618.0, 11702.88297117018, 11716.70708232301, 11744.471498782576, 11788.351640659846, 5181.316072276525, 5336.679799211982, 5447.1829225616475, 5450.155225939986, 5458.1266997280245, 755.8526087412902, 769.9114601820862, 783.3419927261015, 812.3460614205621, 887.6050157679899, 22890.0, 23469.647955280685, 23490.177843775386, 23824.64263036056, 23947.16184933519, 807.6284908941952, 847.9279261262739, 860.9354298427643, 884.5046773806689, 923.6536298887917, 11848.644540663794, 11981.0, 12096.27422354644, 12194.878051219373, 12218.20581662189, 271639.0, 277007.0, 280789.0, 283241.0, 285174.0, 45000.77499612481, 45368.0, 45382.09235815265, 45976.31035534403, 45982.0, 1151.1021403305435, 1152.8731839497648, 1159.9826002609968, 1160.8026635471822, 1160.9361485118231, 23581.764182358642, 25761.227163185133, 26822.597661035492, 26865.865670671523, 27305.180844574694, 44519.55480445283, 44564.55435445734, 44925.0, 45067.54932450633, 45345.31982020338, 226594.0, 228352.0, 228624.0, 230528.0, 231845.0, 31643.0, 31709.207269817518, 34859.128521787155, 35910.461343079354, 36829.815850920575, 37264.813675931444, 38377.61622383852, 38530.2293954125, 38701.80649096736, 40566.39150412687, 31306.0, 32201.194970124998, 32469.51295730613, 32785.91818268172, 32802.0, 31178.387890179987, 32450.83774581112, 34309.313813723085, 34469.482957756154, 34739.478907816905, 32135.357292853543, 33265.0, 33324.33351332911, 33934.49098263479, 33938.49092263568, 26222.86888565621, 27965.580516291866, 28700.712992869805, 28748.281292967844, 28804.711952880203, 21107.683384749547, 21256.574868502234, 21348.14607415686, 21367.14531418726, 21570.784292156877], "prototype.html": [255.59871002526035, 258.11080826552535, 265.675875431973, 265.9454811763587, 266.0329701534922, 5049.469805670397, 5112.233165025248, 5136.332276804015, 5162.38051433828, 5223.529882310591, 5062.341895553582, 5115.7697903594335, 5130.897382052357, 5169.534741873231, 5175.171972484403, 3959.623835735615, 3976.940345894814, 4023.2154729827694, 4025.8188381522755, 4050.0684842486244, 3959.584243654418, 3976.065624578222, 4019.678425725935, 4032.8790136295956, 4046.008727861678, 3937.2125574884994, 3951.3677811550156, 4022.6781857451333, 4028.0, 4042.514898212204, 3998.10042740384, 4013.337799263118, 4034.576369481221, 4036.616521430474, 4056.553779084298, 3423.6576342365815, 3424.383610950028, 3461.9826900865587, 3466.341395134916, 3472.9305413891834, 4765.833195838164, 4818.229083346683, 4857.247126695333, 4879.829205977774, 5080.77136528857, 4315.395844581761, 4364.454443194601, 4367.279398899178, 4379.146066517031, 4385.539518350591, 5280.339957505312, 5282.97358513205, 5367.329083864517, 5371.060064488738, 5372.650777699437, 3609.3322735294055, 3614.7108231341695, 3619.927601447983, 3676.191237927652, 3679.632036796299, 5452.40023597404, 5622.072358060874, 5633.521150702154, 5637.154426835967, 5684.8863022739315, 3730.813459327023, 3735.458358537997, 3779.7732136071922, 3794.6015668354976, 3795.2788970095594, 3792.829322680486, 3797.240551889633, 3805.6194380562274, 3865.6520913117956, 3878.8448462061765, 4400.669949753717, 4435.933460998088, 4436.0906014267, 4461.308497182942, 4470.195364834296, 5002.0, 5196.714180720021, 5373.140297552372, 5426.213199086111, 5426.647267927651, 1347.0570600579633, 1354.1468874608934, 1354.9390277437342, 1374.0725010617793, 1374.752544541992, 879.3580686099183, 894.6779159502574, 895.8969718482327, 896.6010125494092, 915.9404638698463, 5014.6991180529285, 5029.899402012013, 5050.696958182521, 5094.465081166498, 5095.184770436712, 5466.3713672928125, 5529.004779139794, 5534.225208470817, 5553.972230138824, 5634.746436410372, 5100.6429549931145, 5143.691378517301, 5143.7685304161405, 5149.76826042829, 5151.6136289778415, 3017.125033740235, 3041.057272245611, 3064.6628870824193, 3110.673379295187, 3140.0579826052094, 5592.5805564582815, 5608.439156084359, 5611.438856114356, 5715.1713001614535, 5728.971355143198, 5701.2018317435595, 5707.258056452634, 5738.167965644958, 5791.536677065825, 5794.072948328248, 5614.831555053192, 5640.407757185437, 5647.350554686182, 5711.428857114339, 5721.313442386857, 5484.396716361117, 5653.660780353192, 5661.46216109469, 5672.631278966854, 5762.250907382014, 5497.8075767347955, 5611.0, 5629.605927585029, 5644.379118297066, 5657.745401457027, 5695.202671625892, 5782.913256301243, 5788.594798364074, 5791.0, 5858.062709966385, 3542.7165826733285, 3567.5897271814074, 3586.2648157128247, 3589.2462582857893, 3637.5271214741915, 5549.334079910436, 5575.526080283222, 5610.326760788732, 5726.770929162787, 5727.770889164553, 5346.1713434417725, 5438.9122175565835, 5462.153366228241, 5462.562994960314, 5469.699166545878, 5433.8369848904595, 5442.891142177055, 5475.917861232005, 5494.2033405155225, 5505.146702261156, 5209.47905209476, 5279.762410691451, 5319.840404787863, 5328.280682107866, 5380.569554435558, 5412.431694672003, 5491.917621235764, 5498.285222920995, 5563.721813909369, 5568.610197286151, 5379.515843574097, 5391.568674506108, 5395.109806881977, 5396.109641909041, 5437.40188579248], "yui.html": [564.2157401212313, 598.9490893274074, 611.3825036712918, 635.3900255754475, 640.433216603306, 10784.191185661068, 11479.368634725086, 11503.539858405653, 11579.42102894854, 11700.707482312935, 10663.200259980495, 10766.300190487613, 10801.13590912727, 10976.670699879016, 11103.72240693983, 743.2975837833236, 748.3788455581881, 760.1752098972621, 761.7905076104088, 769.5075151902759, 751.5265382808823, 758.9848203035936, 761.1931352766086, 771.2441807029115, 771.5178013741412, 789.5065584009993, 796.036795477473, 796.4305521552089, 799.9440039197259, 800.9959950200241, 789.9763007109796, 790.4229912164095, 790.7667238164755, 794.4161041634394, 802.8073262417007, 583.7898356591623, 583.8686295583502, 584.1733946465746, 586.7564960541371, 595.6396380189966, 10328.741781455448, 10469.895301046969, 10477.16649586327, 10478.947605262001, 10538.947305263502, 7975.2423519765525, 8140.5115693058015, 8153.510789352598, 8331.50010999336, 8645.178708022728, 7173.605451700155, 7307.232740562217, 7392.408607311402, 7659.846803063908, 7702.730404435874, 2576.3172759218824, 2596.6234895939983, 2648.205538338491, 2758.7930905181993, 2807.354308509054, 34282.971510854964, 35449.64550354489, 35722.82138589316, 39738.20523589541, 40073.39889901654, 6921.169459664872, 7116.964415177891, 7228.457865660096, 7275.126984761757, 7313.926860731431, 15467.5359739208, 15525.922370388076, 15638.139902305482, 15672.373105075898, 15767.526974190563, 5715.971420142872, 5741.081426971665, 5886.352501224862, 6016.458518733248, 6075.088736689444, 3039.3921215756936, 3072.6312842459047, 3074.3851229754137, 3123.8594263257755, 3171.873125074971, 2253.1550668499312, 2271.2391348897972, 2299.5171014086895, 2308.988455057714, 2320.083566991063, 343.2911038705066, 344.720776171302, 345.6854262621003, 351.8029903254135, 351.9348920449725, 371.7973704331146, 451.7560517320676, 470.13025902080875, 499.96750211236156, 513.3916309173641, 6236.314005459396, 6631.734730610818, 6681.498887583353, 6836.418904393083, 7292.380147687506, 390.3695531716314, 401.2416532753099, 409.09793904440636, 410.8089738271718, 429.34739196421265, 3093.767967402454, 3115.1744787631296, 3119.8752049918203, 3146.4179126861604, 3185.267388500658, 50752.746236268584, 50918.23622645663, 50920.23619645708, 51249.74375128175, 51824.740876296135, 42984.0, 43910.56089439065, 44606.776966114965, 44611.77694111509, 45191.322130168075, 34472.655273447446, 35820.46269305963, 38551.22897542034, 39178.804105979856, 41281.380779288935, 6584.275729669636, 6729.73081076771, 6806.6256355900905, 6852.657367131723, 6933.2720064392515, 28747.5687864678, 29820.403591928472, 30000.0, 30251.394972100876, 30513.542296865122, 35933.1016724584, 36349.636503634625, 36894.446583300734, 39910.800445997585, 40205.0, 5994.13085102649, 6079.0, 6156.107364432221, 6166.414190651881, 6270.310265870659, 9025.323100767337, 9317.254619630548, 9327.673531426368, 9383.249340052917, 9628.277879159232, 8646.697365592174, 8873.64505419776, 8916.55417229123, 9376.57805398745, 9408.717738467856, 8672.78318042054, 8883.644654213758, 8941.284697224077, 8953.597088130919, 9391.248700104112, 8518.616662250337, 8588.914110859061, 8602.827943441222, 8625.266852317623, 9010.927486677969, 7210.1708303545765, 7323.816904577428, 7507.849843003219, 7684.923150768421, 7740.187280335484, 6687.431568316748, 6962.338577835098, 7092.751753688803, 7525.134609519975, 7858.921410785819]}, "summary": {"suite": 5459.314020745049, "subtests": {"jquery.html": {"filtered": 5663.866670613058, "value": 5663.866670613058}, "dojo.html": {"filtered": 4419.061015527417, "value": 4419.061015527417}, "mootools.html": {"filtered": 3508.48812716499, "value": 3508.48812716499}, "ext.html": {"filtered": 15004.266556778617, "value": 15004.266556778617}, "prototype.html": {"filtered": 4064.2047784313886, "value": 4064.2047784313886}, "yui.html": {"filtered": 4943.448303217888, "value": 4943.448303217888}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0099.e"}, "testrun": {"date": 1446695242, "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": "45.0a1", "id": "20151104182235", "branch": "Mozilla-Inbound", "revision": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166"}}, {"talos_counters": {}, "results": {"audio-dft": [204.0, 216.0, 210.0, 210.0, 210.0, 211.0, 211.0, 212.0, 203.0, 209.0], "ai-astar": [135.0, 131.0, 143.0, 142.0, 143.0, 154.0, 142.0, 138.0, 134.0, 136.0], "imaging-gaussian-blur": [139.0, 158.0, 157.0, 158.0, 151.0, 157.0, 151.0, 150.0, 156.0, 151.0], "audio-beat-detection": [188.0, 172.0, 192.0, 205.0, 171.0, 198.0, 197.0, 164.0, 206.0, 164.0], "json-stringify-tinderbox": [77.0, 82.0, 83.0, 89.0, 86.0, 88.0, 90.0, 88.0, 89.0, 85.0], "stanford-crypto-pbkdf2": [187.0, 203.0, 185.0, 196.0, 186.0, 179.0, 204.0, 199.0, 200.0, 196.0], "json-parse-financial": [73.0, 74.0, 76.0, 77.0, 80.0, 80.0, 80.0, 87.0, 79.0, 81.0], "stanford-crypto-sha256-iterative": [82.0, 84.0, 92.0, 93.0, 94.0, 91.0, 93.0, 93.0, 94.0, 91.0], "audio-fft": [77.0, 90.0, 100.0, 151.0, 84.0, 90.0, 91.0, 90.0, 117.0, 86.0], "imaging-darkroom": [165.0, 165.0, 165.0, 164.0, 164.0, 166.0, 168.0, 164.0, 159.0, 164.0], "stanford-crypto-ccm": [168.0, 173.0, 161.0, 167.0, 159.0, 173.0, 166.0, 169.0, 158.0, 170.0], "audio-oscillator": [101.0, 109.0, 159.0, 111.0, 114.0, 115.0, 157.0, 114.0, 117.0, 161.0], "stanford-crypto-aes": [106.0, 112.0, 115.0, 114.0, 113.0, 114.0, 112.0, 116.0, 116.0, 118.0], "imaging-desaturate": [133.0, 136.0, 138.0, 139.0, 139.0, 141.0, 136.0, 135.0, 135.0, 133.0]}, "summary": {"suite": 1940.8000000000002, "subtests": {"audio-fft": {"filtered": 97.6, "value": 97.6}, "stanford-crypto-pbkdf2": {"filtered": 193.5, "value": 193.5}, "audio-beat-detection": {"filtered": 185.7, "value": 185.7}, "stanford-crypto-ccm": {"filtered": 166.4, "value": 166.4}, "imaging-darkroom": {"filtered": 164.4, "value": 164.4}, "json-parse-financial": {"filtered": 78.7, "value": 78.7}, "audio-oscillator": {"filtered": 125.8, "value": 125.8}, "ai-astar": {"filtered": 139.8, "value": 139.8}, "audio-dft": {"filtered": 209.6, "value": 209.6}, "stanford-crypto-sha256-iterative": {"filtered": 90.7, "value": 90.7}, "json-stringify-tinderbox": {"filtered": 85.7, "value": 85.7}, "imaging-gaussian-blur": {"filtered": 152.8, "value": 152.8}, "stanford-crypto-aes": {"filtered": 113.6, "value": 113.6}, "imaging-desaturate": {"filtered": 136.5, "value": 136.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0099.e"}, "testrun": {"date": 1446695242, "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": "45.0a1", "id": "20151104182235", "branch": "Mozilla-Inbound", "revision": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166"}}, {"talos_counters": {}, "results": {"DeltaBlue": [239.52095808383234], "Encrypt": [392.31071008238524], "NavierStokes": [7042.2535211267605], "Decrypt": [6903.448275862069], "Splay": [877.3006134969326], "Richards": [897.6660682226212], "RegExp": [35508.771929824565], "Earley": [972.7626459143969], "Boyer": [15796.875], "RayTrace": [1381.2154696132598]}, "summary": {"suite": 13714.274437979475, "subtests": {"DeltaBlue": {"filtered": 276.04265000000004, "value": 276.04265000000004}, "Encrypt": {"filtered": 678.4953689999999, "value": 678.4953689999999}, "NavierStokes": {"filtered": 210.72800000000018, "value": 210.72800000000018}, "Decrypt": {"filtered": 38.55768731268734, "value": 38.55768731268734}, "Splay": {"filtered": 92.88834265734262, "value": 92.88834265734262}, "RegExp": {"filtered": 25.655209980237164, "value": 25.655209980237164}, "Richards": {"filtered": 39.32642799999999, "value": 39.32642799999999}, "Earley": {"filtered": 685.1239639999999, "value": 685.1239639999999}, "Boyer": {"filtered": 42.189546983185, "value": 42.189546983185}, "RayTrace": {"filtered": 535.7520359999999, "value": 535.7520359999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0099.e"}, "testrun": {"date": 1446695242, "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": "45.0a1", "id": "20151104182235", "branch": "Mozilla-Inbound", "revision": "3111b73e96d8bd2fb34ad7a3c9731a2fd1ee3166"}}] 20:07:39 INFO - RETURN: dromaeo_css: 5459.31 20:07:39 INFO - RETURN: kraken: 1940.80 20:07:39 INFO - RETURN: v8_7: 13714.27 20:07:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "13714.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1940.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5459.31"}}} 20:07:39 INFO - Return code: 0 20:07:39 INFO - # TBPL SUCCESS # 20:07:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:39 INFO - 2015-11-04 20:07:39.894 screenresolution[1665:10683] starting screenresolution argv=screenresolution get 20:07:39 INFO - 2015-11-04 20:07:39.898 screenresolution[1665:10683] Display 0: 1600x1200x32@60 20:07:39 INFO - 2015-11-04 20:07:39.905 screenresolution[1666:10686] starting screenresolution argv=screenresolution list 20:07:39 INFO - Available Modes on Display 0 20:07:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:40 INFO - Intel HD Graphics 3000: 20:07:40 INFO - Chipset Model: Intel HD Graphics 3000 20:07:40 INFO - Type: GPU 20:07:40 INFO - Bus: Built-In 20:07:40 INFO - VRAM (Total): 512 MB 20:07:40 INFO - VRAM (Dynamic, Max): 10 20:07:40 INFO - Vendor: Intel (0x8086) 20:07:40 INFO - Device ID: 0x0116 20:07:40 INFO - Revision ID: 0x0009 20:07:40 INFO - Displays: 20:07:40 INFO - Display: 20:07:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:40 INFO - Display Serial Number: 1600x1200 60 20:07:40 INFO - Main Display: Yes 20:07:40 INFO - Mirror: Off 20:07:40 INFO - Online: Yes 20:07:40 INFO - Rotation: Supported 20:07:40 INFO - Return code: 0 20:07:40 INFO - Running post-action listener: _resource_record_post_action 20:07:40 INFO - Running post-run listener: _resource_record_post_run 20:07:41 INFO - Total resource usage - Wall time: 1262s; CPU: 30.0%; Read bytes: 37323776; Write bytes: 688256000; Read time: 4397; Write time: 68491 20:07:41 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 337469952; Write bytes: 334157824; Read time: 37984; Write time: 4290 20:07:41 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 36434944; Write bytes: 343727104; Read time: 3996; Write time: 63647 20:07:41 INFO - Running post-run listener: _upload_blobber_files 20:07:41 INFO - Blob upload gear active. 20:07:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:07:41 INFO - Copying logs to upload dir... 20:07:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1325.023327 ========= master_lag: 3.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-04 20:07:44.484411) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-04 20:07:44.488050) ========= 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.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010419 build_url: 'https://queue.taskcluster.net/v1/task/xQ32SVkJSXmq9CxyATc3JQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.64 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-04 20:07:46.135396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 20:07:46.138929) ========= 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.SLHYtREuBu/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.VAjhfS8krP/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.005461 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 20:07:46.218994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 20:07:46.219456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 20:07:46.236520) ========= ========= Total master_lag: 5.06 =========