builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0067 starttime: 1446694603.79 results: success (0) buildid: 20151104175135 builduid: 17ff31677ae5490492bde9b2735ccbc0 revision: 91a6134ea200f28f562144a71a254e7a50881081 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.789489) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.789946) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.790251) ========= 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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.006516 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.815042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.815332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.831435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.831723) ========= 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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.005926 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.880880) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.881213) ========= 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:36:43.881608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:43.881903) ========= 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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:36:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2015-11-04 19:36:43 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112661 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.011570) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.011921) ========= 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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.022232 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.061486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.061856) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 91a6134ea200f28f562144a71a254e7a50881081 --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 91a6134ea200f28f562144a71a254e7a50881081 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:36:44,138 truncating revision to first 12 chars 2015-11-04 19:36:44,138 Setting DEBUG logging. 2015-11-04 19:36:44,138 attempt 1/10 2015-11-04 19:36:44,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/91a6134ea200?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-04 19:36:44,598 unpacking tar archive at: mozilla-inbound-91a6134ea200/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.803184) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.803525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.817552) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 19:36:44.817913) ========= 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:36:44.818355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-04 19:36:44.818676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:36:45 INFO - MultiFileLogger online at 20151104 19:36:45 in /builds/slave/test 19:36:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:36:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:45 INFO - {'append_to_log': False, 19:36:45 INFO - 'base_work_dir': '/builds/slave/test', 19:36:45 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:36:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:45 INFO - 'branch': 'Mozilla-Inbound', 19:36:45 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:45 INFO - 'config_files': ('talos/mac_config.py',), 19:36:45 INFO - 'default_actions': ('clobber', 19:36:45 INFO - 'read-buildbot-config', 19:36:45 INFO - 'download-and-extract', 19:36:45 INFO - 'populate-webroot', 19:36:45 INFO - 'create-virtualenv', 19:36:45 INFO - 'install', 19:36:45 INFO - 'run-tests'), 19:36:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:45 INFO - 'download_minidump_stackwalk': True, 19:36:45 INFO - 'download_symbols': 'ondemand', 19:36:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:45 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:45 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:45 INFO - 'installer_path': 'installer.exe', 19:36:45 INFO - 'log_level': 'info', 19:36:45 INFO - 'log_name': 'talos', 19:36:45 INFO - 'log_to_console': True, 19:36:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:36:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:36:45 INFO - 'opt_config_files': (), 19:36:45 INFO - 'pip_index': False, 19:36:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:45 INFO - 'cmd': ('bash', 19:36:45 INFO - '-c', 19:36:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:45 INFO - 'enabled': True, 19:36:45 INFO - 'halt_on_failure': False, 19:36:45 INFO - 'name': 'check_screen_resolution'},), 19:36:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:45 INFO - 'cmd': ('bash', 19:36:45 INFO - '-c', 19:36:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:45 INFO - 'enabled': True, 19:36:45 INFO - 'halt_on_failure': False, 19:36:45 INFO - 'name': 'check_screen_resolution'},), 19:36:45 INFO - 'run_cmd_checks_enabled': True, 19:36:45 INFO - 'sps_profile': False, 19:36:45 INFO - 'sps_profile_interval': 0, 19:36:45 INFO - 'suite': 'dromaeojs', 19:36:45 INFO - 'system_bits': '64', 19:36:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:45 INFO - 'title': 't-yosemite-r5-0067', 19:36:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:45 INFO - 'use_talos_json': True, 19:36:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:45 INFO - 'work_dir': 'build'} 19:36:45 INFO - ##### 19:36:45 INFO - ##### Running clobber step. 19:36:45 INFO - ##### 19:36:45 INFO - Running pre-action listener: _resource_record_pre_action 19:36:45 INFO - Running main action method: clobber 19:36:45 INFO - rmtree: /builds/slave/test/build 19:36:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:45 INFO - Running post-action listener: _resource_record_post_action 19:36:45 INFO - ##### 19:36:45 INFO - ##### Running read-buildbot-config step. 19:36:45 INFO - ##### 19:36:45 INFO - Running pre-action listener: _resource_record_pre_action 19:36:45 INFO - Running main action method: read_buildbot_config 19:36:45 INFO - Using buildbot properties: 19:36:45 INFO - { 19:36:45 INFO - "properties": { 19:36:45 INFO - "buildnumber": 3019, 19:36:45 INFO - "product": "firefox", 19:36:45 INFO - "script_repo_revision": "production", 19:36:45 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 19:36:45 INFO - "repository": "", 19:36:45 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 19:36:45 INFO - "buildid": "20151104175135", 19:36:45 INFO - "slavename": "t-yosemite-r5-0067", 19:36:45 INFO - "pgo_build": "False", 19:36:45 INFO - "basedir": "/builds/slave/test", 19:36:45 INFO - "project": "", 19:36:45 INFO - "platform": "yosemite", 19:36:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:36:45 INFO - "slavebuilddir": "test", 19:36:45 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 19:36:45 INFO - "branch": "mozilla-inbound", 19:36:45 INFO - "repo_path": "integration/mozilla-inbound", 19:36:45 INFO - "stage_platform": "macosx64", 19:36:45 INFO - "builduid": "17ff31677ae5490492bde9b2735ccbc0", 19:36:45 INFO - "revision": "91a6134ea200f28f562144a71a254e7a50881081" 19:36:45 INFO - }, 19:36:45 INFO - "sourcestamp": { 19:36:45 INFO - "repository": "", 19:36:45 INFO - "hasPatch": false, 19:36:45 INFO - "project": "", 19:36:45 INFO - "branch": "mozilla-inbound-macosx64-talos", 19:36:45 INFO - "changes": [ 19:36:45 INFO - { 19:36:45 INFO - "category": null, 19:36:45 INFO - "files": [ 19:36:45 INFO - { 19:36:45 INFO - "url": null, 19:36:45 INFO - "name": "https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:36:45 INFO - } 19:36:45 INFO - ], 19:36:45 INFO - "repository": "", 19:36:45 INFO - "rev": "91a6134ea200f28f562144a71a254e7a50881081", 19:36:45 INFO - "who": "tnikkel@gmail.com", 19:36:45 INFO - "when": 1446694453, 19:36:45 INFO - "number": 6622900, 19:36:45 INFO - "comments": "Bug 1215977. Add a flag for GetNearestScrollable that makes fixed pos frames return the root scroll frame of their document. And make APZCCallbackHelper use it to restore previous behaviour. r=botond\n\nWe may want to do this for fixed pos frames in all documents (not just root documents). However, this patch only maintains the previous behaviour on purpose.", 19:36:45 INFO - "project": "", 19:36:45 INFO - "at": "Wed 04 Nov 2015 19:34:13", 19:36:45 INFO - "branch": "mozilla-inbound-macosx64-talos", 19:36:45 INFO - "revlink": "", 19:36:45 INFO - "properties": [ 19:36:45 INFO - [ 19:36:45 INFO - "buildid", 19:36:45 INFO - "20151104175135", 19:36:45 INFO - "Change" 19:36:45 INFO - ], 19:36:45 INFO - [ 19:36:45 INFO - "builduid", 19:36:45 INFO - "17ff31677ae5490492bde9b2735ccbc0", 19:36:45 INFO - "Change" 19:36:45 INFO - ], 19:36:45 INFO - [ 19:36:45 INFO - "pgo_build", 19:36:45 INFO - "False", 19:36:45 INFO - "Change" 19:36:45 INFO - ] 19:36:45 INFO - ], 19:36:45 INFO - "revision": "91a6134ea200f28f562144a71a254e7a50881081" 19:36:45 INFO - } 19:36:45 INFO - ], 19:36:45 INFO - "revision": "91a6134ea200f28f562144a71a254e7a50881081" 19:36:45 INFO - } 19:36:45 INFO - } 19:36:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:36:45 INFO - Running post-action listener: _resource_record_post_action 19:36:45 INFO - ##### 19:36:45 INFO - ##### Running download-and-extract step. 19:36:45 INFO - ##### 19:36:45 INFO - Running pre-action listener: _resource_record_pre_action 19:36:45 INFO - Running main action method: download_and_extract 19:36:45 INFO - mkdir: /builds/slave/test/build/tests 19:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:45 INFO - https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/test_packages.json 19:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/test_packages.json 19:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:36:46 INFO - Downloaded 1149 bytes. 19:36:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:36:46 INFO - Using the following test package requirements: 19:36:46 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:36:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:36:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'jsshell-mac.zip'], 19:36:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:36:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:36:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:36:46 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:36:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:36:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:36:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:46 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:36:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:46 INFO - https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:36:48 INFO - Downloaded 17458631 bytes. 19:36:48 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:36:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:36:53 INFO - Return code: 0 19:36:53 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:36:53 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:36:53 INFO - https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:36:54 INFO - Downloaded 17458631 bytes. 19:36:54 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:36:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:37:02 INFO - Return code: 0 19:37: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:37:02 INFO - https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:37:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:37:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:37:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:37:03 INFO - Downloaded 11131307 bytes. 19:37:03 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:37:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:37:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:37:03 INFO - Return code: 0 19:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:03 INFO - https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:37:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:37:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:37:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:37:07 INFO - Downloaded 108663396 bytes. 19:37:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:37:07 INFO - mkdir: /builds/slave/test/properties 19:37:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:37:07 INFO - Writing to file /builds/slave/test/properties/build_url 19:37:07 INFO - Contents: 19:37:07 INFO - build_url:https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:37:07 INFO - Running post-action listener: _resource_record_post_action 19:37:07 INFO - Running post-action listener: set_extra_try_arguments 19:37:07 INFO - ##### 19:37:07 INFO - ##### Running populate-webroot step. 19:37:07 INFO - ##### 19:37:07 INFO - Running pre-action listener: _resource_record_pre_action 19:37:07 INFO - Running main action method: populate_webroot 19:37:07 INFO - Guessing talos json url... 19:37:07 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:37:07 INFO - https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 19:37:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 19:37:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 19:37:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 19:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uP9ODpWpQf2eTwbsFbQhTg/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:37:07 INFO - Downloaded 111 bytes. 19:37:07 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 19:37:07 INFO - Contents: 19:37:07 INFO - 20151104175135 19:37:07 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/91a6134ea200f28f562144a71a254e7a50881081 19:37:07 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:37:07 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/91a6134ea2/testing/talos/talos.json 19:37:07 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/91a6134ea2/testing/talos/talos.json to /builds/slave/test/build/talos.json 19:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/91a6134ea2/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 19:37:08 INFO - Downloaded 4264 bytes. 19:37:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:37:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:37:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:37:08 INFO - '../fennec_ids.txt'], 19:37:08 INFO - 'tests': ['tcheck2']}, 19:37:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:37:08 INFO - '--tppagecycles', 19:37:08 INFO - '7'], 19:37:08 INFO - 'tests': ['tsvgm']}}, 19:37:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:37:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:37:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:37:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:37:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:37:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:37:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'tests': ['damp', 'tps']}, 19:37:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['damp', 'tps']}, 19:37:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:37:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:37:08 INFO - 'other': {'tests': ['a11yr', 19:37:08 INFO - 'ts_paint', 19:37:08 INFO - 'tpaint', 19:37:08 INFO - 'sessionrestore', 19:37:08 INFO - 'sessionrestore_no_auto_restore']}, 19:37:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['a11yr', 19:37:08 INFO - 'ts_paint', 19:37:08 INFO - 'tpaint', 19:37:08 INFO - 'sessionrestore', 19:37:08 INFO - 'sessionrestore_no_auto_restore']}, 19:37:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['a11yr', 19:37:08 INFO - 'ts_paint', 19:37:08 INFO - 'tpaint', 19:37:08 INFO - 'sessionrestore', 19:37:08 INFO - 'sessionrestore_no_auto_restore']}, 19:37:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['a11yr', 19:37:08 INFO - 'ts_paint', 19:37:08 INFO - 'tpaint', 19:37:08 INFO - 'sessionrestore', 19:37:08 INFO - 'sessionrestore_no_auto_restore']}, 19:37:08 INFO - 'other_l64': {'tests': ['a11yr', 19:37:08 INFO - 'ts_paint', 19:37:08 INFO - 'tpaint', 19:37:08 INFO - 'sessionrestore', 19:37:08 INFO - 'sessionrestore_no_auto_restore']}, 19:37:08 INFO - 'other_nol64': {'tests': ['a11yr', 19:37:08 INFO - 'ts_paint', 19:37:08 INFO - 'tpaint', 19:37:08 INFO - 'sessionrestore', 19:37:08 INFO - 'sessionrestore_no_auto_restore']}, 19:37:08 INFO - 'svgr': {'tests': ['tsvgx', 19:37:08 INFO - 'tsvgr_opacity', 19:37:08 INFO - 'tart', 19:37:08 INFO - 'tscrollx', 19:37:08 INFO - 'cart']}, 19:37:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['tsvgx', 19:37:08 INFO - 'tsvgr_opacity', 19:37:08 INFO - 'tart', 19:37:08 INFO - 'tscrollx', 19:37:08 INFO - 'cart']}, 19:37:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'tests': ['tp5o']}, 19:37:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'talos_options': ['--e10s'], 19:37:08 INFO - 'tests': ['tp5o']}, 19:37:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'talos_options': ['--xperf_path', 19:37:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:37:08 INFO - 'tests': ['tp5n']}, 19:37:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:08 INFO - 'talos_options': ['--e10s', 19:37:08 INFO - '--xperf_path', 19:37:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 19:37:08 INFO - 'C:/slave/talos-data/talos/xperf.config'], 19:37:08 INFO - 'tests': ['tp5n']}}, 19:37:08 INFO - 'talos.zip': {'path': '', 19:37:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:37:08 INFO - Running post-action listener: _resource_record_post_action 19:37:08 INFO - ##### 19:37:08 INFO - ##### Running create-virtualenv step. 19:37:08 INFO - ##### 19:37:08 INFO - Running pre-action listener: _resource_record_pre_action 19:37:08 INFO - Running main action method: create_virtualenv 19:37:08 INFO - Creating virtualenv /builds/slave/test/build/venv 19:37:08 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:37:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:37:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:37:08 INFO - Using real prefix '/tools/python27' 19:37:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:37:09 INFO - Installing distribute.............................................................................................................................................................................................done. 19:37:13 INFO - Installing pip.................done. 19:37:13 INFO - Return code: 0 19:37:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:13 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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:13 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:37:13 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:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:13 INFO - 'HOME': '/Users/cltbld', 19:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:13 INFO - 'LOGNAME': 'cltbld', 19:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:13 INFO - 'MOZ_NO_REMOTE': '1', 19:37:13 INFO - 'NO_EM_RESTART': '1', 19:37:13 INFO - 'PAGER': '/bin/cat', 19:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:13 INFO - 'PWD': '/builds/slave/test', 19:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:13 INFO - 'SHELL': '/bin/bash', 19:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:13 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:13 INFO - 'USER': 'cltbld', 19:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:13 INFO - 'XPC_FLAGS': '0x0', 19:37:13 INFO - 'XPC_SERVICE_NAME': '0', 19:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:14 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:37:14 INFO - Cleaning up... 19:37:14 INFO - Return code: 0 19:37:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:14 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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:14 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:37:14 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:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:14 INFO - 'HOME': '/Users/cltbld', 19:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:14 INFO - 'LOGNAME': 'cltbld', 19:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:14 INFO - 'MOZ_NO_REMOTE': '1', 19:37:14 INFO - 'NO_EM_RESTART': '1', 19:37:14 INFO - 'PAGER': '/bin/cat', 19:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:14 INFO - 'PWD': '/builds/slave/test', 19:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:14 INFO - 'SHELL': '/bin/bash', 19:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:14 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:14 INFO - 'USER': 'cltbld', 19:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:14 INFO - 'XPC_FLAGS': '0x0', 19:37:14 INFO - 'XPC_SERVICE_NAME': '0', 19:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:14 INFO - Downloading/unpacking psutil>=0.7.1 19:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:37:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:17 INFO - Installing collected packages: psutil 19:37:17 INFO - Running setup.py install for psutil 19:37:17 INFO - building 'psutil._psutil_osx' extension 19:37:17 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:37:17 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:37:18 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:37:18 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:37:18 INFO - building 'psutil._psutil_posix' extension 19:37:18 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:37:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:37:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:37:18 INFO - ^ 19:37:18 INFO - 1 warning generated. 19:37:18 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:37:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:18 INFO - Successfully installed psutil 19:37:18 INFO - Cleaning up... 19:37:18 INFO - Return code: 0 19:37:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:18 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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:18 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:37:18 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:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:18 INFO - 'HOME': '/Users/cltbld', 19:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:18 INFO - 'LOGNAME': 'cltbld', 19:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:18 INFO - 'MOZ_NO_REMOTE': '1', 19:37:18 INFO - 'NO_EM_RESTART': '1', 19:37:18 INFO - 'PAGER': '/bin/cat', 19:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:18 INFO - 'PWD': '/builds/slave/test', 19:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:18 INFO - 'SHELL': '/bin/bash', 19:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:18 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:18 INFO - 'USER': 'cltbld', 19:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:18 INFO - 'XPC_FLAGS': '0x0', 19:37:18 INFO - 'XPC_SERVICE_NAME': '0', 19:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:37:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:37:21 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:37:21 INFO - Installing collected packages: mozsystemmonitor 19:37:21 INFO - Running setup.py install for mozsystemmonitor 19:37:21 INFO - Successfully installed mozsystemmonitor 19:37:21 INFO - Cleaning up... 19:37:21 INFO - Return code: 0 19:37:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:21 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:37:21 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:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:21 INFO - 'HOME': '/Users/cltbld', 19:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:21 INFO - 'LOGNAME': 'cltbld', 19:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:21 INFO - 'MOZ_NO_REMOTE': '1', 19:37:21 INFO - 'NO_EM_RESTART': '1', 19:37:21 INFO - 'PAGER': '/bin/cat', 19:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:21 INFO - 'PWD': '/builds/slave/test', 19:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:21 INFO - 'SHELL': '/bin/bash', 19:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:21 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:21 INFO - 'USER': 'cltbld', 19:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:21 INFO - 'XPC_FLAGS': '0x0', 19:37:21 INFO - 'XPC_SERVICE_NAME': '0', 19:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:22 INFO - Downloading/unpacking blobuploader==1.2.4 19:37: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:37: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:37: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:37: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:37: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:37: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:37:25 INFO - Downloading blobuploader-1.2.4.tar.gz 19:37:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:37:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:37:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:37:26 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:37:26 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:37:26 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:37:26 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:37:26 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:37:26 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:37:26 INFO - Downloading docopt-0.6.1.tar.gz 19:37:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:37:26 INFO - Installing collected packages: blobuploader, requests, docopt 19:37:26 INFO - Running setup.py install for blobuploader 19:37:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:37:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:37:26 INFO - Running setup.py install for requests 19:37:27 INFO - Running setup.py install for docopt 19:37:27 INFO - Successfully installed blobuploader requests docopt 19:37:27 INFO - Cleaning up... 19:37:27 INFO - Return code: 0 19:37:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:27 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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:27 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:37:27 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:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:27 INFO - 'HOME': '/Users/cltbld', 19:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:27 INFO - 'LOGNAME': 'cltbld', 19:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:27 INFO - 'MOZ_NO_REMOTE': '1', 19:37:27 INFO - 'NO_EM_RESTART': '1', 19:37:27 INFO - 'PAGER': '/bin/cat', 19:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:27 INFO - 'PWD': '/builds/slave/test', 19:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:27 INFO - 'SHELL': '/bin/bash', 19:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:27 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:27 INFO - 'USER': 'cltbld', 19:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:27 INFO - 'XPC_FLAGS': '0x0', 19:37:27 INFO - 'XPC_SERVICE_NAME': '0', 19:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-tmxsKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-AOq1LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-VTIEmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-b2H7Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-BusPFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-vFOint-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:28 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-cCurWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-YlyBhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-k5j_WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-gEV_Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-qO7Zdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-8styym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-xh8qf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:29 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-ZsmHaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:30 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-0HBmSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:30 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-1IG982-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:30 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-vsRr3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:37:30 INFO - Running setup.py install for manifestparser 19:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:37:30 INFO - Running setup.py install for mozcrash 19:37:30 INFO - Running setup.py install for mozdebug 19:37:30 INFO - Running setup.py install for mozdevice 19:37:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Running setup.py install for mozfile 19:37:31 INFO - Running setup.py install for mozhttpd 19:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Running setup.py install for mozinfo 19:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Running setup.py install for mozInstall 19:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:37:31 INFO - Running setup.py install for mozleak 19:37:32 INFO - Running setup.py install for mozlog 19:37:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:37:32 INFO - Running setup.py install for moznetwork 19:37:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:37:32 INFO - Running setup.py install for mozprocess 19:37:32 INFO - Running setup.py install for mozprofile 19:37:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:37:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:37:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:37:32 INFO - Running setup.py install for mozrunner 19:37:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:37:33 INFO - Running setup.py install for mozscreenshot 19:37:33 INFO - Running setup.py install for moztest 19:37:33 INFO - Running setup.py install for mozversion 19:37:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:37:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:37:33 INFO - Cleaning up... 19:37:33 INFO - Return code: 0 19:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:33 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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:33 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:37:33 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:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:33 INFO - 'HOME': '/Users/cltbld', 19:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:33 INFO - 'LOGNAME': 'cltbld', 19:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:33 INFO - 'MOZ_NO_REMOTE': '1', 19:37:33 INFO - 'NO_EM_RESTART': '1', 19:37:33 INFO - 'PAGER': '/bin/cat', 19:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:33 INFO - 'PWD': '/builds/slave/test', 19:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:33 INFO - 'SHELL': '/bin/bash', 19:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:33 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:33 INFO - 'USER': 'cltbld', 19:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:33 INFO - 'XPC_FLAGS': '0x0', 19:37:33 INFO - 'XPC_SERVICE_NAME': '0', 19:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:34 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-bqWHKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:34 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:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:34 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-icMgaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:34 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:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:34 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-UDtR0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:34 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:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:34 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-isPJTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:34 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:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:34 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-MMfmTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:34 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:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:34 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-fdu_it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-TAMNV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-iz4j0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-VbIRlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-gmsqhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-avxeyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-zi2B6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:35 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-1Uh1Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:36 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-Hi83HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:36 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-VsjUY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:36 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-bw4oRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:36 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-kQzXih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:39 INFO - Downloading blessings-1.5.1.tar.gz 19:37:39 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:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:37:39 INFO - Installing collected packages: blessings 19:37:39 INFO - Running setup.py install for blessings 19:37:39 INFO - Successfully installed blessings 19:37:39 INFO - Cleaning up... 19:37:39 INFO - Return code: 0 19:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:40 INFO - Reading from file tmpfile_stdout 19:37:40 INFO - Current package versions: 19:37:40 INFO - blessings == 1.5.1 19:37:40 INFO - blobuploader == 1.2.4 19:37:40 INFO - docopt == 0.6.1 19:37:40 INFO - manifestparser == 1.1 19:37:40 INFO - mozInstall == 1.12 19:37:40 INFO - mozcrash == 0.16 19:37:40 INFO - mozdebug == 0.1 19:37:40 INFO - mozdevice == 0.47 19:37:40 INFO - mozfile == 1.2 19:37:40 INFO - mozhttpd == 0.7 19:37:40 INFO - mozinfo == 0.9 19:37:40 INFO - mozleak == 0.1 19:37:40 INFO - mozlog == 3.0 19:37:40 INFO - moznetwork == 0.27 19:37:40 INFO - mozprocess == 0.22 19:37:40 INFO - mozprofile == 0.27 19:37:40 INFO - mozrunner == 6.11 19:37:40 INFO - mozscreenshot == 0.1 19:37:40 INFO - mozsystemmonitor == 0.0 19:37:40 INFO - moztest == 0.7 19:37:40 INFO - mozversion == 1.4 19:37:40 INFO - psutil == 3.1.1 19:37:40 INFO - requests == 1.2.3 19:37:40 INFO - wsgiref == 0.1.2 19:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37: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:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37: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:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x104d57a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd70a47f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, '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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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:37:40 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:37:40 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:37:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:37:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:40 INFO - 'HOME': '/Users/cltbld', 19:37:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:40 INFO - 'LOGNAME': 'cltbld', 19:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:40 INFO - 'MOZ_NO_REMOTE': '1', 19:37:40 INFO - 'NO_EM_RESTART': '1', 19:37:40 INFO - 'PAGER': '/bin/cat', 19:37:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:40 INFO - 'PWD': '/builds/slave/test', 19:37:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:40 INFO - 'SHELL': '/bin/bash', 19:37:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:37:40 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:37:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:40 INFO - 'USER': 'cltbld', 19:37:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:40 INFO - 'XPC_FLAGS': '0x0', 19:37:40 INFO - 'XPC_SERVICE_NAME': '0', 19:37:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 INFO - Cleaning up... 19:37:40 INFO - Return code: 0 19:37:40 INFO - Running post-action listener: _resource_record_post_action 19:37:40 INFO - Running post-action listener: _start_resource_monitoring 19:37:40 INFO - Starting resource monitoring. 19:37:40 INFO - ##### 19:37:40 INFO - ##### Running install step. 19:37:40 INFO - ##### 19:37:40 INFO - Running pre-action listener: _resource_record_pre_action 19:37:40 INFO - Running main action method: install 19:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:40 INFO - Reading from file tmpfile_stdout 19:37:40 INFO - Detecting whether we're running mozinstall >=1.0... 19:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:37:40 INFO - Reading from file tmpfile_stdout 19:37:40 INFO - Output received: 19:37:40 INFO - Usage: mozinstall [options] installer 19:37:40 INFO - Options: 19:37:40 INFO - -h, --help show this help message and exit 19:37:40 INFO - -d DEST, --destination=DEST 19:37:40 INFO - Directory to install application into. [default: 19:37:40 INFO - "/builds/slave/test"] 19:37:40 INFO - --app=APP Application being installed. [default: firefox] 19:37:40 INFO - mkdir: /builds/slave/test/build/application 19:37:40 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:37:40 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:38:22 INFO - Reading from file tmpfile_stdout 19:38:22 INFO - Output received: 19:38:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:38:22 INFO - Running post-action listener: _resource_record_post_action 19:38:22 INFO - ##### 19:38:22 INFO - ##### Running run-tests step. 19:38:22 INFO - ##### 19:38:22 INFO - Running pre-action listener: _resource_record_pre_action 19:38:22 INFO - Running main action method: run_tests 19:38:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:38:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:38:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:38:22 INFO - 2015-11-04 19:38:22.951 screenresolution[1943:8917] starting screenresolution argv=screenresolution get 19:38:22 INFO - 2015-11-04 19:38:22.955 screenresolution[1943:8917] Display 0: 1600x1200x32@60 19:38:22 INFO - 2015-11-04 19:38:22.962 screenresolution[1944:8919] starting screenresolution argv=screenresolution list 19:38:22 INFO - Available Modes on Display 0 19:38:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:38:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:38:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:38:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:38:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:38:23 INFO - Intel HD Graphics 3000: 19:38:23 INFO - Chipset Model: Intel HD Graphics 3000 19:38:23 INFO - Type: GPU 19:38:23 INFO - Bus: Built-In 19:38:23 INFO - VRAM (Total): 512 MB 19:38:23 INFO - VRAM (Dynamic, Max): 10 19:38:23 INFO - Vendor: Intel (0x8086) 19:38:23 INFO - Device ID: 0x0116 19:38:23 INFO - Revision ID: 0x0009 19:38:23 INFO - Displays: 19:38:23 INFO - Display: 19:38:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:38:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:38:23 INFO - Display Serial Number: 1600x1200 60 19:38:23 INFO - Main Display: Yes 19:38:23 INFO - Mirror: Off 19:38:23 INFO - Online: Yes 19:38:23 INFO - Rotation: Supported 19:38:23 INFO - Return code: 0 19:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:38:23 INFO - Python 2.7.3 19:38:23 INFO - Return code: 0 19:38:23 INFO - grabbing minidump binary from tooltool 19:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:23 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 0x104d0c9f0>, '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 0x104a6bcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cd6990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:38:23 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:38:23 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:38:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:38:23 INFO - Return code: 0 19:38:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:38:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:38:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:38:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:38:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:38:23 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0067', '--webServer', 'localhost'] in /builds/slave/test/build 19:38:23 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0067 --webServer localhost 19:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uuf32IpZKk/Render', 19:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:23 INFO - 'HOME': '/Users/cltbld', 19:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:23 INFO - 'LOGNAME': 'cltbld', 19:38:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:38:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:23 INFO - 'MOZ_NO_REMOTE': '1', 19:38:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:38:23 INFO - 'NO_EM_RESTART': '1', 19:38:23 INFO - 'PAGER': '/bin/cat', 19:38:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:23 INFO - 'PWD': '/builds/slave/test', 19:38:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:23 INFO - 'SHELL': '/bin/bash', 19:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tx44syJ9zF/Listeners', 19:38:23 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 19:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:23 INFO - 'USER': 'cltbld', 19:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:23 INFO - 'XPC_FLAGS': '0x0', 19:38:23 INFO - 'XPC_SERVICE_NAME': '0', 19:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:38:23 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0067', '--webServer', 'localhost'] with output_timeout 3600 19:38:23 INFO - mozversion INFO | application_buildid: 20151104175135 19:38:23 INFO - mozversion INFO | application_changeset: 91a6134ea200f28f562144a71a254e7a50881081 19:38:23 INFO - mozversion INFO | application_display_name: Nightly 19:38:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:38:23 INFO - mozversion INFO | application_name: Firefox 19:38:23 INFO - mozversion INFO | application_remotingname: firefox 19:38:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:38:23 INFO - mozversion INFO | application_vendor: Mozilla 19:38:23 INFO - mozversion INFO | application_version: 45.0a1 19:38:23 INFO - mozversion INFO | platform_buildid: 20151104175135 19:38:23 INFO - mozversion INFO | platform_changeset: 91a6134ea200f28f562144a71a254e7a50881081 19:38:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:38:23 INFO - mozversion INFO | platform_version: 45.0a1 19:38:23 INFO - 2015-11-04 19:38:23,741 DEBUG : using testdate: 1446694703 19:38:23 INFO - 2015-11-04 19:38:23,741 DEBUG : actual date: 1446694703 19:38:23 INFO - 2015-11-04 19:38:23,751 INFO : starting webserver on 'localhost:49331' 19:38:23 INFO - 2015-11-04 19:38:23,752 INFO : Starting test suite t-yosemite-r5-0067 19:38:23 INFO - 2015-11-04 19:38:23,752 INFO : Starting test dromaeo_css 19:38:23 INFO - 2015-11-04 19:38:23,752 DEBUG : operating with platform_type : mac_ 19:38:23 INFO - 2015-11-04 19:38:23,753 INFO : Initialising browser for dromaeo_css test... 19:38:23 INFO - 2015-11-04 19:38:23,776 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpAwLv0u/profile http://localhost:49331/getInfo.html 19:38:27 INFO - 2015-11-04 19:38:27,122 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:38:27 INFO - 2015-11-04 19:38:27,122 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:38:27 INFO - 2015-11-04 19:38:27,123 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:38:27 INFO - 2015-11-04 19:38:27,123 DEBUG : BROWSER_OUTPUT: __metrics 19:38:27 INFO - 2015-11-04 19:38:27,141 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:27 INFO - 2015-11-04 19:38:27,920 INFO : Browser initialized. 19:38:27 INFO - 2015-11-04 19:38:27,921 INFO : Running cycle 1/1 for dromaeo_css test... 19:38:27 INFO - 2015-11-04 19:38:27,921 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpAwLv0u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:38:40 INFO - 2015-11-04 19:38:40,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 220434432 19:38:40 INFO - 2015-11-04 19:38:40,068 DEBUG : BROWSER_OUTPUT: 19:39:31 INFO - 2015-11-04 19:39:31,889 DEBUG : BROWSER_OUTPUT: 1446694771888 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:41:40 INFO - 2015-11-04 19:41:40,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49331/tests/dromaeo/cssquery-ext.html) 19:41:42 INFO - 2015-11-04 19:41:42,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 323522560 19:41:42 INFO - 2015-11-04 19:41:42,057 DEBUG : BROWSER_OUTPUT: 19:44:44 INFO - 2015-11-04 19:44:44,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-ext.html (next: http://localhost:49331/tests/dromaeo/cssquery-jquery.html) 19:44:45 INFO - 2015-11-04 19:44:45,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 356896768 19:44:45 INFO - 2015-11-04 19:44:45,532 DEBUG : BROWSER_OUTPUT: 19:47:47 INFO - 2015-11-04 19:47:47,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49331/tests/dromaeo/cssquery-mootools.html) 19:47:48 INFO - 2015-11-04 19:47:48,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 318943232 19:47:48 INFO - 2015-11-04 19:47:48,455 DEBUG : BROWSER_OUTPUT: 19:50:50 INFO - 2015-11-04 19:50:50,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49331/tests/dromaeo/cssquery-prototype.html) 19:50:51 INFO - 2015-11-04 19:50:51,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 310116352 19:50:51 INFO - 2015-11-04 19:50:51,189 DEBUG : BROWSER_OUTPUT: 19:53:54 INFO - 2015-11-04 19:53:54,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49331/tests/dromaeo/cssquery-yui.html) 19:53:55 INFO - 2015-11-04 19:53:55,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 310054912 19:53:55 INFO - 2015-11-04 19:53:55,163 DEBUG : BROWSER_OUTPUT: 19:56:57 INFO - 2015-11-04 19:56:57,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-yui.html (next: http://localhost:49331/tests/dromaeo/cssquery-dojo.html) 19:56:58 INFO - 2015-11-04 19:56:58,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 359829504 19:56:58 INFO - 2015-11-04 19:56:58,227 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,227 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:56:58 INFO - 2015-11-04 19:56:58,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:56:58 INFO - 2015-11-04 19:56:58,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:56:58 INFO - 2015-11-04 19:56:58,227 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:56:58 INFO - 2015-11-04 19:56:58,229 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2572.729863364347;2665.586834040724;2673.7860971122313;2700.1629494856597;2705.6347393101937;4298.204832106063;4373.8031788569515;4376.168527979686;4432.091421258642;4479.955200447995;4330.826766929319;4355.564443555643;4362.760048197348;4390.67069969752;4492.61812745917;4028.858989935353;4128.710990230685;4158.4178215049915;4164.063085805685;4228.76741779202;51.828013138890284;3849.7497662651976;3915.2561013407503;4033.35466325388;4056.1482088761395;3954.4463775071513;4037.6366127048414;4059.9188016239805;4083.3874918762126;4151.647109995639;4075.5924407559305;4100.5489396166395;4106.137711080677;4113.547509773923;4138.6482149017365;3926.666233370167;4033.495813023372;4053.229886321619;4098.569650186747;4132.214879172978;4270.167317373113;4415.712978656377;4418.403515525395;4430.756308403036;4435.423394958667;4674.555917187861;4729.337892695025;4730.219513780222;4734.739589322586;4764.428268607755;4556.225441674923;4671.85984420468;4779.091972525209;4818.10864989978;4831.202851529529;4314.568543145691;4410.647148228134;4418.116376724668;4434.623057040156;4436.600705936449;4843.0313937211995;4851.684640498356;4906.484819093944;4959.876003099879;4960.77676504551;4380.233459144701;4440.600345968878;4654.371659825948;4715.717056976524;4763.45220299663;4624.190766615829;4624.28323609841;4682.555157260055;4698.201305778026;4746.8101275948575;4642.767861606906;4691.46048204454;4694.084653492536;4725.621950243973;4784.832530861403;4487.977560112178;4624.699394539344;4754.667173297836;4768.046390721869;4801.207800712913;3615.3311637347174;3635.94546081809;3649.671529562352;3665.8533658653887;3688.133288677159;3307.6196237432523;3309.1561651778643;3311.8675252990092;3317.834108294576;3372.0389688938535;4487.573680500347;4498.347739577743;4502.099580083996;4514.074614703978;4556.589906908394;4520.52534483881;4638.79125439356;4655.743934083658;4660.487346391894;4676.906461870812;4434.733915965053;4472.865814025519;4511.819527218874;4541.772911354419;4602.769861506911;4234.322508398642;4234.703570750018;4242.278812601865;4245.893852653709;4309.655227581786;4669.603083737852;4855.635827312895;4871.342368780241;4888.388951381077;4918.8770280743265;4551.704139230939;4627.398438203012;4659.627229821674;4678.391809064936;4747.311639812277;4817.566419022305;4830.178869592248;4842;4851.248056551241;4905.533974272438;4488.640908727229;4645.326427667902;4716.29255611661;4748.857534273978;4779.378680771478;4677.602403795579;4736.739479328532;4758.262469317261;4779.617630589475;4784.138855005993;4504.572065653758;4669.626429885669;4690.859274221779;4722.740249286322;4723.173444647105;4452.087322099027;4583.702059366131;4609.423822022247;4625.676202665781;4693.694909830987;4434.224010798033;4497.280435130363;4526;4544.159330523864;4606.493285738499;4414.293713005904;4450.310201918578;4461.687681862239;4481.395011673382;4707.952920470751;4350.32569951658;4430.75630840294;4440.689151759475;4447.199504089295;4677.508861569622 19:56:58 INFO - 2015-11-04 19:56:58,230 DEBUG : BROWSER_OUTPUT: |1;ext.html;449.5167694728167;451.3951305250964;453.5102089743078;459.7861994172711;482.7634459115035;26124.2162735118;27004.189874303753;31822.522662160085;32286;32390.190245243823;34939;34984.825075874585;35168.29663406737;35182;35771.821140894324;6861.4510839133;7639.427042971785;7839.137694853562;7881.290683838453;7943.086545047307;6983.2318444971015;9161.770955726126;9445.244380449582;9482.952585237064;9576.186024187953;9222.308326875478;9396.15434610885;9413.48225847578;9413.717588472357;9543.522823858779;6984.546004509691;7201.495895287332;9033.412828166149;9217.354785165042;9320.953395233015;8847.247983921374;8887.466751994902;9083.500407477586;9089.045650206765;9112.5443727814;30077.69922300771;30350;30464.54303185454;30690.23274418135;30793.076207713806;2611.7388261173733;2783.4154827486254;2816.2677703796953;2916.7229113234207;2922.7807914406294;23065.654015189786;23886.761132388627;24014.75985240143;24047.759522404725;25318.620220696703;1632.1920649278684;1684.713598688226;1698.5923378389098;1723.3709695960883;1723.482955113461;225858;227862;228193;231339;232400;47782.283265751044;48950;49043.26435103476;51877.74061129746;52016.479835201164;59363.70318148468;59689;60004.39995600076;60205.09692354618;60752;13569.932150339382;13627;13642.863571364358;13712.314384280746;13834.93082534581;10378.221633377527;10405.687829365132;10440.060394564525;10494.317869338469;10511.319613498661;17194;17204.741928871077;17249;17345.2194651241;17456.127193640266;7037.753678621224;7118.074650295428;7244.927550724531;7256.492045556866;7316.524425912298;781.5935713428985;791.6912404162381;815.1278132398277;819.1439945257221;919.2416256588341;23571.528569428516;23747.525049498912;24074.51850962971;24151.411231865888;24230;894.3113802372137;932.8367535681228;964.4647220792388;1009.6869970309227;1011.367895065584;12308.323042232583;12585.87414125847;12597.496100155891;12672.80990785139;12757.234565926074;264353;270734;274038;274630;274686;46476.767616161706;47013.05973880503;47119.76440117846;47142.29286560704;47819.521804782205;1133.121830581306;1148.9885101149048;1159.4550561236206;1163.0637336943842;1164.4818055965184;22454.663180052637;23617.763822362245;25017.624735628615;25650;26724;44900.326495103254;44971;45016.77491612521;45818.08363832771;46522.27821774317;254759;260591;261258;261558;262928;28820.855895720386;29982.25044373821;35887.102822429646;36237.275254494234;38574;35548.28903421865;36030.279394412486;36082.27835443224;36177.819110904275;36593.81703091574;29507.409851802415;30378.696213037587;30598;32939.91791764782;33291.66708332886;29175.854120729262;29300.681469333504;29643;29656.703432966257;30037.69962300349;30678.846605766827;30679;30906.227344316572;31216.21959450941;31473;25388.365290867878;26534.469310614066;28912.566311504925;28926.421471570873;28927;19921.701174482103;19939.800601993793;20070.59858802845;20176.697349540063;20235.392938211877 19:56:58 INFO - 2015-11-04 19:56:58,234 DEBUG : BROWSER_OUTPUT: |2;jquery.html;282.26329280577687;282.55215483458716;283.05459764386944;286.53438162985145;293.7987478577174;9312.8603070954;10107.090361867431;14639.780403293946;14863.182524961123;15134.394624215018;16217.756733649005;16322.510324690249;16993.83006169938;17025.82974170258;17152.056636884965;4651.813927442899;4817.807287708488;4834.734089625069;4904.558589726924;4908.43552991407;4709.175894218515;4794;4800.703809971305;4817;4875.70745755254;3315.5026745988052;3506.7019303359243;3506.7194624430113;4749.168895443301;4770.952290477103;4951.2573114033;5168.302279192299;5212.895742085175;5220.269162317279;5311.893762124774;4293.248681480728;4298.11888562847;4299.871003869889;4421.557844215585;4621.514740952185;19036.238550457965;19065.714014289795;19145.808541914543;19254.71117933232;19365.80634193668;1623.2046297314348;1643.2089022964906;1656.1222552047434;1983.355409491921;1997.1412292714126;11399.715007124889;11782.941085294604;12067.818982715266;12112.636620901387;12554.68613284666;1434.978475322871;1456.5557504960982;1458.7155504676593;1472.2050092949794;1480.6002379357512;41014.1797164058;42470.362944555854;42775.786121069505;42852.57147428548;48377.27434088491;5330;5441.319835020622;5471;5484.561235101182;5522.22688823565;6168.8766224675255;6175.536834737412;6180.289266734293;6208.689565521706;6228.816524860262;4407.228734971367;4507.887302817456;4513;4600.88497787558;4637.304404339308;4883.731394773251;4973.2042873140845;4979.178435558092;4993.325901003318;4997.650164488524;2372;2408.3858616052794;2475.8390704604144;2488.228649118779;2498.5502609530095;823.7405217356513;850.4472093139385;860.2343913916619;892.3352102683542;921.0329154387866;321.5530412726312;335.7532213822838;344.3216862780319;356.2252101678838;370.73862926636656;9034.2320902724;9237.584308706124;9390.201832844148;9503.097205765442;9643.566039528238;339.15888596280865;372.2907860525703;378.6175962278119;389.2701185277605;394.9684025277971;5045.520675535819;5167.405748338989;5243.947560524346;5256.474352564789;5273.525382715574;440134;448158;449827;450536;466113;53618.19572706413;54160;54977.72511137499;55517.44482555203;55555;406.30319002910153;409.11834995584564;409.35935261315944;410.2840543252044;411.08123344325406;8952.68665596701;9115;9132.178103970675;9138.223251023472;9217.631294748135;27458.17625471239;27524.311892202855;27554.11612413126;27849.721502784712;27850.721492784814;36815.26369472649;37651.81174094112;38506.80746596249;38714.41928371133;39061.41407878827;5142.280080788618;5255.658382205144;5258.658187217971;5264.9210261846865;5294.444083371191;9418.858717119112;9513.096255855682;9983.650572229937;10010.04904534068;10021.198304135798;8379.874301885598;8611.95694021526;8655.394122411371;8677.956610216908;8686.739397818075;7831.451798374059;8166.550839703873;8186.058603260702;8402.32781377476;8470;8289.668413263644;8545.401821872409;8901.777455563404;8986.68546600866;9005.459672419676;4378.16814805186;4496.77516124186;4499.730016199039;5027.321311622884;5145.61407894402;8120.675172993014;8130.63412146443;8234.258916697527;8333.916660833314;8395.32837373021 19:56:58 INFO - 2015-11-04 19:56:58,235 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1041.6718733598912;1128.2666266926497;1141.246777127096;1304.8890844278235;1486.8587484189004;5669.659820410773;5895.823125306242;6155.384461553843;6279.874402511947;6408.070829729698;6136.662483563402;6267.310595834455;6293.590916590419;6310.747570097202;6329.050642403642;1601.4875239923228;1612.5323656139706;1768.5313391951177;1789.633125209329;1800;1578.2187817030585;1775.7691500104968;1811.529002459357;1818.3908390689135;1821.471773185781;1730.5068055604156;1747.8863873848159;1754.8944165175985;1763.8853474524115;1775.9733603995885;1781.0115385960787;1807.1416077363147;1814.83666470017;1822.535253510353;1832.697604895204;1774.7222000159863;1797.667431525172;1799.7840259168852;1812.8005919348861;1834.302964873353;6238.781642642532;6314.242290925073;6314.494840412802;6368;6414.358564143595;3775.886723398275;3857.9421308680394;3867.207222519377;3885.7279990400684;3889.2221555688693;2224.7552769195377;2274.601944659678;2314.36355002374;2317.698699169114;2339.239747082205;583.2564168024949;665.2117241069349;673.3973094080819;689.7034275261635;691.4537515362857;8003.799905002364;8009.879851802228;8024.959875200645;8047.718329858427;8069.112397636255;3319.4025075486643;3418.8974330770116;3450.275442157125;3464.6015708193377;3536.982315088408;7088.468364872552;7122.109736282965;7128.7504937327985;7180.820479488055;7196.532225405332;3781.6596506314563;3803.3154032274456;3815.008097894512;3823.617638236154;3840.135969406861;3451.6375780543185;3463.7748546344405;3478.6347433519118;3489.0405138586584;3510.227749895019;2960.363521842814;3024.2590565311198;3027.8637461314293;3032.348045170299;3061.2959019425657;963.9903600964041;969.7914948286011;986.0386123529502;988.6243227573476;995.4276291132628;1068.5832525315134;1079.794838980591;1081.1729027294127;1089.8256278995482;1123.2586492914636;5860.882782344329;5890.087036509348;5900.055991041499;5901.40985901415;6004.639721616717;359.8938313197613;955.8040601676639;1004.7739258666742;1033.7415646088477;1062.6918193723734;4713.128071306819;4715.528447155326;4721.622270218374;4730.385049943486;4738.3129446230105;7361.411087113018;7364.079490063742;7404.851902961911;7451.888221676679;7525.473216874876;7449.6275186241555;7459.776206713807;7462.776116716507;7484.288992545699;7521.811954701177;5211.869703257449;5415.566754659618;5551.8889622207325;5784.566157538202;5878.118282257696;5711.228984087095;5867.413258674099;5882.382349853204;5884.235049443545;5943.91084133747;6531.542792004514;6592.7033283503315;6610.933890661224;6618.602883826986;6665.633390163393;6522.902156467562;6682.064510968566;6715.630640314635;6770.86458270822;6835.453163746789;5278.076336640996;5301.151815709468;5315.335583052119;5376.408595054619;5379.65032272901;5944.64332140073;5966.313873904556;5979;5980.910286345621;5982.192404025575;5385.084535629031;5429.511343979061;5444.6188766785945;5683.829485115453;5783;5516.600278878701;5556.833295001156;5575.6933368663495;5649.915251271152;5712;5638.4925356718095;5681.119426488901;5715.514181294637;5717.942820571741;5743.56923230751;5093.592512598909;5136.922946155736;5139.665921715076;5194.714290713896;5199.428062913001;5226.346706661668;5279.366476022902;5279.419263880894;5298.337707786527;5331.920021199608 19:56:58 INFO - 2015-11-04 19:56:58,237 DEBUG : BROWSER_OUTPUT: |4;prototype.html;255.95776696845022;258.93267750384894;263.7586608253448;267.65472540422854;268.9152916831198;5023.547880690737;5086;5122.743862806854;5132.538071573557;5180.766865491052;4895.16782147035;4951.183054795954;4968.080905032562;4982.601391888649;5098.286239926404;3846.115393459506;3857.633524815138;3863.942040869389;3888.008557817767;3890.8443662253476;3848.345781217186;3859.749116307431;3890.3386424307796;3915.2169566086754;3947.960520394802;3828.8468461261655;3837.328467518187;3843.231353729251;3843.404272337792;3901.2977664020464;3850.7111966602615;3851.826667799956;3851.9422208666892;3870.9806450967844;3913.5303763548413;3201.439748044083;3248.6751324867323;3265.510173473974;3298.901032969015;3301.0756988043386;4886.877828054292;4887.3890763654545;4901.8774530636665;4937.061958227961;4992.201247800334;4278.593533614302;4294.205571969195;4296.355546667994;4298.054428025829;4334.718243314174;5205.089109405839;5217.113090774577;5238.449962753894;5263.631545791796;5284.577233821324;3340.9832950835334;3388.102152929476;3469.4795780632853;3505.6669616386403;3563.251717139404;5429.104197807357;5521.751521181516;5539.99999999996;5542.7782888684405;5561.304836895388;3589.8025608591256;3596.2088340565033;3605.5673319201865;3609.9892030231576;3649.7445178837756;3461.7576769625884;3546.5212196353677;3589.4974703541525;3632.0919770057485;3670.0641336459566;4183.309753890635;4205.306124489425;4222.556631553704;4249.87250382489;4303.569643035734;5275.577953763766;5275.894482110336;5292.497212764782;5317.282166907496;5334.573234141337;1298.5649807314467;1325.2313658078292;1326.6550696818897;1329.3884812985941;1358.5380970470087;828.9626966786509;844.5819319436918;846.5217152308926;866.5970323799463;868.9782755431165;5092.414372347227;5114.15616423286;5122.718250496258;5140.280360749498;5235.790568377222;5502.889942201134;5520.806771762969;5548.4174161713245;5582.860428489239;5593.8321850344555;5127.4872512748425;5175.4824517548695;5193.896122077537;5237.057329680694;5243.292155558951;2989.925251868677;3036.69633036699;3065.157081802522;3070.9539356909663;3081.4607443697264;5594.720263986785;5628.493435590816;5639.802606908738;5644.407337229614;5741.081426971665;5615.213870058195;5631.746571404296;5647.29408823897;5708.086706127;5740.68426236561;5555.944440555542;5630.127330263816;5637.7181140942785;5667.773289068391;5738.340090889601;5216.295800066942;5552.944470555242;5578.972105139448;5580.581456390868;5630.493255607015;5482.17767334887;5488.945110549003;5510.228568000403;5532.861678458071;5552.666839989613;5634.464725851038;5656.208130861765;5686.118651609007;5688.943110568841;5767.625104368202;3538.5046093546407;3611.5485564304463;3662.066173125836;3663.8900832975055;3664.4136938089778;5289.841304760864;5352.518273355417;5503.7798488060025;5516.227728118147;5525.309336332958;5211.687298762086;5270.156774915995;5319.41486436484;5338.786448542171;5405.945940540544;5285.867853303698;5337.786488540415;5366.7048312343195;5373.650712703662;5388.030154572215;5198.532132108128;5215.322008138917;5223.268742375994;5224.791008359623;5268.57851371897;5178.093833579184;5329.413764485981;5359.062164121186;5368.7852485901685;5389.649672771257;5294.9205761912835;5314.62797604164;5315.867103322448;5328.813491527778;5386.757595908115 19:56:58 INFO - 2015-11-04 19:56:58,240 DEBUG : BROWSER_OUTPUT: |5;yui.html;458.2370353361653;477.9866682632821;488.2871008327842;508.3493128795141;513.8997895410395;12845;13028.283444410565;13044.413001414936;13099.083064185486;13188.406521706522;11947;11979.760404791921;12004.759904801898;12024.879751202485;12076.396180190999;569.3054473542293;582.833892340683;724.1816747075796;728.7995801154672;735.91904890462;586.7447660267776;711.1927961763384;728.726727477196;738.35762886289;741.4402126394565;708.1608294171398;735.6946867050168;738.269113577557;738.3391864281465;739.6301849075462;581.459242904099;597.0417479944713;722.357102179061;738.7303634173514;740.5334639177311;539.2612121393715;539.5063516882049;540.864783804049;544.4609836262072;548.1175307754512;11283.49224284901;11459.140564457699;11504.066463051868;11525.077993760478;11587.710307242301;8159.877601835978;8197.672093116269;8279.70806686083;8326.167383261685;8416.074231834493;7242.6378681065735;7298.233685463003;7513.962430187814;7603.619819009027;7612.391008719344;2482.2801387597574;2496.3010357100043;2562.7309132541186;2647.973520264792;2675.42478367152;38259.42610860839;38797;38810.61189388098;39148.60851391507;39168;5290.92063619046;5331.173668081454;5397;5447.455254474521;5449.3188351456065;9973.152282056106;9978.600855965826;10026.097651211427;10095.495225238708;10163.593456261815;5185.585153187736;5210.452902445264;5470.234167216593;5482.862928426821;5494.587905907073;3102.286474110922;3227.1125440504047;3241.546183534307;3279.8196099214774;3335.533025376449;2115.598036373084;2147.302126808793;2147.5919575280645;2159.039227543728;2183.825293976478;313;319.3118828923673;320.3864599292329;321.94687876500586;323.4146195386358;428.1073960791784;428.2035414129716;431.1463302660749;431.8445359670516;448.82495826627644;6440.194975628046;6552.508561857784;6745.932540674628;6798.490113241527;6834.6582670866255;390.8573370719667;414.169589972104;446.51107037793565;455.1352430382234;487.8463284065508;3057.5260834570677;3179.1893067267697;3231.8384080795868;3307.107081088093;3346.2972775716885;49404.258936115984;49666.751666241435;49852.75073624681;49967.25049124266;50386.24420633693;42165;42628;42769.57230427718;43306.566934330884;43446.56553434425;38797.80601097033;38915.80542097271;39075.60924390776;39575.80212098921;40561.391579126335;6408.308510425539;6617.536772426077;6660.800175994728;6719.114190152974;6767.593944363354;28848.2787930295;29562.408751824412;29571.26071848221;30582;31352.21619459532;35834.462483062256;37056.814715926244;37222.25555488929;37269.440958386185;38143.42784858285;8310.085890552155;8469.491830490191;8563.272121869462;8575.95712021436;8638.56807159627;8838.823223535623;8851.822963540564;8869.246114080375;8921.107889211027;8924.643014279356;8289;8369.790755231168;8434.662613495391;8480.448770829877;8481.067082620782;8375.07874133857;8384.203500667427;8453.577321133796;8499.277561407349;8515.82968340642;8175.100738918595;8366.121557236402;8462.238398543914;8485.278751306209;8520.531370774666;7253.566941295057;7399.297066778648;7789.1821358756515;7818.765437036898;7830.491018083806;7276.792368460236;7546.622668866425;7552.584607846621;7708.768736937901;7710.614469276626 19:56:58 INFO - 2015-11-04 19:56:58,240 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:56:58 INFO - 2015-11-04 19:56:58,240 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:56:58 INFO - 2015-11-04 19:56:58,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 19:56:58 INFO - 2015-11-04 19:56:58,240 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:56:58 INFO - 2015-11-04 19:56:58,241 DEBUG : BROWSER_OUTPUT: __startTimestamp1446695818225__endTimestamp 19:56:58 INFO - 2015-11-04 19:56:58,241 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,241 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:56:58 INFO - 2015-11-04 19:56:58,241 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:56:58 INFO - 2015-11-04 19:56:58,241 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,241 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4369.60 Median:4498.35 stddev:575.08 (12.8%) stddev-sans-first:559.30 19:56:58 INFO - 2015-11-04 19:56:58,242 DEBUG : BROWSER_OUTPUT: Values: 2572.7 2665.6 2673.8 2700.2 2705.6 4298.2 4373.8 4376.2 4432.1 4480.0 4330.8 4355.6 4362.8 4390.7 4492.6 4028.9 4128.7 4158.4 4164.1 4228.8 51.8 3849.7 3915.3 4033.4 4056.1 3954.4 4037.6 4059.9 4083.4 4151.6 4075.6 4100.5 4106.1 4113.5 4138.6 3926.7 4033.5 4053.2 4098.6 4132.2 4270.2 4415.7 4418.4 4430.8 4435.4 4674.6 4729.3 4730.2 4734.7 4764.4 4556.2 4671.9 4779.1 4818.1 4831.2 4314.6 4410.6 4418.1 4434.6 4436.6 4843.0 4851.7 4906.5 4959.9 4960.8 4380.2 4440.6 4654.4 4715.7 4763.5 4624.2 4624.3 4682.6 4698.2 4746.8 4642.8 4691.5 4694.1 4725.6 4784.8 4488.0 4624.7 4754.7 4768.0 4801.2 3615.3 3635.9 3649.7 3665.9 3688.1 3307.6 3309.2 3311.9 3317.8 3372.0 4487.6 4498.3 4502.1 4514.1 4556.6 4520.5 4638.8 4655.7 4660.5 4676.9 4434.7 4472.9 4511.8 4541.8 4602.8 4234.3 4234.7 4242.3 4245.9 4309.7 4669.6 4855.6 4871.3 4888.4 4918.9 4551.7 4627.4 4659.6 4678.4 4747.3 4817.6 4830.2 4842.0 4851.2 4905.5 4488.6 4645.3 4716.3 4748.9 4779.4 4677.6 4736.7 4758.3 4779.6 4784.1 4504.6 4669.6 4690.9 4722.7 4723.2 4452.1 4583.7 4609.4 4625.7 4693.7 4434.2 4497.3 4526.0 4544.2 4606.5 4414.3 4450.3 4461.7 4481.4 4708.0 4350.3 4430.8 4440.7 4447.2 4677.5 19:56:58 INFO - 2015-11-04 19:56:58,242 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,242 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40387.79 Median:30531.27 stddev:66478.52 (217.7%) stddev-sans-first:66597.38 19:56:58 INFO - 2015-11-04 19:56:58,242 DEBUG : BROWSER_OUTPUT: Values: 449.5 451.4 453.5 459.8 482.8 26124.2 27004.2 31822.5 32286.0 32390.2 34939.0 34984.8 35168.3 35182.0 35771.8 6861.5 7639.4 7839.1 7881.3 7943.1 6983.2 9161.8 9445.2 9483.0 9576.2 9222.3 9396.2 9413.5 9413.7 9543.5 6984.5 7201.5 9033.4 9217.4 9321.0 8847.2 8887.5 9083.5 9089.0 9112.5 30077.7 30350.0 30464.5 30690.2 30793.1 2611.7 2783.4 2816.3 2916.7 2922.8 23065.7 23886.8 24014.8 24047.8 25318.6 1632.2 1684.7 1698.6 1723.4 1723.5 225858.0 227862.0 228193.0 231339.0 232400.0 47782.3 48950.0 49043.3 51877.7 52016.5 59363.7 59689.0 60004.4 60205.1 60752.0 13569.9 13627.0 13642.9 13712.3 13834.9 10378.2 10405.7 10440.1 10494.3 10511.3 17194.0 17204.7 17249.0 17345.2 17456.1 7037.8 7118.1 7244.9 7256.5 7316.5 781.6 791.7 815.1 819.1 919.2 23571.5 23747.5 24074.5 24151.4 24230.0 894.3 932.8 964.5 1009.7 1011.4 12308.3 12585.9 12597.5 12672.8 12757.2 264353.0 270734.0 274038.0 274630.0 274686.0 46476.8 47013.1 47119.8 47142.3 47819.5 1133.1 1149.0 1159.5 1163.1 1164.5 22454.7 23617.8 25017.6 25650.0 26724.0 44900.3 44971.0 45016.8 45818.1 46522.3 254759.0 260591.0 261258.0 261558.0 262928.0 28820.9 29982.3 35887.1 36237.3 38574.0 35548.3 36030.3 36082.3 36177.8 36593.8 29507.4 30378.7 30598.0 32939.9 33291.7 29175.9 29300.7 29643.0 29656.7 30037.7 30678.8 30679.0 30906.2 31216.2 31473.0 25388.4 26534.5 28912.6 28926.4 28927.0 19921.7 19939.8 20070.6 20176.7 20235.4 19:56:58 INFO - 2015-11-04 19:56:58,242 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,242 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22366.91 Median:235382.41 stddev:73683.13 (31.3%) stddev-sans-first:73871.16 19:56:58 INFO - 2015-11-04 19:56:58,244 DEBUG : BROWSER_OUTPUT: Values: 282.3 282.6 283.1 286.5 293.8 9312.9 10107.1 14639.8 14863.2 15134.4 16217.8 16322.5 16993.8 17025.8 17152.1 4651.8 4817.8 4834.7 4904.6 4908.4 4709.2 4794.0 4800.7 4817.0 4875.7 3315.5 3506.7 3506.7 4749.2 4771.0 4951.3 5168.3 5212.9 5220.3 5311.9 4293.2 4298.1 4299.9 4421.6 4621.5 19036.2 19065.7 19145.8 19254.7 19365.8 1623.2 1643.2 1656.1 1983.4 1997.1 11399.7 11782.9 12067.8 12112.6 12554.7 1435.0 1456.6 1458.7 1472.2 1480.6 41014.2 42470.4 42775.8 42852.6 48377.3 5330.0 5441.3 5471.0 5484.6 5522.2 6168.9 6175.5 6180.3 6208.7 6228.8 4407.2 4507.9 4513.0 4600.9 4637.3 4883.7 4973.2 4979.2 4993.3 4997.7 2372.0 2408.4 2475.8 2488.2 2498.6 823.7 850.4 860.2 892.3 921.0 321.6 335.8 344.3 356.2 370.7 9034.2 9237.6 9390.2 9503.1 9643.6 339.2 372.3 378.6 389.3 395.0 5045.5 5167.4 5243.9 5256.5 5273.5 440134.0 448158.0 449827.0 450536.0 466113.0 53618.2 54160.0 54977.7 55517.4 55555.0 406.3 409.1 409.4 410.3 411.1 8952.7 9115.0 9132.2 9138.2 9217.6 27458.2 27524.3 27554.1 27849.7 27850.7 36815.3 37651.8 38506.8 38714.4 39061.4 5142.3 5255.7 5258.7 5264.9 5294.4 9418.9 9513.1 9983.7 10010.0 10021.2 8379.9 8612.0 8655.4 8678.0 8686.7 7831.5 8166.6 8186.1 8402.3 8470.0 8289.7 8545.4 8901.8 8986.7 9005.5 4378.2 4496.8 4499.7 5027.3 5145.6 8120.7 8130.6 8234.3 8333.9 8395.3 19:56:58 INFO - 2015-11-04 19:56:58,244 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,244 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4341.24 Median:5400.33 stddev:2224.79 (41.2%) stddev-sans-first:2217.20 19:56:58 INFO - 2015-11-04 19:56:58,245 DEBUG : BROWSER_OUTPUT: Values: 1041.7 1128.3 1141.2 1304.9 1486.9 5669.7 5895.8 6155.4 6279.9 6408.1 6136.7 6267.3 6293.6 6310.7 6329.1 1601.5 1612.5 1768.5 1789.6 1800.0 1578.2 1775.8 1811.5 1818.4 1821.5 1730.5 1747.9 1754.9 1763.9 1776.0 1781.0 1807.1 1814.8 1822.5 1832.7 1774.7 1797.7 1799.8 1812.8 1834.3 6238.8 6314.2 6314.5 6368.0 6414.4 3775.9 3857.9 3867.2 3885.7 3889.2 2224.8 2274.6 2314.4 2317.7 2339.2 583.3 665.2 673.4 689.7 691.5 8003.8 8009.9 8025.0 8047.7 8069.1 3319.4 3418.9 3450.3 3464.6 3537.0 7088.5 7122.1 7128.8 7180.8 7196.5 3781.7 3803.3 3815.0 3823.6 3840.1 3451.6 3463.8 3478.6 3489.0 3510.2 2960.4 3024.3 3027.9 3032.3 3061.3 964.0 969.8 986.0 988.6 995.4 1068.6 1079.8 1081.2 1089.8 1123.3 5860.9 5890.1 5900.1 5901.4 6004.6 359.9 955.8 1004.8 1033.7 1062.7 4713.1 4715.5 4721.6 4730.4 4738.3 7361.4 7364.1 7404.9 7451.9 7525.5 7449.6 7459.8 7462.8 7484.3 7521.8 5211.9 5415.6 5551.9 5784.6 5878.1 5711.2 5867.4 5882.4 5884.2 5943.9 6531.5 6592.7 6610.9 6618.6 6665.6 6522.9 6682.1 6715.6 6770.9 6835.5 5278.1 5301.2 5315.3 5376.4 5379.7 5944.6 5966.3 5979.0 5980.9 5982.2 5385.1 5429.5 5444.6 5683.8 5783.0 5516.6 5556.8 5575.7 5649.9 5712.0 5638.5 5681.1 5715.5 5717.9 5743.6 5093.6 5136.9 5139.7 5194.7 5199.4 5226.3 5279.4 5279.4 5298.3 5331.9 19:56:58 INFO - 2015-11-04 19:56:58,245 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,245 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4434.65 Median:5179.43 stddev:1365.09 (26.4%) stddev-sans-first:1332.40 19:56:58 INFO - 2015-11-04 19:56:58,247 DEBUG : BROWSER_OUTPUT: Values: 256.0 258.9 263.8 267.7 268.9 5023.5 5086.0 5122.7 5132.5 5180.8 4895.2 4951.2 4968.1 4982.6 5098.3 3846.1 3857.6 3863.9 3888.0 3890.8 3848.3 3859.7 3890.3 3915.2 3948.0 3828.8 3837.3 3843.2 3843.4 3901.3 3850.7 3851.8 3851.9 3871.0 3913.5 3201.4 3248.7 3265.5 3298.9 3301.1 4886.9 4887.4 4901.9 4937.1 4992.2 4278.6 4294.2 4296.4 4298.1 4334.7 5205.1 5217.1 5238.4 5263.6 5284.6 3341.0 3388.1 3469.5 3505.7 3563.3 5429.1 5521.8 5540.0 5542.8 5561.3 3589.8 3596.2 3605.6 3610.0 3649.7 3461.8 3546.5 3589.5 3632.1 3670.1 4183.3 4205.3 4222.6 4249.9 4303.6 5275.6 5275.9 5292.5 5317.3 5334.6 1298.6 1325.2 1326.7 1329.4 1358.5 829.0 844.6 846.5 866.6 869.0 5092.4 5114.2 5122.7 5140.3 5235.8 5502.9 5520.8 5548.4 5582.9 5593.8 5127.5 5175.5 5193.9 5237.1 5243.3 2989.9 3036.7 3065.2 3071.0 3081.5 5594.7 5628.5 5639.8 5644.4 5741.1 5615.2 5631.7 5647.3 5708.1 5740.7 5555.9 5630.1 5637.7 5667.8 5738.3 5216.3 5552.9 5579.0 5580.6 5630.5 5482.2 5488.9 5510.2 5532.9 5552.7 5634.5 5656.2 5686.1 5688.9 5767.6 3538.5 3611.5 3662.1 3663.9 3664.4 5289.8 5352.5 5503.8 5516.2 5525.3 5211.7 5270.2 5319.4 5338.8 5405.9 5285.9 5337.8 5366.7 5373.7 5388.0 5198.5 5215.3 5223.3 5224.8 5268.6 5178.1 5329.4 5359.1 5368.8 5389.6 5294.9 5314.6 5315.9 5328.8 5386.8 19:56:58 INFO - 2015-11-04 19:56:58,247 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,247 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11066.73 Median:5311.05 stddev:13560.32 (255.3%) stddev-sans-first:13574.96 19:56:58 INFO - 2015-11-04 19:56:58,248 DEBUG : BROWSER_OUTPUT: Values: 458.2 478.0 488.3 508.3 513.9 12845.0 13028.3 13044.4 13099.1 13188.4 11947.0 11979.8 12004.8 12024.9 12076.4 569.3 582.8 724.2 728.8 735.9 586.7 711.2 728.7 738.4 741.4 708.2 735.7 738.3 738.3 739.6 581.5 597.0 722.4 738.7 740.5 539.3 539.5 540.9 544.5 548.1 11283.5 11459.1 11504.1 11525.1 11587.7 8159.9 8197.7 8279.7 8326.2 8416.1 7242.6 7298.2 7514.0 7603.6 7612.4 2482.3 2496.3 2562.7 2648.0 2675.4 38259.4 38797.0 38810.6 39148.6 39168.0 5290.9 5331.2 5397.0 5447.5 5449.3 9973.2 9978.6 10026.1 10095.5 10163.6 5185.6 5210.5 5470.2 5482.9 5494.6 3102.3 3227.1 3241.5 3279.8 3335.5 2115.6 2147.3 2147.6 2159.0 2183.8 313.0 319.3 320.4 321.9 323.4 428.1 428.2 431.1 431.8 448.8 6440.2 6552.5 6745.9 6798.5 6834.7 390.9 414.2 446.5 455.1 487.8 3057.5 3179.2 3231.8 3307.1 3346.3 49404.3 49666.8 49852.8 49967.3 50386.2 42165.0 42628.0 42769.6 43306.6 43446.6 38797.8 38915.8 39075.6 39575.8 40561.4 6408.3 6617.5 6660.8 6719.1 6767.6 28848.3 29562.4 29571.3 30582.0 31352.2 35834.5 37056.8 37222.3 37269.4 38143.4 8310.1 8469.5 8563.3 8576.0 8638.6 8838.8 8851.8 8869.2 8921.1 8924.6 8289.0 8369.8 8434.7 8480.4 8481.1 8375.1 8384.2 8453.6 8499.3 8515.8 8175.1 8366.1 8462.2 8485.3 8520.5 7253.6 7399.3 7789.2 7818.8 7830.5 7276.8 7546.6 7552.6 7708.8 7710.6 19:56:58 INFO - 2015-11-04 19:56:58,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:56:58 INFO - 2015-11-04 19:56:58,248 DEBUG : BROWSER_OUTPUT: 19:56:58 INFO - 2015-11-04 19:56:58,828 INFO : Browser exited with error code: 0 19:56:58 INFO - 2015-11-04 19:56:58,862 INFO : Completed test dromaeo_css (00:18:35) 19:56:58 INFO - 2015-11-04 19:56:58,862 INFO : Starting test kraken 19:56:58 INFO - 2015-11-04 19:56:58,862 DEBUG : operating with platform_type : mac_ 19:56:58 INFO - 2015-11-04 19:56:58,863 INFO : Initialising browser for kraken test... 19:56:58 INFO - 2015-11-04 19:56:58,878 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpBM3GDm/profile http://localhost:49331/getInfo.html 19:57:01 INFO - 2015-11-04 19:57:01,370 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:57:01 INFO - 2015-11-04 19:57:01,370 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:57:01 INFO - 2015-11-04 19:57:01,370 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:57:01 INFO - 2015-11-04 19:57:01,370 DEBUG : BROWSER_OUTPUT: __metrics 19:57:01 INFO - 2015-11-04 19:57:01,386 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:02 INFO - 2015-11-04 19:57:02,178 INFO : Browser initialized. 19:57:02 INFO - 2015-11-04 19:57:02,178 INFO : Running cycle 1/1 for kraken test... 19:57:02 INFO - 2015-11-04 19:57:02,179 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpBM3GDm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:57:14 INFO - 2015-11-04 19:57:14,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 221016064 19:57:14 INFO - 2015-11-04 19:57:14,248 DEBUG : BROWSER_OUTPUT: 19:57:17 INFO - 2015-11-04 19:57:17,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-beat-detection) 19:57:17 INFO - 2015-11-04 19:57:17,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 277118976 19:57:17 INFO - 2015-11-04 19:57:17,779 DEBUG : BROWSER_OUTPUT: 19:57:20 INFO - 2015-11-04 19:57:20,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-dft) 19:57:21 INFO - 2015-11-04 19:57:21,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 291840000 19:57:21 INFO - 2015-11-04 19:57:21,414 DEBUG : BROWSER_OUTPUT: 19:57:24 INFO - 2015-11-04 19:57:24,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-fft) 19:57:25 INFO - 2015-11-04 19:57:25,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 277192704 19:57:25 INFO - 2015-11-04 19:57:25,369 DEBUG : BROWSER_OUTPUT: 19:57:27 INFO - 2015-11-04 19:57:27,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-oscillator) 19:57:28 INFO - 2015-11-04 19:57:28,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 278675456 19:57:28 INFO - 2015-11-04 19:57:28,256 DEBUG : BROWSER_OUTPUT: 19:57:30 INFO - 2015-11-04 19:57:30,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:57:31 INFO - 2015-11-04 19:57:31,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 280473600 19:57:31 INFO - 2015-11-04 19:57:31,291 DEBUG : BROWSER_OUTPUT: 19:57:34 INFO - 2015-11-04 19:57:34,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49331/tests/kraken/driver.html?testName=imaging-darkroom) 19:57:35 INFO - 2015-11-04 19:57:35,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 274640896 19:57:35 INFO - 2015-11-04 19:57:35,379 DEBUG : BROWSER_OUTPUT: 19:57:38 INFO - 2015-11-04 19:57:38,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49331/tests/kraken/driver.html?testName=imaging-desaturate) 19:57:39 INFO - 2015-11-04 19:57:39,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 275267584 19:57:39 INFO - 2015-11-04 19:57:39,606 DEBUG : BROWSER_OUTPUT: 19:57:42 INFO - 2015-11-04 19:57:42,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49331/tests/kraken/driver.html?testName=json-parse-financial) 19:57:43 INFO - 2015-11-04 19:57:43,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 277704704 19:57:43 INFO - 2015-11-04 19:57:43,555 DEBUG : BROWSER_OUTPUT: 19:57:45 INFO - 2015-11-04 19:57:45,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:57:45 INFO - 2015-11-04 19:57:45,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 312250368 19:57:45 INFO - 2015-11-04 19:57:45,854 DEBUG : BROWSER_OUTPUT: 19:57:47 INFO - 2015-11-04 19:57:47,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:57:48 INFO - 2015-11-04 19:57:48,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 312827904 19:57:48 INFO - 2015-11-04 19:57:48,492 DEBUG : BROWSER_OUTPUT: 19:57:50 INFO - 2015-11-04 19:57:50,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:57:51 INFO - 2015-11-04 19:57:51,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 319909888 19:57:51 INFO - 2015-11-04 19:57:51,462 DEBUG : BROWSER_OUTPUT: 19:57:54 INFO - 2015-11-04 19:57:54,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:57:55 INFO - 2015-11-04 19:57:55,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 320622592 19:57:55 INFO - 2015-11-04 19:57:55,051 DEBUG : BROWSER_OUTPUT: 19:57:58 INFO - 2015-11-04 19:57:58,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:57:58 INFO - 2015-11-04 19:57:58,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 319348736 19:57:58 INFO - 2015-11-04 19:57:58,591 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49331/tests/kraken/driver.html?testName=ai-astar) 19:58:00 INFO - 2015-11-04 19:58:00,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 380395520 19:58:00 INFO - 2015-11-04 19:58:00,803 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,803 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:58:00 INFO - 2015-11-04 19:58:00,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:58:00 INFO - 2015-11-04 19:58:00,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:58:00 INFO - 2015-11-04 19:58:00,804 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:58:00 INFO - 2015-11-04 19:58:00,804 DEBUG : BROWSER_OUTPUT: |0;ai-astar;120;128;125;132;132;134;114;126;133;124 19:58:00 INFO - 2015-11-04 19:58:00,804 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;160;183;195;153;183;179;152;197;154 19:58:00 INFO - 2015-11-04 19:58:00,804 DEBUG : BROWSER_OUTPUT: |2;audio-dft;188;194;197;197;187;195;198;199;189;188 19:58:00 INFO - 2015-11-04 19:58:00,804 DEBUG : BROWSER_OUTPUT: |3;audio-fft;89;92;108;104;82;85;85;106;104;81 19:58:00 INFO - 2015-11-04 19:58:00,805 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;114;159;108;110;106;150;103;109;160 19:58:00 INFO - 2015-11-04 19:58:00,805 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;142;142;140;142;143;148;138;142;135 19:58:00 INFO - 2015-11-04 19:58:00,805 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;155;155;154;153;147;154;154;152;147 19:58:00 INFO - 2015-11-04 19:58:00,805 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;125;136;133;129;124;124;123;123;123 19:58:00 INFO - 2015-11-04 19:58:00,805 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;66;67;69;74;71;78;80;70;70 19:58:00 INFO - 2015-11-04 19:58:00,806 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;75;78;82;82;83;82;83;79;79 19:58:00 INFO - 2015-11-04 19:58:00,806 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;99;104;106;106;104;107;105;104;108;115 19:58:00 INFO - 2015-11-04 19:58:00,806 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;150;151;153;156;169;158;162;161;152;159 19:58:00 INFO - 2015-11-04 19:58:00,806 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;181;183;183;181;183;188;180;174;160 19:58:00 INFO - 2015-11-04 19:58:00,806 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;82;84;84;84;86;85;86;84;85 19:58:00 INFO - 2015-11-04 19:58:00,807 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:58:00 INFO - 2015-11-04 19:58:00,807 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:58:00 INFO - 2015-11-04 19:58:00,807 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 19:58:00 INFO - 2015-11-04 19:58:00,807 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:58:00 INFO - 2015-11-04 19:58:00,807 DEBUG : BROWSER_OUTPUT: __startTimestamp1446695880799__endTimestamp 19:58:00 INFO - 2015-11-04 19:58:00,808 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,808 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:58:00 INFO - 2015-11-04 19:58:00,808 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:58:00 INFO - 2015-11-04 19:58:00,808 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,808 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:126.80 Median:130.00 stddev:6.39 (4.9%) stddev-sans-first:6.29 19:58:00 INFO - 2015-11-04 19:58:00,809 DEBUG : BROWSER_OUTPUT: Values: 120.0 128.0 125.0 132.0 132.0 134.0 114.0 126.0 133.0 124.0 19:58:00 INFO - 2015-11-04 19:58:00,809 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,809 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:174.10 Median:183.00 stddev:17.63 (9.6%) stddev-sans-first:18.26 19:58:00 INFO - 2015-11-04 19:58:00,809 DEBUG : BROWSER_OUTPUT: Values: 185.0 160.0 183.0 195.0 153.0 183.0 179.0 152.0 197.0 154.0 19:58:00 INFO - 2015-11-04 19:58:00,809 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,809 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.20 Median:196.00 stddev:4.71 (2.4%) stddev-sans-first:4.60 19:58:00 INFO - 2015-11-04 19:58:00,810 DEBUG : BROWSER_OUTPUT: Values: 188.0 194.0 197.0 197.0 187.0 195.0 198.0 199.0 189.0 188.0 19:58:00 INFO - 2015-11-04 19:58:00,810 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,810 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.60 Median:83.50 stddev:10.76 (12.9%) stddev-sans-first:11.29 19:58:00 INFO - 2015-11-04 19:58:00,810 DEBUG : BROWSER_OUTPUT: Values: 89.0 92.0 108.0 104.0 82.0 85.0 85.0 106.0 104.0 81.0 19:58:00 INFO - 2015-11-04 19:58:00,810 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,810 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.00 Median:112.50 stddev:23.33 (20.7%) stddev-sans-first:24.34 19:58:00 INFO - 2015-11-04 19:58:00,811 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 159.0 108.0 110.0 106.0 150.0 103.0 109.0 160.0 19:58:00 INFO - 2015-11-04 19:58:00,811 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,811 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:140.80 Median:142.00 stddev:3.77 (2.7%) stddev-sans-first:3.57 19:58:00 INFO - 2015-11-04 19:58:00,811 DEBUG : BROWSER_OUTPUT: Values: 136.0 142.0 142.0 140.0 142.0 143.0 148.0 138.0 142.0 135.0 19:58:00 INFO - 2015-11-04 19:58:00,811 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,812 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:151.90 Median:154.00 stddev:3.28 (2.1%) stddev-sans-first:3.16 19:58:00 INFO - 2015-11-04 19:58:00,812 DEBUG : BROWSER_OUTPUT: Values: 148.0 155.0 155.0 154.0 153.0 147.0 154.0 154.0 152.0 147.0 19:58:00 INFO - 2015-11-04 19:58:00,812 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,812 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.80 Median:124.50 stddev:5.35 (4.3%) stddev-sans-first:4.87 19:58:00 INFO - 2015-11-04 19:58:00,812 DEBUG : BROWSER_OUTPUT: Values: 118.0 125.0 136.0 133.0 129.0 124.0 124.0 123.0 123.0 123.0 19:58:00 INFO - 2015-11-04 19:58:00,813 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,813 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.80 Median:70.50 stddev:5.27 (7.5%) stddev-sans-first:4.77 19:58:00 INFO - 2015-11-04 19:58:00,813 DEBUG : BROWSER_OUTPUT: Values: 63.0 66.0 67.0 69.0 74.0 71.0 78.0 80.0 70.0 70.0 19:58:00 INFO - 2015-11-04 19:58:00,813 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,813 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.40 Median:82.00 stddev:3.92 (4.8%) stddev-sans-first:2.74 19:58:00 INFO - 2015-11-04 19:58:00,814 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 78.0 82.0 82.0 83.0 82.0 83.0 79.0 79.0 19:58:00 INFO - 2015-11-04 19:58:00,814 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,814 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.80 Median:106.50 stddev:4.05 (3.8%) stddev-sans-first:3.47 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: Values: 99.0 104.0 106.0 106.0 104.0 107.0 105.0 104.0 108.0 115.0 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:158.50 stddev:5.93 (3.7%) stddev-sans-first:5.71 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: Values: 150.0 151.0 153.0 156.0 169.0 158.0 162.0 161.0 152.0 159.0 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:182.00 stddev:9.75 (5.4%) stddev-sans-first:8.09 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: Values: 160.0 181.0 183.0 183.0 181.0 183.0 188.0 180.0 174.0 160.0 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: 19:58:00 INFO - 2015-11-04 19:58:00,816 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.90 Median:84.50 stddev:2.08 (2.5%) stddev-sans-first:1.24 19:58:00 INFO - 2015-11-04 19:58:00,817 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 84.0 84.0 84.0 86.0 85.0 86.0 84.0 85.0 19:58:00 INFO - 2015-11-04 19:58:00,817 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:58:00 INFO - 2015-11-04 19:58:00,817 DEBUG : BROWSER_OUTPUT: 19:58:01 INFO - 2015-11-04 19:58:01,511 INFO : Browser exited with error code: 0 19:58:01 INFO - 2015-11-04 19:58:01,569 INFO : Completed test kraken (00:01:02) 19:58:01 INFO - 2015-11-04 19:58:01,569 INFO : Starting test v8_7 19:58:01 INFO - 2015-11-04 19:58:01,569 DEBUG : operating with platform_type : mac_ 19:58:01 INFO - 2015-11-04 19:58:01,569 INFO : Initialising browser for v8_7 test... 19:58:01 INFO - 2015-11-04 19:58:01,590 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmp1YgvzU/profile http://localhost:49331/getInfo.html 19:58:04 INFO - 2015-11-04 19:58:04,036 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:58:04 INFO - 2015-11-04 19:58:04,036 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:58:04 INFO - 2015-11-04 19:58:04,037 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:58:04 INFO - 2015-11-04 19:58:04,037 DEBUG : BROWSER_OUTPUT: __metrics 19:58:04 INFO - 2015-11-04 19:58:04,057 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:58:04 INFO - 2015-11-04 19:58:04,833 INFO : Browser initialized. 19:58:04 INFO - 2015-11-04 19:58:04,833 INFO : Running cycle 1/1 for v8_7 test... 19:58:04 INFO - 2015-11-04 19:58:04,834 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmp1YgvzU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:58:16 INFO - 2015-11-04 19:58:16,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 220614656 19:58:16 INFO - 2015-11-04 19:58:16,907 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49331/tests/v8_7/run.html (next: http://localhost:49331/tests/v8_7/run.html) 19:58:39 INFO - 2015-11-04 19:58:39,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 700678144 19:58:39 INFO - 2015-11-04 19:58:39,807 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,807 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:58:39 INFO - 2015-11-04 19:58:39,807 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:58:39 INFO - 2015-11-04 19:58:39,807 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:58:39 INFO - 2015-11-04 19:58:39,807 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |0;Richards;196.50225977598743 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;240.73182474723157 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |2;Encrypt;378.64445285876565 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6944.827586206897 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2500 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |5;Earley;961.5384615384615 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |6;Boyer;15687.5 19:58:39 INFO - 2015-11-04 19:58:39,808 DEBUG : BROWSER_OUTPUT: |7;RegExp;35719.29824561404 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: |8;Splay;912.4886052871468 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6856.164383561644 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: __startTimestamp1446695919801__endTimestamp 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:58:39 INFO - 2015-11-04 19:58:39,809 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:196.50 Median:196.50 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: Values: 196.5 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:240.73 Median:240.73 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: Values: 240.7 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:378.64 Median:378.64 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,810 DEBUG : BROWSER_OUTPUT: Values: 378.6 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6944.83 Median:6944.83 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: Values: 6944.8 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2500.00 Median:2500.00 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: Values: 2500.0 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,811 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:961.54 Median:961.54 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: Values: 961.5 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15687.50 Median:15687.50 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: Values: 15687.5 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35719.30 Median:35719.30 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: Values: 35719.3 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:912.49 Median:912.49 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: Values: 912.5 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6856.16 Median:6856.16 stddev:0.00 (0.0%) 19:58:39 INFO - 2015-11-04 19:58:39,812 DEBUG : BROWSER_OUTPUT: Values: 6856.2 19:58:39 INFO - 2015-11-04 19:58:39,813 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:58:39 INFO - 2015-11-04 19:58:39,813 DEBUG : BROWSER_OUTPUT: 19:58:40 INFO - 2015-11-04 19:58:40,544 INFO : Browser exited with error code: 0 19:58:40 INFO - 2015-11-04 19:58:40,568 INFO : Completed test v8_7 (00:00:38) 19:58:40 INFO - 2015-11-04 19:58:40,789 INFO : Completed test suite (00:20:17) 19:58:40 INFO - 2015-11-04 19:58:40,789 DEBUG : Working with test: dromaeo_css 19:58:40 INFO - 2015-11-04 19:58:40,789 DEBUG : Generating results file: dromaeo_css 19:58:40 INFO - 2015-11-04 19:58:40,790 DEBUG : Working with test: kraken 19:58:40 INFO - 2015-11-04 19:58:40,790 DEBUG : Generating results file: kraken 19:58:40 INFO - 2015-11-04 19:58:40,790 INFO : javascript benchmark 19:58:40 INFO - 2015-11-04 19:58:40,790 DEBUG : Working with test: v8_7 19:58:40 INFO - 2015-11-04 19:58:40,790 DEBUG : Generating results file: v8_7 19:58:40 INFO - 2015-11-04 19:58:40,790 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:40 INFO - 2015-11-04 19:58:40,849 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 19:58:40 INFO - 2015-11-04 19:58:40,849 DEBUG : process_Request line: dromaeo_css 5493.52 graph.html#tests=[[72,63,55]] 19:58:40 INFO - 2015-11-04 19:58:40,849 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:40 INFO - 2015-11-04 19:58:40,875 DEBUG : process_Request line: kraken 1803.50 graph.html#tests=[[232,63,55]] 19:58:40 INFO - 2015-11-04 19:58:40,875 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:40 INFO - 2015-11-04 19:58:40,909 DEBUG : process_Request line: v8_7 15064.80 graph.html#tests=[[230,63,55]] 19:58:40 INFO - 2015-11-04 19:58:40,910 INFO : javascript benchmark 19:58:40 INFO - 2015-11-04 19:58:40,912 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [282.26329280577687, 282.55215483458716, 283.05459764386944, 286.53438162985145, 293.7987478577174, 9312.8603070954, 10107.090361867431, 14639.780403293946, 14863.182524961123, 15134.394624215018, 16217.756733649005, 16322.510324690249, 16993.83006169938, 17025.82974170258, 17152.056636884965, 4651.813927442899, 4817.807287708488, 4834.734089625069, 4904.558589726924, 4908.43552991407, 4709.175894218515, 4794.0, 4800.703809971305, 4817.0, 4875.70745755254, 3315.5026745988052, 3506.7019303359243, 3506.7194624430113, 4749.168895443301, 4770.952290477103, 4951.2573114033, 5168.302279192299, 5212.895742085175, 5220.269162317279, 5311.893762124774, 4293.248681480728, 4298.11888562847, 4299.871003869889, 4421.557844215585, 4621.514740952185, 19036.238550457965, 19065.714014289795, 19145.808541914543, 19254.71117933232, 19365.80634193668, 1623.2046297314348, 1643.2089022964906, 1656.1222552047434, 1983.355409491921, 1997.1412292714126, 11399.715007124889, 11782.941085294604, 12067.818982715266, 12112.636620901387, 12554.68613284666, 1434.978475322871, 1456.5557504960982, 1458.7155504676593, 1472.2050092949794, 1480.6002379357512, 41014.1797164058, 42470.362944555854, 42775.786121069505, 42852.57147428548, 48377.27434088491, 5330.0, 5441.319835020622, 5471.0, 5484.561235101182, 5522.22688823565, 6168.8766224675255, 6175.536834737412, 6180.289266734293, 6208.689565521706, 6228.816524860262, 4407.228734971367, 4507.887302817456, 4513.0, 4600.88497787558, 4637.304404339308, 4883.731394773251, 4973.2042873140845, 4979.178435558092, 4993.325901003318, 4997.650164488524, 2372.0, 2408.3858616052794, 2475.8390704604144, 2488.228649118779, 2498.5502609530095, 823.7405217356513, 850.4472093139385, 860.2343913916619, 892.3352102683542, 921.0329154387866, 321.5530412726312, 335.7532213822838, 344.3216862780319, 356.2252101678838, 370.73862926636656, 9034.2320902724, 9237.584308706124, 9390.201832844148, 9503.097205765442, 9643.566039528238, 339.15888596280865, 372.2907860525703, 378.6175962278119, 389.2701185277605, 394.9684025277971, 5045.520675535819, 5167.405748338989, 5243.947560524346, 5256.474352564789, 5273.525382715574, 440134.0, 448158.0, 449827.0, 450536.0, 466113.0, 53618.19572706413, 54160.0, 54977.72511137499, 55517.44482555203, 55555.0, 406.30319002910153, 409.11834995584564, 409.35935261315944, 410.2840543252044, 411.08123344325406, 8952.68665596701, 9115.0, 9132.178103970675, 9138.223251023472, 9217.631294748135, 27458.17625471239, 27524.311892202855, 27554.11612413126, 27849.721502784712, 27850.721492784814, 36815.26369472649, 37651.81174094112, 38506.80746596249, 38714.41928371133, 39061.41407878827, 5142.280080788618, 5255.658382205144, 5258.658187217971, 5264.9210261846865, 5294.444083371191, 9418.858717119112, 9513.096255855682, 9983.650572229937, 10010.04904534068, 10021.198304135798, 8379.874301885598, 8611.95694021526, 8655.394122411371, 8677.956610216908, 8686.739397818075, 7831.451798374059, 8166.550839703873, 8186.058603260702, 8402.32781377476, 8470.0, 8289.668413263644, 8545.401821872409, 8901.777455563404, 8986.68546600866, 9005.459672419676, 4378.16814805186, 4496.77516124186, 4499.730016199039, 5027.321311622884, 5145.61407894402, 8120.675172993014, 8130.63412146443, 8234.258916697527, 8333.916660833314, 8395.32837373021], "dojo.html": [2572.729863364347, 2665.586834040724, 2673.7860971122313, 2700.1629494856597, 2705.6347393101937, 4298.204832106063, 4373.8031788569515, 4376.168527979686, 4432.091421258642, 4479.955200447995, 4330.826766929319, 4355.564443555643, 4362.760048197348, 4390.67069969752, 4492.61812745917, 4028.858989935353, 4128.710990230685, 4158.4178215049915, 4164.063085805685, 4228.76741779202, 51.828013138890284, 3849.7497662651976, 3915.2561013407503, 4033.35466325388, 4056.1482088761395, 3954.4463775071513, 4037.6366127048414, 4059.9188016239805, 4083.3874918762126, 4151.647109995639, 4075.5924407559305, 4100.5489396166395, 4106.137711080677, 4113.547509773923, 4138.6482149017365, 3926.666233370167, 4033.495813023372, 4053.229886321619, 4098.569650186747, 4132.214879172978, 4270.167317373113, 4415.712978656377, 4418.403515525395, 4430.756308403036, 4435.423394958667, 4674.555917187861, 4729.337892695025, 4730.219513780222, 4734.739589322586, 4764.428268607755, 4556.225441674923, 4671.85984420468, 4779.091972525209, 4818.10864989978, 4831.202851529529, 4314.568543145691, 4410.647148228134, 4418.116376724668, 4434.623057040156, 4436.600705936449, 4843.0313937211995, 4851.684640498356, 4906.484819093944, 4959.876003099879, 4960.77676504551, 4380.233459144701, 4440.600345968878, 4654.371659825948, 4715.717056976524, 4763.45220299663, 4624.190766615829, 4624.28323609841, 4682.555157260055, 4698.201305778026, 4746.8101275948575, 4642.767861606906, 4691.46048204454, 4694.084653492536, 4725.621950243973, 4784.832530861403, 4487.977560112178, 4624.699394539344, 4754.667173297836, 4768.046390721869, 4801.207800712913, 3615.3311637347174, 3635.94546081809, 3649.671529562352, 3665.8533658653887, 3688.133288677159, 3307.6196237432523, 3309.1561651778643, 3311.8675252990092, 3317.834108294576, 3372.0389688938535, 4487.573680500347, 4498.347739577743, 4502.099580083996, 4514.074614703978, 4556.589906908394, 4520.52534483881, 4638.79125439356, 4655.743934083658, 4660.487346391894, 4676.906461870812, 4434.733915965053, 4472.865814025519, 4511.819527218874, 4541.772911354419, 4602.769861506911, 4234.322508398642, 4234.703570750018, 4242.278812601865, 4245.893852653709, 4309.655227581786, 4669.603083737852, 4855.635827312895, 4871.342368780241, 4888.388951381077, 4918.8770280743265, 4551.704139230939, 4627.398438203012, 4659.627229821674, 4678.391809064936, 4747.311639812277, 4817.566419022305, 4830.178869592248, 4842.0, 4851.248056551241, 4905.533974272438, 4488.640908727229, 4645.326427667902, 4716.29255611661, 4748.857534273978, 4779.378680771478, 4677.602403795579, 4736.739479328532, 4758.262469317261, 4779.617630589475, 4784.138855005993, 4504.572065653758, 4669.626429885669, 4690.859274221779, 4722.740249286322, 4723.173444647105, 4452.087322099027, 4583.702059366131, 4609.423822022247, 4625.676202665781, 4693.694909830987, 4434.224010798033, 4497.280435130363, 4526.0, 4544.159330523864, 4606.493285738499, 4414.293713005904, 4450.310201918578, 4461.687681862239, 4481.395011673382, 4707.952920470751, 4350.32569951658, 4430.75630840294, 4440.689151759475, 4447.199504089295, 4677.508861569622], "mootools.html": [1041.6718733598912, 1128.2666266926497, 1141.246777127096, 1304.8890844278235, 1486.8587484189004, 5669.659820410773, 5895.823125306242, 6155.384461553843, 6279.874402511947, 6408.070829729698, 6136.662483563402, 6267.310595834455, 6293.590916590419, 6310.747570097202, 6329.050642403642, 1601.4875239923228, 1612.5323656139706, 1768.5313391951177, 1789.633125209329, 1800.0, 1578.2187817030585, 1775.7691500104968, 1811.529002459357, 1818.3908390689135, 1821.471773185781, 1730.5068055604156, 1747.8863873848159, 1754.8944165175985, 1763.8853474524115, 1775.9733603995885, 1781.0115385960787, 1807.1416077363147, 1814.83666470017, 1822.535253510353, 1832.697604895204, 1774.7222000159863, 1797.667431525172, 1799.7840259168852, 1812.8005919348861, 1834.302964873353, 6238.781642642532, 6314.242290925073, 6314.494840412802, 6368.0, 6414.358564143595, 3775.886723398275, 3857.9421308680394, 3867.207222519377, 3885.7279990400684, 3889.2221555688693, 2224.7552769195377, 2274.601944659678, 2314.36355002374, 2317.698699169114, 2339.239747082205, 583.2564168024949, 665.2117241069349, 673.3973094080819, 689.7034275261635, 691.4537515362857, 8003.799905002364, 8009.879851802228, 8024.959875200645, 8047.718329858427, 8069.112397636255, 3319.4025075486643, 3418.8974330770116, 3450.275442157125, 3464.6015708193377, 3536.982315088408, 7088.468364872552, 7122.109736282965, 7128.7504937327985, 7180.820479488055, 7196.532225405332, 3781.6596506314563, 3803.3154032274456, 3815.008097894512, 3823.617638236154, 3840.135969406861, 3451.6375780543185, 3463.7748546344405, 3478.6347433519118, 3489.0405138586584, 3510.227749895019, 2960.363521842814, 3024.2590565311198, 3027.8637461314293, 3032.348045170299, 3061.2959019425657, 963.9903600964041, 969.7914948286011, 986.0386123529502, 988.6243227573476, 995.4276291132628, 1068.5832525315134, 1079.794838980591, 1081.1729027294127, 1089.8256278995482, 1123.2586492914636, 5860.882782344329, 5890.087036509348, 5900.055991041499, 5901.40985901415, 6004.639721616717, 359.8938313197613, 955.8040601676639, 1004.7739258666742, 1033.7415646088477, 1062.6918193723734, 4713.128071306819, 4715.528447155326, 4721.622270218374, 4730.385049943486, 4738.3129446230105, 7361.411087113018, 7364.079490063742, 7404.851902961911, 7451.888221676679, 7525.473216874876, 7449.6275186241555, 7459.776206713807, 7462.776116716507, 7484.288992545699, 7521.811954701177, 5211.869703257449, 5415.566754659618, 5551.8889622207325, 5784.566157538202, 5878.118282257696, 5711.228984087095, 5867.413258674099, 5882.382349853204, 5884.235049443545, 5943.91084133747, 6531.542792004514, 6592.7033283503315, 6610.933890661224, 6618.602883826986, 6665.633390163393, 6522.902156467562, 6682.064510968566, 6715.630640314635, 6770.86458270822, 6835.453163746789, 5278.076336640996, 5301.151815709468, 5315.335583052119, 5376.408595054619, 5379.65032272901, 5944.64332140073, 5966.313873904556, 5979.0, 5980.910286345621, 5982.192404025575, 5385.084535629031, 5429.511343979061, 5444.6188766785945, 5683.829485115453, 5783.0, 5516.600278878701, 5556.833295001156, 5575.6933368663495, 5649.915251271152, 5712.0, 5638.4925356718095, 5681.119426488901, 5715.514181294637, 5717.942820571741, 5743.56923230751, 5093.592512598909, 5136.922946155736, 5139.665921715076, 5194.714290713896, 5199.428062913001, 5226.346706661668, 5279.366476022902, 5279.419263880894, 5298.337707786527, 5331.920021199608], "ext.html": [449.5167694728167, 451.3951305250964, 453.5102089743078, 459.7861994172711, 482.7634459115035, 26124.2162735118, 27004.189874303753, 31822.522662160085, 32286.0, 32390.190245243823, 34939.0, 34984.825075874585, 35168.29663406737, 35182.0, 35771.821140894324, 6861.4510839133, 7639.427042971785, 7839.137694853562, 7881.290683838453, 7943.086545047307, 6983.2318444971015, 9161.770955726126, 9445.244380449582, 9482.952585237064, 9576.186024187953, 9222.308326875478, 9396.15434610885, 9413.48225847578, 9413.717588472357, 9543.522823858779, 6984.546004509691, 7201.495895287332, 9033.412828166149, 9217.354785165042, 9320.953395233015, 8847.247983921374, 8887.466751994902, 9083.500407477586, 9089.045650206765, 9112.5443727814, 30077.69922300771, 30350.0, 30464.54303185454, 30690.23274418135, 30793.076207713806, 2611.7388261173733, 2783.4154827486254, 2816.2677703796953, 2916.7229113234207, 2922.7807914406294, 23065.654015189786, 23886.761132388627, 24014.75985240143, 24047.759522404725, 25318.620220696703, 1632.1920649278684, 1684.713598688226, 1698.5923378389098, 1723.3709695960883, 1723.482955113461, 225858.0, 227862.0, 228193.0, 231339.0, 232400.0, 47782.283265751044, 48950.0, 49043.26435103476, 51877.74061129746, 52016.479835201164, 59363.70318148468, 59689.0, 60004.39995600076, 60205.09692354618, 60752.0, 13569.932150339382, 13627.0, 13642.863571364358, 13712.314384280746, 13834.93082534581, 10378.221633377527, 10405.687829365132, 10440.060394564525, 10494.317869338469, 10511.319613498661, 17194.0, 17204.741928871077, 17249.0, 17345.2194651241, 17456.127193640266, 7037.753678621224, 7118.074650295428, 7244.927550724531, 7256.492045556866, 7316.524425912298, 781.5935713428985, 791.6912404162381, 815.1278132398277, 819.1439945257221, 919.2416256588341, 23571.528569428516, 23747.525049498912, 24074.51850962971, 24151.411231865888, 24230.0, 894.3113802372137, 932.8367535681228, 964.4647220792388, 1009.6869970309227, 1011.367895065584, 12308.323042232583, 12585.87414125847, 12597.496100155891, 12672.80990785139, 12757.234565926074, 264353.0, 270734.0, 274038.0, 274630.0, 274686.0, 46476.767616161706, 47013.05973880503, 47119.76440117846, 47142.29286560704, 47819.521804782205, 1133.121830581306, 1148.9885101149048, 1159.4550561236206, 1163.0637336943842, 1164.4818055965184, 22454.663180052637, 23617.763822362245, 25017.624735628615, 25650.0, 26724.0, 44900.326495103254, 44971.0, 45016.77491612521, 45818.08363832771, 46522.27821774317, 254759.0, 260591.0, 261258.0, 261558.0, 262928.0, 28820.855895720386, 29982.25044373821, 35887.102822429646, 36237.275254494234, 38574.0, 35548.28903421865, 36030.279394412486, 36082.27835443224, 36177.819110904275, 36593.81703091574, 29507.409851802415, 30378.696213037587, 30598.0, 32939.91791764782, 33291.66708332886, 29175.854120729262, 29300.681469333504, 29643.0, 29656.703432966257, 30037.69962300349, 30678.846605766827, 30679.0, 30906.227344316572, 31216.21959450941, 31473.0, 25388.365290867878, 26534.469310614066, 28912.566311504925, 28926.421471570873, 28927.0, 19921.701174482103, 19939.800601993793, 20070.59858802845, 20176.697349540063, 20235.392938211877], "prototype.html": [255.95776696845022, 258.93267750384894, 263.7586608253448, 267.65472540422854, 268.9152916831198, 5023.547880690737, 5086.0, 5122.743862806854, 5132.538071573557, 5180.766865491052, 4895.16782147035, 4951.183054795954, 4968.080905032562, 4982.601391888649, 5098.286239926404, 3846.115393459506, 3857.633524815138, 3863.942040869389, 3888.008557817767, 3890.8443662253476, 3848.345781217186, 3859.749116307431, 3890.3386424307796, 3915.2169566086754, 3947.960520394802, 3828.8468461261655, 3837.328467518187, 3843.231353729251, 3843.404272337792, 3901.2977664020464, 3850.7111966602615, 3851.826667799956, 3851.9422208666892, 3870.9806450967844, 3913.5303763548413, 3201.439748044083, 3248.6751324867323, 3265.510173473974, 3298.901032969015, 3301.0756988043386, 4886.877828054292, 4887.3890763654545, 4901.8774530636665, 4937.061958227961, 4992.201247800334, 4278.593533614302, 4294.205571969195, 4296.355546667994, 4298.054428025829, 4334.718243314174, 5205.089109405839, 5217.113090774577, 5238.449962753894, 5263.631545791796, 5284.577233821324, 3340.9832950835334, 3388.102152929476, 3469.4795780632853, 3505.6669616386403, 3563.251717139404, 5429.104197807357, 5521.751521181516, 5539.99999999996, 5542.7782888684405, 5561.304836895388, 3589.8025608591256, 3596.2088340565033, 3605.5673319201865, 3609.9892030231576, 3649.7445178837756, 3461.7576769625884, 3546.5212196353677, 3589.4974703541525, 3632.0919770057485, 3670.0641336459566, 4183.309753890635, 4205.306124489425, 4222.556631553704, 4249.87250382489, 4303.569643035734, 5275.577953763766, 5275.894482110336, 5292.497212764782, 5317.282166907496, 5334.573234141337, 1298.5649807314467, 1325.2313658078292, 1326.6550696818897, 1329.3884812985941, 1358.5380970470087, 828.9626966786509, 844.5819319436918, 846.5217152308926, 866.5970323799463, 868.9782755431165, 5092.414372347227, 5114.15616423286, 5122.718250496258, 5140.280360749498, 5235.790568377222, 5502.889942201134, 5520.806771762969, 5548.4174161713245, 5582.860428489239, 5593.8321850344555, 5127.4872512748425, 5175.4824517548695, 5193.896122077537, 5237.057329680694, 5243.292155558951, 2989.925251868677, 3036.69633036699, 3065.157081802522, 3070.9539356909663, 3081.4607443697264, 5594.720263986785, 5628.493435590816, 5639.802606908738, 5644.407337229614, 5741.081426971665, 5615.213870058195, 5631.746571404296, 5647.29408823897, 5708.086706127, 5740.68426236561, 5555.944440555542, 5630.127330263816, 5637.7181140942785, 5667.773289068391, 5738.340090889601, 5216.295800066942, 5552.944470555242, 5578.972105139448, 5580.581456390868, 5630.493255607015, 5482.17767334887, 5488.945110549003, 5510.228568000403, 5532.861678458071, 5552.666839989613, 5634.464725851038, 5656.208130861765, 5686.118651609007, 5688.943110568841, 5767.625104368202, 3538.5046093546407, 3611.5485564304463, 3662.066173125836, 3663.8900832975055, 3664.4136938089778, 5289.841304760864, 5352.518273355417, 5503.7798488060025, 5516.227728118147, 5525.309336332958, 5211.687298762086, 5270.156774915995, 5319.41486436484, 5338.786448542171, 5405.945940540544, 5285.867853303698, 5337.786488540415, 5366.7048312343195, 5373.650712703662, 5388.030154572215, 5198.532132108128, 5215.322008138917, 5223.268742375994, 5224.791008359623, 5268.57851371897, 5178.093833579184, 5329.413764485981, 5359.062164121186, 5368.7852485901685, 5389.649672771257, 5294.9205761912835, 5314.62797604164, 5315.867103322448, 5328.813491527778, 5386.757595908115], "yui.html": [458.2370353361653, 477.9866682632821, 488.2871008327842, 508.3493128795141, 513.8997895410395, 12845.0, 13028.283444410565, 13044.413001414936, 13099.083064185486, 13188.406521706522, 11947.0, 11979.760404791921, 12004.759904801898, 12024.879751202485, 12076.396180190999, 569.3054473542293, 582.833892340683, 724.1816747075796, 728.7995801154672, 735.91904890462, 586.7447660267776, 711.1927961763384, 728.726727477196, 738.35762886289, 741.4402126394565, 708.1608294171398, 735.6946867050168, 738.269113577557, 738.3391864281465, 739.6301849075462, 581.459242904099, 597.0417479944713, 722.357102179061, 738.7303634173514, 740.5334639177311, 539.2612121393715, 539.5063516882049, 540.864783804049, 544.4609836262072, 548.1175307754512, 11283.49224284901, 11459.140564457699, 11504.066463051868, 11525.077993760478, 11587.710307242301, 8159.877601835978, 8197.672093116269, 8279.70806686083, 8326.167383261685, 8416.074231834493, 7242.6378681065735, 7298.233685463003, 7513.962430187814, 7603.619819009027, 7612.391008719344, 2482.2801387597574, 2496.3010357100043, 2562.7309132541186, 2647.973520264792, 2675.42478367152, 38259.42610860839, 38797.0, 38810.61189388098, 39148.60851391507, 39168.0, 5290.92063619046, 5331.173668081454, 5397.0, 5447.455254474521, 5449.3188351456065, 9973.152282056106, 9978.600855965826, 10026.097651211427, 10095.495225238708, 10163.593456261815, 5185.585153187736, 5210.452902445264, 5470.234167216593, 5482.862928426821, 5494.587905907073, 3102.286474110922, 3227.1125440504047, 3241.546183534307, 3279.8196099214774, 3335.533025376449, 2115.598036373084, 2147.302126808793, 2147.5919575280645, 2159.039227543728, 2183.825293976478, 313.0, 319.3118828923673, 320.3864599292329, 321.94687876500586, 323.4146195386358, 428.1073960791784, 428.2035414129716, 431.1463302660749, 431.8445359670516, 448.82495826627644, 6440.194975628046, 6552.508561857784, 6745.932540674628, 6798.490113241527, 6834.6582670866255, 390.8573370719667, 414.169589972104, 446.51107037793565, 455.1352430382234, 487.8463284065508, 3057.5260834570677, 3179.1893067267697, 3231.8384080795868, 3307.107081088093, 3346.2972775716885, 49404.258936115984, 49666.751666241435, 49852.75073624681, 49967.25049124266, 50386.24420633693, 42165.0, 42628.0, 42769.57230427718, 43306.566934330884, 43446.56553434425, 38797.80601097033, 38915.80542097271, 39075.60924390776, 39575.80212098921, 40561.391579126335, 6408.308510425539, 6617.536772426077, 6660.800175994728, 6719.114190152974, 6767.593944363354, 28848.2787930295, 29562.408751824412, 29571.26071848221, 30582.0, 31352.21619459532, 35834.462483062256, 37056.814715926244, 37222.25555488929, 37269.440958386185, 38143.42784858285, 8310.085890552155, 8469.491830490191, 8563.272121869462, 8575.95712021436, 8638.56807159627, 8838.823223535623, 8851.822963540564, 8869.246114080375, 8921.107889211027, 8924.643014279356, 8289.0, 8369.790755231168, 8434.662613495391, 8480.448770829877, 8481.067082620782, 8375.07874133857, 8384.203500667427, 8453.577321133796, 8499.277561407349, 8515.82968340642, 8175.100738918595, 8366.121557236402, 8462.238398543914, 8485.278751306209, 8520.531370774666, 7253.566941295057, 7399.297066778648, 7789.1821358756515, 7818.765437036898, 7830.491018083806, 7276.792368460236, 7546.622668866425, 7552.584607846621, 7708.768736937901, 7710.614469276626]}, "summary": {"suite": 5493.527162793049, "subtests": {"jquery.html": {"filtered": 5848.100307564881, "value": 5848.100307564881}, "dojo.html": {"filtered": 4335.664328100435, "value": 4335.664328100435}, "mootools.html": {"filtered": 3567.131082321235, "value": 3567.131082321235}, "ext.html": {"filtered": 15955.111081812494, "value": 15955.111081812494}, "prototype.html": {"filtered": 3981.500417473616, "value": 3981.500417473616}, "yui.html": {"filtered": 4783.244757135017, "value": 4783.244757135017}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0067"}, "testrun": {"date": 1446694703, "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": "20151104175135", "branch": "Mozilla-Inbound", "revision": "91a6134ea200f28f562144a71a254e7a50881081"}}, {"talos_counters": {}, "results": {"audio-dft": [188.0, 194.0, 197.0, 197.0, 187.0, 195.0, 198.0, 199.0, 189.0, 188.0], "ai-astar": [120.0, 128.0, 125.0, 132.0, 132.0, 134.0, 114.0, 126.0, 133.0, 124.0], "imaging-gaussian-blur": [136.0, 142.0, 142.0, 140.0, 142.0, 143.0, 148.0, 138.0, 142.0, 135.0], "audio-beat-detection": [185.0, 160.0, 183.0, 195.0, 153.0, 183.0, 179.0, 152.0, 197.0, 154.0], "json-stringify-tinderbox": [71.0, 75.0, 78.0, 82.0, 82.0, 83.0, 82.0, 83.0, 79.0, 79.0], "stanford-crypto-pbkdf2": [160.0, 181.0, 183.0, 183.0, 181.0, 183.0, 188.0, 180.0, 174.0, 160.0], "json-parse-financial": [63.0, 66.0, 67.0, 69.0, 74.0, 71.0, 78.0, 80.0, 70.0, 70.0], "stanford-crypto-sha256-iterative": [79.0, 82.0, 84.0, 84.0, 84.0, 86.0, 85.0, 86.0, 84.0, 85.0], "audio-fft": [89.0, 92.0, 108.0, 104.0, 82.0, 85.0, 85.0, 106.0, 104.0, 81.0], "imaging-darkroom": [148.0, 155.0, 155.0, 154.0, 153.0, 147.0, 154.0, 154.0, 152.0, 147.0], "stanford-crypto-ccm": [150.0, 151.0, 153.0, 156.0, 169.0, 158.0, 162.0, 161.0, 152.0, 159.0], "audio-oscillator": [111.0, 114.0, 159.0, 108.0, 110.0, 106.0, 150.0, 103.0, 109.0, 160.0], "stanford-crypto-aes": [99.0, 104.0, 106.0, 106.0, 104.0, 107.0, 105.0, 104.0, 108.0, 115.0], "imaging-desaturate": [118.0, 125.0, 136.0, 133.0, 129.0, 124.0, 124.0, 123.0, 123.0, 123.0]}, "summary": {"suite": 1803.5, "subtests": {"audio-fft": {"filtered": 93.6, "value": 93.6}, "stanford-crypto-pbkdf2": {"filtered": 177.3, "value": 177.3}, "audio-beat-detection": {"filtered": 174.1, "value": 174.1}, "stanford-crypto-ccm": {"filtered": 157.1, "value": 157.1}, "imaging-darkroom": {"filtered": 151.9, "value": 151.9}, "json-parse-financial": {"filtered": 70.8, "value": 70.8}, "audio-oscillator": {"filtered": 123.0, "value": 123.0}, "ai-astar": {"filtered": 126.8, "value": 126.8}, "audio-dft": {"filtered": 193.2, "value": 193.2}, "stanford-crypto-sha256-iterative": {"filtered": 83.9, "value": 83.9}, "json-stringify-tinderbox": {"filtered": 79.4, "value": 79.4}, "imaging-gaussian-blur": {"filtered": 140.8, "value": 140.8}, "stanford-crypto-aes": {"filtered": 105.8, "value": 105.8}, "imaging-desaturate": {"filtered": 125.8, "value": 125.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0067"}, "testrun": {"date": 1446694703, "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": "20151104175135", "branch": "Mozilla-Inbound", "revision": "91a6134ea200f28f562144a71a254e7a50881081"}}, {"talos_counters": {}, "results": {"DeltaBlue": [240.73182474723157], "Encrypt": [378.64445285876565], "NavierStokes": [6856.164383561644], "Decrypt": [6944.827586206897], "Splay": [912.4886052871468], "Richards": [196.50225977598743], "RegExp": [35719.29824561404], "Earley": [961.5384615384615], "Boyer": [15687.5], "RayTrace": [2500.0]}, "summary": {"suite": 15064.801306977057, "subtests": {"DeltaBlue": {"filtered": 274.6541720000001, "value": 274.6541720000001}, "Encrypt": {"filtered": 702.9840210000001, "value": 702.9840210000001}, "NavierStokes": {"filtered": 216.44755244755225, "value": 216.44755244755225}, "Decrypt": {"filtered": 38.32794935451837, "value": 38.32794935451837}, "Splay": {"filtered": 89.3063206793207, "value": 89.3063206793207}, "RegExp": {"filtered": 25.50400049115914, "value": 25.50400049115914}, "Richards": {"filtered": 179.65187799999995, "value": 179.65187799999995}, "Earley": {"filtered": 693.1215199999998, "value": 693.1215199999998}, "Boyer": {"filtered": 42.48369721115538, "value": 42.48369721115538}, "RayTrace": {"filtered": 295.99559999999997, "value": 295.99559999999997}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0067"}, "testrun": {"date": 1446694703, "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": "20151104175135", "branch": "Mozilla-Inbound", "revision": "91a6134ea200f28f562144a71a254e7a50881081"}}] 19:58:40 INFO - RETURN: dromaeo_css: 5493.52 19:58:40 INFO - RETURN: kraken: 1803.50 19:58:40 INFO - RETURN: v8_7: 15064.80 19:58:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15064.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1803.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5493.52"}}} 19:58:41 INFO - Return code: 0 19:58:41 INFO - # TBPL SUCCESS # 19:58:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:58:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:58:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:58:41 INFO - 2015-11-04 19:58:41.053 screenresolution[1971:11014] starting screenresolution argv=screenresolution get 19:58:41 INFO - 2015-11-04 19:58:41.057 screenresolution[1971:11014] Display 0: 1600x1200x32@60 19:58:41 INFO - 2015-11-04 19:58:41.064 screenresolution[1972:11016] starting screenresolution argv=screenresolution list 19:58:41 INFO - Available Modes on Display 0 19:58:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:58:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:58:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:58:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:58:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:58:41 INFO - Intel HD Graphics 3000: 19:58:41 INFO - Chipset Model: Intel HD Graphics 3000 19:58:41 INFO - Type: GPU 19:58:41 INFO - Bus: Built-In 19:58:41 INFO - VRAM (Total): 512 MB 19:58:41 INFO - VRAM (Dynamic, Max): 10 19:58:41 INFO - Vendor: Intel (0x8086) 19:58:41 INFO - Device ID: 0x0116 19:58:41 INFO - Revision ID: 0x0009 19:58:41 INFO - Displays: 19:58:41 INFO - Display: 19:58:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:58:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:58:41 INFO - Display Serial Number: 1600x1200 60 19:58:41 INFO - Main Display: Yes 19:58:41 INFO - Mirror: Off 19:58:41 INFO - Online: Yes 19:58:41 INFO - Rotation: Supported 19:58:41 INFO - Return code: 0 19:58:41 INFO - Running post-action listener: _resource_record_post_action 19:58:41 INFO - Running post-run listener: _resource_record_post_run 19:58:42 INFO - Total resource usage - Wall time: 1261s; CPU: 30.0%; Read bytes: 37381120; Write bytes: 687517696; Read time: 3982; Write time: 59768 19:58:42 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 338717184; Write bytes: 334899200; Read time: 37046; Write time: 5104 19:58:42 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 36520960; Write bytes: 341403648; Read time: 3918; Write time: 54120 19:58:42 INFO - Running post-run listener: _upload_blobber_files 19:58:42 INFO - Blob upload gear active. 19:58:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:58:42 INFO - Copying logs to upload dir... 19:58:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.651866 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-04 19:58:42.505440) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 19:58:42.508978) ========= 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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/uP9ODpWpQf2eTwbsFbQhTg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 19:58:42.536067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:58:42.536377) ========= 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.Uuf32IpZKk/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.Tx44syJ9zF/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.005537 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 19:58:42.585554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 19:58:42.585930) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 19:58:42.586279) ========= ========= Total master_lag: 0.22 =========